{"level":"warn","ts":"2026-05-19T01:59:51.38126Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-19T01:59:51.381345Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.3: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.3:2380","--initial-cluster=instance=https://199.204.45.3:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.3:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.3:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-19T01:59:51.381423Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-19T01:59:51.381439Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.3:2380"]} {"level":"info","ts":"2026-05-19T01:59:51.381457Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-19T01:59:51.38221Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"]} {"level":"info","ts":"2026-05-19T01:59:51.382297Z","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.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.3:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-19T01:59:51.387356Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.832944ms"} {"level":"info","ts":"2026-05-19T01:59:51.400631Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"597401b06ce1cf3d","cluster-id":"dfc54657ad8a2432"} {"level":"info","ts":"2026-05-19T01:59:51.401521Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=()"} {"level":"info","ts":"2026-05-19T01:59:51.401551Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 0"} {"level":"info","ts":"2026-05-19T01:59:51.401568Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 597401b06ce1cf3d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-19T01:59:51.401606Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 1"} {"level":"info","ts":"2026-05-19T01:59:51.401705Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"} {"level":"warn","ts":"2026-05-19T01:59:51.413104Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-19T01:59:51.414577Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-19T01:59:51.415789Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-19T01:59:51.418586Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"597401b06ce1cf3d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-19T01:59:51.4196Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"597401b06ce1cf3d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-19T01:59:51.4197Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-19T01:59:51.420046Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-19T01:59:51.42007Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-19T01:59:51.419879Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"} {"level":"info","ts":"2026-05-19T01:59:51.422277Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","added-peer-id":"597401b06ce1cf3d","added-peer-peer-urls":["https://199.204.45.3:2380"]} {"level":"info","ts":"2026-05-19T01:59:51.423613Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-19T01:59:51.4238Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"597401b06ce1cf3d","initial-advertise-peer-urls":["https://199.204.45.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-19T01:59:51.423773Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.3:2380"} {"level":"info","ts":"2026-05-19T01:59:51.423852Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-19T01:59:51.423899Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.3:2380"} {"level":"info","ts":"2026-05-19T01:59:51.909662Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d is starting a new election at term 1"} {"level":"info","ts":"2026-05-19T01:59:51.909769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became pre-candidate at term 1"} {"level":"info","ts":"2026-05-19T01:59:51.909802Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgPreVoteResp from 597401b06ce1cf3d at term 1"} {"level":"info","ts":"2026-05-19T01:59:51.909824Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became candidate at term 2"} {"level":"info","ts":"2026-05-19T01:59:51.909839Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgVoteResp from 597401b06ce1cf3d at term 2"} {"level":"info","ts":"2026-05-19T01:59:51.909861Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became leader at term 2"} {"level":"info","ts":"2026-05-19T01:59:51.909878Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 597401b06ce1cf3d elected leader 597401b06ce1cf3d at term 2"} {"level":"info","ts":"2026-05-19T01:59:52.119771Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T01:59:52.312446Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"597401b06ce1cf3d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.3:2379]}","request-path":"/0/members/597401b06ce1cf3d/attributes","cluster-id":"dfc54657ad8a2432","publish-timeout":"7s"} {"level":"info","ts":"2026-05-19T01:59:52.312459Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T01:59:52.312506Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T01:59:52.313253Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-19T01:59:52.313312Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-19T01:59:52.315968Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.3:2379"} {"level":"info","ts":"2026-05-19T01:59:52.316656Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-19T01:59:52.463505Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T01:59:52.463675Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T01:59:52.463719Z","caller":"traceutil/trace.go:171","msg":"trace[712226946] linearizableReadLoop","detail":"{readStateIndex:4; appliedIndex:3; }","duration":"108.249901ms","start":"2026-05-19T01:59:52.355456Z","end":"2026-05-19T01:59:52.463706Z","steps":["trace[712226946] 'read index received' (duration: 107.995067ms)","trace[712226946] 'applied index is now lower than readState.Index' (duration: 253.924µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T01:59:52.463753Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-05-19T01:59:52.463885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.377793ms","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:4"} {"level":"warn","ts":"2026-05-19T01:59:52.463898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.328442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T01:59:52.463942Z","caller":"traceutil/trace.go:171","msg":"trace[1971170817] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"108.482984ms","start":"2026-05-19T01:59:52.355452Z","end":"2026-05-19T01:59:52.463935Z","steps":["trace[1971170817] 'agreement among raft nodes before linearized reading' (duration: 108.312092ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T01:59:52.463957Z","caller":"traceutil/trace.go:171","msg":"trace[1874811419] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"108.421993ms","start":"2026-05-19T01:59:52.355518Z","end":"2026-05-19T01:59:52.46394Z","steps":["trace[1874811419] 'agreement among raft nodes before linearized reading' (duration: 108.307452ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:00:03.709272Z","caller":"traceutil/trace.go:171","msg":"trace[1933530532] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"103.06979ms","start":"2026-05-19T02:00:03.606173Z","end":"2026-05-19T02:00:03.709243Z","steps":["trace[1933530532] 'process raft request' (duration: 98.820457ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:00:23.873019Z","caller":"traceutil/trace.go:171","msg":"trace[822207987] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"159.893894ms","start":"2026-05-19T02:00:23.713096Z","end":"2026-05-19T02:00:23.87299Z","steps":["trace[822207987] 'process raft request' (duration: 151.987431ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:00:23.87313Z","caller":"traceutil/trace.go:171","msg":"trace[679354285] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"133.373819ms","start":"2026-05-19T02:00:23.739735Z","end":"2026-05-19T02:00:23.873109Z","steps":["trace[679354285] 'process raft request' (duration: 133.188347ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:00:23.873427Z","caller":"traceutil/trace.go:171","msg":"trace[266917257] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"122.372268ms","start":"2026-05-19T02:00:23.751039Z","end":"2026-05-19T02:00:23.873411Z","steps":["trace[266917257] 'process raft request' (duration: 121.934764ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:00:24.091538Z","caller":"traceutil/trace.go:171","msg":"trace[1625789038] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"135.077624ms","start":"2026-05-19T02:00:23.956444Z","end":"2026-05-19T02:00:24.091522Z","steps":["trace[1625789038] 'process raft request' (duration: 127.159923ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:24.091619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.898254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-19T02:00:24.091532Z","caller":"traceutil/trace.go:171","msg":"trace[1147407684] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:634; }","duration":"133.810333ms","start":"2026-05-19T02:00:23.957701Z","end":"2026-05-19T02:00:24.091511Z","steps":["trace[1147407684] 'read index received' (duration: 125.919442ms)","trace[1147407684] 'applied index is now lower than readState.Index' (duration: 7.890091ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:00:24.091658Z","caller":"traceutil/trace.go:171","msg":"trace[1391441261] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:612; }","duration":"133.969035ms","start":"2026-05-19T02:00:23.957682Z","end":"2026-05-19T02:00:24.091651Z","steps":["trace[1391441261] 'agreement among raft nodes before linearized reading' (duration: 133.887694ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:25.878643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.661092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"} {"level":"info","ts":"2026-05-19T02:00:25.878698Z","caller":"traceutil/trace.go:171","msg":"trace[1555035691] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:640; }","duration":"193.762813ms","start":"2026-05-19T02:00:25.684924Z","end":"2026-05-19T02:00:25.878687Z","steps":["trace[1555035691] 'range keys from in-memory index tree' (duration: 193.561342ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:29.217947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.652454ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-19T02:00:29.21806Z","caller":"traceutil/trace.go:171","msg":"trace[1432401827] linearizableReadLoop","detail":"{readStateIndex:695; appliedIndex:694; }","duration":"102.429332ms","start":"2026-05-19T02:00:29.115614Z","end":"2026-05-19T02:00:29.218044Z","steps":["trace[1432401827] 'read index received' (duration: 35.301µs)","trace[1432401827] 'applied index is now lower than readState.Index' (duration: 102.392571ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:00:29.218075Z","caller":"traceutil/trace.go:171","msg":"trace[2101945652] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"269.357844ms","start":"2026-05-19T02:00:28.948692Z","end":"2026-05-19T02:00:29.21805Z","steps":["trace[2101945652] 'process raft request' (duration: 123.042294ms)","trace[2101945652] 'compare' (duration: 145.384872ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T02:00:29.218239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.626893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-05-19T02:00:29.218278Z","caller":"traceutil/trace.go:171","msg":"trace[1750470364] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:671; }","duration":"102.707724ms","start":"2026-05-19T02:00:29.115561Z","end":"2026-05-19T02:00:29.218269Z","steps":["trace[1750470364] 'agreement among raft nodes before linearized reading' (duration: 102.529282ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:30.10311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.205812ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-19T02:00:30.103241Z","caller":"traceutil/trace.go:171","msg":"trace[1874730354] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"273.253033ms","start":"2026-05-19T02:00:29.829968Z","end":"2026-05-19T02:00:30.103221Z","steps":["trace[1874730354] 'process raft request' (duration: 85.858829ms)","trace[1874730354] 'compare' (duration: 187.060991ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:00:30.103792Z","caller":"traceutil/trace.go:171","msg":"trace[1747464035] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"271.869211ms","start":"2026-05-19T02:00:29.831894Z","end":"2026-05-19T02:00:30.103763Z","steps":["trace[1747464035] 'process raft request' (duration: 271.67484ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:00:30.103921Z","caller":"traceutil/trace.go:171","msg":"trace[224424602] linearizableReadLoop","detail":"{readStateIndex:703; appliedIndex:701; }","duration":"139.706374ms","start":"2026-05-19T02:00:29.9642Z","end":"2026-05-19T02:00:30.103907Z","steps":["trace[224424602] 'read index received' (duration: 139.3129ms)","trace[224424602] 'applied index is now lower than readState.Index' (duration: 392.374µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:00:30.104007Z","caller":"traceutil/trace.go:171","msg":"trace[1048388666] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"269.538991ms","start":"2026-05-19T02:00:29.834459Z","end":"2026-05-19T02:00:30.103998Z","steps":["trace[1048388666] 'process raft request' (duration: 269.236779ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:30.10418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.976986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-19T02:00:30.104215Z","caller":"traceutil/trace.go:171","msg":"trace[1522447856] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:679; }","duration":"140.054436ms","start":"2026-05-19T02:00:29.964151Z","end":"2026-05-19T02:00:30.104205Z","steps":["trace[1522447856] 'agreement among raft nodes before linearized reading' (duration: 139.930465ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:30.104401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.452615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-19T02:00:30.104446Z","caller":"traceutil/trace.go:171","msg":"trace[971765168] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:679; }","duration":"122.568516ms","start":"2026-05-19T02:00:29.981863Z","end":"2026-05-19T02:00:30.104431Z","steps":["trace[971765168] 'agreement among raft nodes before linearized reading' (duration: 122.408065ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.2723Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265928387522175,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-19T02:00:31.399379Z","caller":"traceutil/trace.go:171","msg":"trace[315800070] linearizableReadLoop","detail":"{readStateIndex:712; appliedIndex:711; }","duration":"628.149705ms","start":"2026-05-19T02:00:30.77121Z","end":"2026-05-19T02:00:31.39936Z","steps":["trace[315800070] 'read index received' (duration: 627.961214ms)","trace[315800070] 'applied index is now lower than readState.Index' (duration: 187.711µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:00:31.399515Z","caller":"traceutil/trace.go:171","msg":"trace[1329235204] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"641.908322ms","start":"2026-05-19T02:00:30.757592Z","end":"2026-05-19T02:00:31.3995Z","steps":["trace[1329235204] 'process raft request' (duration: 641.63999ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.399827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:30.757559Z","time spent":"641.990163ms","remote":"127.0.0.1:38510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17126,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T02:00:31.399925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.047309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T02:00:31.400025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.100157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T02:00:31.400063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.922026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T02:00:31.400083Z","caller":"traceutil/trace.go:171","msg":"trace[1620151744] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:687; }","duration":"135.24051ms","start":"2026-05-19T02:00:31.264824Z","end":"2026-05-19T02:00:31.400065Z","steps":["trace[1620151744] 'agreement among raft nodes before linearized reading' (duration: 135.028838ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.400177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.877672ms","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":"info","ts":"2026-05-19T02:00:31.400218Z","caller":"traceutil/trace.go:171","msg":"trace[311615088] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:687; }","duration":"341.934712ms","start":"2026-05-19T02:00:31.058273Z","end":"2026-05-19T02:00:31.400207Z","steps":["trace[311615088] 'agreement among raft nodes before linearized reading' (duration: 341.877972ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.400223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"629.001742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T02:00:31.400262Z","caller":"traceutil/trace.go:171","msg":"trace[1409407901] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:687; }","duration":"629.059583ms","start":"2026-05-19T02:00:30.771191Z","end":"2026-05-19T02:00:31.400251Z","steps":["trace[1409407901] 'agreement among raft nodes before linearized reading' (duration: 629.000482ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.400182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.361951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T02:00:31.40029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.973418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"warn","ts":"2026-05-19T02:00:31.400302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:30.771176Z","time spent":"629.117283ms","remote":"127.0.0.1:39944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"info","ts":"2026-05-19T02:00:31.400318Z","caller":"traceutil/trace.go:171","msg":"trace[1075051571] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:687; }","duration":"160.020609ms","start":"2026-05-19T02:00:31.240288Z","end":"2026-05-19T02:00:31.400309Z","steps":["trace[1075051571] 'agreement among raft nodes before linearized reading' (duration: 159.912828ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.400348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.090193ms","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":"info","ts":"2026-05-19T02:00:31.40038Z","caller":"traceutil/trace.go:171","msg":"trace[1878210532] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:687; }","duration":"342.143735ms","start":"2026-05-19T02:00:31.058229Z","end":"2026-05-19T02:00:31.400372Z","steps":["trace[1878210532] 'agreement among raft nodes before linearized reading' (duration: 342.098794ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.400413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:31.058215Z","time spent":"342.190355ms","remote":"127.0.0.1:39990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-19T02:00:31.400528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.914776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T02:00:31.400569Z","caller":"traceutil/trace.go:171","msg":"trace[647240968] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:687; }","duration":"192.977356ms","start":"2026-05-19T02:00:31.207583Z","end":"2026-05-19T02:00:31.40056Z","steps":["trace[647240968] 'agreement among raft nodes before linearized reading' (duration: 192.920646ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.400266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:31.058266Z","time spent":"341.988753ms","remote":"127.0.0.1:39990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-19T02:00:31.400665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.092746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T02:00:31.400304Z","caller":"traceutil/trace.go:171","msg":"trace[2072048016] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:687; }","duration":"135.508382ms","start":"2026-05-19T02:00:31.264787Z","end":"2026-05-19T02:00:31.400295Z","steps":["trace[2072048016] 'agreement among raft nodes before linearized reading' (duration: 135.366321ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:00:31.400702Z","caller":"traceutil/trace.go:171","msg":"trace[165852455] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:687; }","duration":"372.140827ms","start":"2026-05-19T02:00:31.028552Z","end":"2026-05-19T02:00:31.400693Z","steps":["trace[165852455] 'agreement among raft nodes before linearized reading' (duration: 372.088107ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.40073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:31.028545Z","time spent":"372.178298ms","remote":"127.0.0.1:39974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 "} {"level":"info","ts":"2026-05-19T02:00:31.400129Z","caller":"traceutil/trace.go:171","msg":"trace[1563537514] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:687; }","duration":"193.013857ms","start":"2026-05-19T02:00:31.207094Z","end":"2026-05-19T02:00:31.400108Z","steps":["trace[1563537514] 'agreement among raft nodes before linearized reading' (duration: 192.858106ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.401047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.410949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T02:00:31.401086Z","caller":"traceutil/trace.go:171","msg":"trace[1707681720] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:687; }","duration":"505.46488ms","start":"2026-05-19T02:00:30.895612Z","end":"2026-05-19T02:00:31.401077Z","steps":["trace[1707681720] 'agreement among raft nodes before linearized reading' (duration: 505.409049ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.401115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:30.895604Z","time spent":"505.50379ms","remote":"127.0.0.1:39944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 "} {"level":"warn","ts":"2026-05-19T02:00:31.401265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.382028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T02:00:31.400123Z","caller":"traceutil/trace.go:171","msg":"trace[491317797] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:687; }","duration":"372.214657ms","start":"2026-05-19T02:00:31.027883Z","end":"2026-05-19T02:00:31.400098Z","steps":["trace[491317797] 'agreement among raft nodes before linearized reading' (duration: 372.083156ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:00:31.401344Z","caller":"traceutil/trace.go:171","msg":"trace[2013560350] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:687; }","duration":"373.491679ms","start":"2026-05-19T02:00:31.027819Z","end":"2026-05-19T02:00:31.40131Z","steps":["trace[2013560350] 'agreement among raft nodes before linearized reading' (duration: 373.384488ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.401362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.68541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T02:00:31.401364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:31.027865Z","time spent":"373.482228ms","remote":"127.0.0.1:39974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"info","ts":"2026-05-19T02:00:31.401396Z","caller":"traceutil/trace.go:171","msg":"trace[754768189] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:687; }","duration":"506.7211ms","start":"2026-05-19T02:00:30.894666Z","end":"2026-05-19T02:00:31.401387Z","steps":["trace[754768189] 'agreement among raft nodes before linearized reading' (duration: 506.66737ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.401395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:31.027804Z","time spent":"373.582009ms","remote":"127.0.0.1:39974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-19T02:00:31.401434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:30.894628Z","time spent":"506.798532ms","remote":"127.0.0.1:39960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-19T02:00:31.401558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.855529ms","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-05-19T02:00:31.401599Z","caller":"traceutil/trace.go:171","msg":"trace[958591423] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:687; }","duration":"107.92472ms","start":"2026-05-19T02:00:31.293664Z","end":"2026-05-19T02:00:31.401589Z","steps":["trace[958591423] 'agreement among raft nodes before linearized reading' (duration: 107.87019ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.401692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.624611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T02:00:31.40172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.096741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T02:00:31.401748Z","caller":"traceutil/trace.go:171","msg":"trace[1056614895] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:687; }","duration":"108.140471ms","start":"2026-05-19T02:00:31.293599Z","end":"2026-05-19T02:00:31.40174Z","steps":["trace[1056614895] 'agreement among raft nodes before linearized reading' (duration: 108.095021ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.401765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.136905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T02:00:31.401799Z","caller":"traceutil/trace.go:171","msg":"trace[1098160714] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:687; }","duration":"220.250647ms","start":"2026-05-19T02:00:31.181537Z","end":"2026-05-19T02:00:31.401787Z","steps":["trace[1098160714] 'agreement among raft nodes before linearized reading' (duration: 220.202516ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.401785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.692982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T02:00:31.401839Z","caller":"traceutil/trace.go:171","msg":"trace[943510212] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:687; }","duration":"194.775172ms","start":"2026-05-19T02:00:31.207057Z","end":"2026-05-19T02:00:31.401832Z","steps":["trace[943510212] 'agreement among raft nodes before linearized reading' (duration: 194.710291ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.401872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.51771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T02:00:31.401902Z","caller":"traceutil/trace.go:171","msg":"trace[175665392] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:687; }","duration":"136.575692ms","start":"2026-05-19T02:00:31.265318Z","end":"2026-05-19T02:00:31.401894Z","steps":["trace[175665392] 'agreement among raft nodes before linearized reading' (duration: 136.531001ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:00:31.401723Z","caller":"traceutil/trace.go:171","msg":"trace[557561834] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:687; }","duration":"219.694022ms","start":"2026-05-19T02:00:31.18202Z","end":"2026-05-19T02:00:31.401714Z","steps":["trace[557561834] 'agreement among raft nodes before linearized reading' (duration: 219.649492ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.402104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"628.616669ms","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-05-19T02:00:31.402146Z","caller":"traceutil/trace.go:171","msg":"trace[503910928] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:687; }","duration":"630.873099ms","start":"2026-05-19T02:00:30.771263Z","end":"2026-05-19T02:00:31.402136Z","steps":["trace[503910928] 'agreement among raft nodes before linearized reading' (duration: 628.589929ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.402189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:30.771235Z","time spent":"630.938089ms","remote":"127.0.0.1:39944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-19T02:00:31.402317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.645799ms","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-05-19T02:00:31.40239Z","caller":"traceutil/trace.go:171","msg":"trace[1286679437] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:687; }","duration":"507.73642ms","start":"2026-05-19T02:00:30.894643Z","end":"2026-05-19T02:00:31.40238Z","steps":["trace[1286679437] 'agreement among raft nodes before linearized reading' (duration: 507.648429ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.402433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:30.894627Z","time spent":"507.79304ms","remote":"127.0.0.1:39960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-19T02:00:31.402892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.397346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T02:00:31.402933Z","caller":"traceutil/trace.go:171","msg":"trace[2022161929] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:687; }","duration":"221.482677ms","start":"2026-05-19T02:00:31.18144Z","end":"2026-05-19T02:00:31.402922Z","steps":["trace[2022161929] 'agreement among raft nodes before linearized reading' (duration: 221.425667ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.405253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.33328ms","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-05-19T02:00:31.405371Z","caller":"traceutil/trace.go:171","msg":"trace[1173785747] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:687; }","duration":"346.455401ms","start":"2026-05-19T02:00:31.058905Z","end":"2026-05-19T02:00:31.405361Z","steps":["trace[1173785747] 'agreement among raft nodes before linearized reading' (duration: 346.31868ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.405396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:31.058896Z","time spent":"346.492081ms","remote":"127.0.0.1:39990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 "} {"level":"info","ts":"2026-05-19T02:00:31.627869Z","caller":"traceutil/trace.go:171","msg":"trace[1819074622] linearizableReadLoop","detail":"{readStateIndex:713; appliedIndex:712; }","duration":"212.566462ms","start":"2026-05-19T02:00:31.415286Z","end":"2026-05-19T02:00:31.627852Z","steps":["trace[1819074622] 'read index received' (duration: 114.779628ms)","trace[1819074622] 'applied index is now lower than readState.Index' (duration: 97.786134ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:00:31.627957Z","caller":"traceutil/trace.go:171","msg":"trace[285094894] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"221.039693ms","start":"2026-05-19T02:00:31.406909Z","end":"2026-05-19T02:00:31.627949Z","steps":["trace[285094894] 'process raft request' (duration: 123.203928ms)","trace[285094894] 'compare' (duration: 97.655174ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T02:00:31.62807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.762374ms","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-05-19T02:00:31.628118Z","caller":"traceutil/trace.go:171","msg":"trace[2082319847] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:688; }","duration":"212.837125ms","start":"2026-05-19T02:00:31.415271Z","end":"2026-05-19T02:00:31.628108Z","steps":["trace[2082319847] 'agreement among raft nodes before linearized reading' (duration: 212.763004ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.628357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.825331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T02:00:31.628382Z","caller":"traceutil/trace.go:171","msg":"trace[1856664951] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:688; }","duration":"125.873541ms","start":"2026-05-19T02:00:31.502503Z","end":"2026-05-19T02:00:31.628376Z","steps":["trace[1856664951] 'agreement among raft nodes before linearized reading' (duration: 125.838021ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.628398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.090177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T02:00:31.628437Z","caller":"traceutil/trace.go:171","msg":"trace[970731150] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:688; }","duration":"213.155207ms","start":"2026-05-19T02:00:31.41527Z","end":"2026-05-19T02:00:31.628426Z","steps":["trace[970731150] 'agreement among raft nodes before linearized reading' (duration: 213.082697ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.628474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.987712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T02:00:31.628499Z","caller":"traceutil/trace.go:171","msg":"trace[583057056] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:688; }","duration":"126.034173ms","start":"2026-05-19T02:00:31.50246Z","end":"2026-05-19T02:00:31.628494Z","steps":["trace[583057056] 'agreement among raft nodes before linearized reading' (duration: 125.998433ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.62859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.824898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T02:00:31.628613Z","caller":"traceutil/trace.go:171","msg":"trace[1509589069] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:688; }","duration":"165.885549ms","start":"2026-05-19T02:00:31.462722Z","end":"2026-05-19T02:00:31.628607Z","steps":["trace[1509589069] 'agreement among raft nodes before linearized reading' (duration: 165.852629ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.628706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.697336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T02:00:31.628727Z","caller":"traceutil/trace.go:171","msg":"trace[1366309549] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:688; }","duration":"166.762486ms","start":"2026-05-19T02:00:31.46196Z","end":"2026-05-19T02:00:31.628722Z","steps":["trace[1366309549] 'agreement among raft nodes before linearized reading' (duration: 166.726675ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.628802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.838166ms","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":"info","ts":"2026-05-19T02:00:31.628824Z","caller":"traceutil/trace.go:171","msg":"trace[978806856] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:688; }","duration":"166.875817ms","start":"2026-05-19T02:00:31.461943Z","end":"2026-05-19T02:00:31.628819Z","steps":["trace[978806856] 'agreement among raft nodes before linearized reading' (duration: 166.843546ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.628899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.923591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T02:00:31.62892Z","caller":"traceutil/trace.go:171","msg":"trace[248958357] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:688; }","duration":"189.964881ms","start":"2026-05-19T02:00:31.438951Z","end":"2026-05-19T02:00:31.628915Z","steps":["trace[248958357] 'agreement among raft nodes before linearized reading' (duration: 189.933461ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.629004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.048891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T02:00:31.629027Z","caller":"traceutil/trace.go:171","msg":"trace[252369187] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:688; }","duration":"191.082461ms","start":"2026-05-19T02:00:31.43794Z","end":"2026-05-19T02:00:31.629022Z","steps":["trace[252369187] 'agreement among raft nodes before linearized reading' (duration: 191.050921ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.629116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.262782ms","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-05-19T02:00:31.629137Z","caller":"traceutil/trace.go:171","msg":"trace[1682235272] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:688; }","duration":"191.299642ms","start":"2026-05-19T02:00:31.437832Z","end":"2026-05-19T02:00:31.629132Z","steps":["trace[1682235272] 'agreement among raft nodes before linearized reading' (duration: 191.266982ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.888447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.204519ms","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-05-19T02:00:31.888515Z","caller":"traceutil/trace.go:171","msg":"trace[1169193031] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:688; }","duration":"148.30565ms","start":"2026-05-19T02:00:31.740193Z","end":"2026-05-19T02:00:31.888498Z","steps":["trace[1169193031] 'range keys from in-memory index tree' (duration: 148.137219ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.888684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.23773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T02:00:31.888739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.191509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T02:00:31.888786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.560462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T02:00:31.888798Z","caller":"traceutil/trace.go:171","msg":"trace[1902609969] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:688; }","duration":"129.2517ms","start":"2026-05-19T02:00:31.759528Z","end":"2026-05-19T02:00:31.888779Z","steps":["trace[1902609969] 'range keys from in-memory index tree' (duration: 129.166039ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:00:31.888821Z","caller":"traceutil/trace.go:171","msg":"trace[2046146327] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:688; }","duration":"148.606122ms","start":"2026-05-19T02:00:31.740206Z","end":"2026-05-19T02:00:31.888812Z","steps":["trace[2046146327] 'count revisions from in-memory index tree' (duration: 148.482442ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.888929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.061333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T02:00:31.888958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.954682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T02:00:31.889005Z","caller":"traceutil/trace.go:171","msg":"trace[533494350] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:688; }","duration":"113.180334ms","start":"2026-05-19T02:00:31.775808Z","end":"2026-05-19T02:00:31.888988Z","steps":["trace[533494350] 'range keys from in-memory index tree' (duration: 112.945833ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.889029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.635825ms","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-05-19T02:00:31.889062Z","caller":"traceutil/trace.go:171","msg":"trace[1301177495] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:688; }","duration":"128.670285ms","start":"2026-05-19T02:00:31.760382Z","end":"2026-05-19T02:00:31.889052Z","steps":["trace[1301177495] 'range keys from in-memory index tree' (duration: 128.575084ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:00:31.889061Z","caller":"traceutil/trace.go:171","msg":"trace[84084934] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:688; }","duration":"113.112724ms","start":"2026-05-19T02:00:31.775904Z","end":"2026-05-19T02:00:31.889017Z","steps":["trace[84084934] 'count revisions from in-memory index tree' (duration: 112.914632ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:00:31.888743Z","caller":"traceutil/trace.go:171","msg":"trace[1408998194] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:688; }","duration":"129.31386ms","start":"2026-05-19T02:00:31.759413Z","end":"2026-05-19T02:00:31.888727Z","steps":["trace[1408998194] 'count revisions from in-memory index tree' (duration: 129.141339ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:31.888673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.7666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T02:00:31.889256Z","caller":"traceutil/trace.go:171","msg":"trace[358322670] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:688; }","duration":"113.388886ms","start":"2026-05-19T02:00:31.775858Z","end":"2026-05-19T02:00:31.889247Z","steps":["trace[358322670] 'range keys from in-memory index tree' (duration: 112.73682ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:00:32.48239Z","caller":"traceutil/trace.go:171","msg":"trace[1283032704] linearizableReadLoop","detail":"{readStateIndex:714; appliedIndex:713; }","duration":"281.203906ms","start":"2026-05-19T02:00:32.201172Z","end":"2026-05-19T02:00:32.482376Z","steps":["trace[1283032704] 'read index received' (duration: 281.017195ms)","trace[1283032704] 'applied index is now lower than readState.Index' (duration: 185.991µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:00:32.482461Z","caller":"traceutil/trace.go:171","msg":"trace[541335231] transaction","detail":"{read_only:false; response_revision:689; number_of_response:1; }","duration":"284.117911ms","start":"2026-05-19T02:00:32.198338Z","end":"2026-05-19T02:00:32.482456Z","steps":["trace[541335231] 'process raft request' (duration: 283.93163ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:32.482652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.465399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-19T02:00:32.482673Z","caller":"traceutil/trace.go:171","msg":"trace[1336649992] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:689; }","duration":"281.517609ms","start":"2026-05-19T02:00:32.201151Z","end":"2026-05-19T02:00:32.482668Z","steps":["trace[1336649992] 'agreement among raft nodes before linearized reading' (duration: 281.435178ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:32.482743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.625877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-19T02:00:32.482766Z","caller":"traceutil/trace.go:171","msg":"trace[1562611108] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:689; }","duration":"228.672409ms","start":"2026-05-19T02:00:32.25409Z","end":"2026-05-19T02:00:32.482762Z","steps":["trace[1562611108] 'agreement among raft nodes before linearized reading' (duration: 228.625608ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:32.482829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.412955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-19T02:00:32.482845Z","caller":"traceutil/trace.go:171","msg":"trace[528473478] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:689; }","duration":"138.473335ms","start":"2026-05-19T02:00:32.344368Z","end":"2026-05-19T02:00:32.482842Z","steps":["trace[528473478] 'agreement among raft nodes before linearized reading' (duration: 138.436095ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:32.830162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.349601ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T02:00:32.830277Z","caller":"traceutil/trace.go:171","msg":"trace[218225691] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"344.528615ms","start":"2026-05-19T02:00:32.485729Z","end":"2026-05-19T02:00:32.830258Z","steps":["trace[218225691] 'process raft request' (duration: 53.001953ms)","trace[218225691] 'compare' (duration: 291.23733ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T02:00:32.830342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:32.485716Z","time spent":"344.595876ms","remote":"127.0.0.1:38596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T02:00:33.073979Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265928387522214,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-19T02:00:33.393009Z","caller":"traceutil/trace.go:171","msg":"trace[349999466] linearizableReadLoop","detail":"{readStateIndex:717; appliedIndex:715; }","duration":"819.859859ms","start":"2026-05-19T02:00:32.573126Z","end":"2026-05-19T02:00:33.392986Z","steps":["trace[349999466] 'read index received' (duration: 783.223617ms)","trace[349999466] 'applied index is now lower than readState.Index' (duration: 36.635322ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:00:33.393062Z","caller":"traceutil/trace.go:171","msg":"trace[871680207] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"906.13565ms","start":"2026-05-19T02:00:32.486889Z","end":"2026-05-19T02:00:33.393025Z","steps":["trace[871680207] 'process raft request' (duration: 869.550737ms)","trace[871680207] 'compare' (duration: 35.984008ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T02:00:33.393124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"819.9825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T02:00:33.393164Z","caller":"traceutil/trace.go:171","msg":"trace[360504025] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:692; }","duration":"820.069082ms","start":"2026-05-19T02:00:32.573085Z","end":"2026-05-19T02:00:33.393154Z","steps":["trace[360504025] 'agreement among raft nodes before linearized reading' (duration: 819.990191ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:33.393203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:32.573065Z","time spent":"820.130242ms","remote":"127.0.0.1:38262","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-05-19T02:00:33.393237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:32.486864Z","time spent":"906.291231ms","remote":"127.0.0.1:38596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T02:00:33.393302Z","caller":"traceutil/trace.go:171","msg":"trace[1227730385] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"906.289121ms","start":"2026-05-19T02:00:32.486973Z","end":"2026-05-19T02:00:33.393262Z","steps":["trace[1227730385] 'process raft request' (duration: 905.927298ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:33.393512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:32.486966Z","time spent":"906.435132ms","remote":"127.0.0.1:38596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T02:00:34.06247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.087886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-05-19T02:00:34.062553Z","caller":"traceutil/trace.go:171","msg":"trace[821168051] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:692; }","duration":"431.192247ms","start":"2026-05-19T02:00:33.631344Z","end":"2026-05-19T02:00:34.062537Z","steps":["trace[821168051] 'range keys from in-memory index tree' (duration: 430.825154ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:34.062597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:33.631273Z","time spent":"431.315318ms","remote":"127.0.0.1:38596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-19T02:00:34.20337Z","caller":"traceutil/trace.go:171","msg":"trace[2039789528] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"136.607368ms","start":"2026-05-19T02:00:34.066741Z","end":"2026-05-19T02:00:34.203348Z","steps":["trace[2039789528] 'process raft request' (duration: 136.468577ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:00:34.515138Z","caller":"traceutil/trace.go:171","msg":"trace[1790042625] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"120.138183ms","start":"2026-05-19T02:00:34.39496Z","end":"2026-05-19T02:00:34.51508Z","steps":["trace[1790042625] 'process raft request' (duration: 77.572164ms)","trace[1790042625] 'compare' (duration: 42.304707ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T02:00:35.640503Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265928387522227,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T02:00:36.140922Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265928387522227,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T02:00:36.222395Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.383955725s","expected-duration":"1s"} {"level":"info","ts":"2026-05-19T02:00:36.222764Z","caller":"traceutil/trace.go:171","msg":"trace[1520021988] linearizableReadLoop","detail":"{readStateIndex:721; appliedIndex:720; }","duration":"1.083156954s","start":"2026-05-19T02:00:35.139586Z","end":"2026-05-19T02:00:36.222742Z","steps":["trace[1520021988] 'read index received' (duration: 1.082954852s)","trace[1520021988] 'applied index is now lower than readState.Index' (duration: 201.212µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:00:36.222824Z","caller":"traceutil/trace.go:171","msg":"trace[414724802] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"1.384436969s","start":"2026-05-19T02:00:34.838361Z","end":"2026-05-19T02:00:36.222798Z","steps":["trace[414724802] 'process raft request' (duration: 1.384226307s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:36.222971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.083368036s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.3\" ","response":"range_response_count:1 size:131"} {"level":"info","ts":"2026-05-19T02:00:36.223006Z","caller":"traceutil/trace.go:171","msg":"trace[937772371] range","detail":"{range_begin:/registry/masterleases/199.204.45.3; range_end:; response_count:1; response_revision:696; }","duration":"1.083459046s","start":"2026-05-19T02:00:35.139537Z","end":"2026-05-19T02:00:36.222996Z","steps":["trace[937772371] 'agreement among raft nodes before linearized reading' (duration: 1.083305975s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:36.223042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:35.139519Z","time spent":"1.083515376s","remote":"127.0.0.1:38296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":154,"request content":"key:\"/registry/masterleases/199.204.45.3\" "} {"level":"warn","ts":"2026-05-19T02:00:36.223042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:34.838312Z","time spent":"1.384622661s","remote":"127.0.0.1:38596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T02:00:36.223043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"825.279713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-19T02:00:36.22311Z","caller":"traceutil/trace.go:171","msg":"trace[1616588176] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:696; }","duration":"825.396724ms","start":"2026-05-19T02:00:35.397695Z","end":"2026-05-19T02:00:36.223092Z","steps":["trace[1616588176] 'agreement among raft nodes before linearized reading' (duration: 825.237333ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:36.223151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:35.39767Z","time spent":"825.472655ms","remote":"127.0.0.1:38596","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":"warn","ts":"2026-05-19T02:00:36.223291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"824.81657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-05-19T02:00:36.223156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"648.968674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T02:00:36.223325Z","caller":"traceutil/trace.go:171","msg":"trace[351873064] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:696; }","duration":"824.87164ms","start":"2026-05-19T02:00:35.398445Z","end":"2026-05-19T02:00:36.223317Z","steps":["trace[351873064] 'agreement among raft nodes before linearized reading' (duration: 824.791709ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:36.223355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:35.398433Z","time spent":"824.91645ms","remote":"127.0.0.1:38596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-19T02:00:36.223378Z","caller":"traceutil/trace.go:171","msg":"trace[490277872] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:696; }","duration":"649.244996ms","start":"2026-05-19T02:00:35.574114Z","end":"2026-05-19T02:00:36.223346Z","steps":["trace[490277872] 'agreement among raft nodes before linearized reading' (duration: 648.896123ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:36.223427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:35.57409Z","time spent":"649.325708ms","remote":"127.0.0.1:38262","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-05-19T02:00:36.72597Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265928387522230,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T02:00:37.128878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:36.22383Z","time spent":"905.042329ms","remote":"127.0.0.1:38296","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-05-19T02:00:37.278879Z","caller":"traceutil/trace.go:171","msg":"trace[1012828937] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"1.051676317s","start":"2026-05-19T02:00:36.227182Z","end":"2026-05-19T02:00:37.278858Z","steps":["trace[1012828937] 'process raft request' (duration: 1.049095266s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:37.279028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:36.227156Z","time spent":"1.051797428s","remote":"127.0.0.1:38596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T02:00:37.279208Z","caller":"traceutil/trace.go:171","msg":"trace[1797171941] linearizableReadLoop","detail":"{readStateIndex:725; appliedIndex:721; }","duration":"1.053824194s","start":"2026-05-19T02:00:36.22536Z","end":"2026-05-19T02:00:37.279184Z","steps":["trace[1797171941] 'read index received' (duration: 816.482405ms)","trace[1797171941] 'applied index is now lower than readState.Index' (duration: 237.340679ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:00:37.279337Z","caller":"traceutil/trace.go:171","msg":"trace[83188908] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"1.051338604s","start":"2026-05-19T02:00:36.227985Z","end":"2026-05-19T02:00:37.279323Z","steps":["trace[83188908] 'process raft request' (duration: 1.051059352s)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:00:37.279284Z","caller":"traceutil/trace.go:171","msg":"trace[1811459960] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"1.05206793s","start":"2026-05-19T02:00:36.227193Z","end":"2026-05-19T02:00:37.279261Z","steps":["trace[1811459960] 'process raft request' (duration: 1.051625036s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:37.279518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:36.227172Z","time spent":"1.052254861s","remote":"127.0.0.1:38596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T02:00:37.279521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:36.227975Z","time spent":"1.051406805s","remote":"127.0.0.1:38596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T02:00:37.279563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.054192207s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T02:00:37.279784Z","caller":"traceutil/trace.go:171","msg":"trace[185588695] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:699; }","duration":"1.054439039s","start":"2026-05-19T02:00:36.22533Z","end":"2026-05-19T02:00:37.279769Z","steps":["trace[185588695] 'agreement among raft nodes before linearized reading' (duration: 1.054025896s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:37.279854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:36.225315Z","time spent":"1.054528899s","remote":"127.0.0.1:38246","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-05-19T02:00:37.283281Z","caller":"traceutil/trace.go:171","msg":"trace[2065687805] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"151.714867ms","start":"2026-05-19T02:00:37.13155Z","end":"2026-05-19T02:00:37.283265Z","steps":["trace[2065687805] 'process raft request' (duration: 151.585056ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:37.28338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"724.429748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-19T02:00:37.283436Z","caller":"traceutil/trace.go:171","msg":"trace[1568107883] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:700; }","duration":"724.527589ms","start":"2026-05-19T02:00:36.558899Z","end":"2026-05-19T02:00:37.283427Z","steps":["trace[1568107883] 'agreement among raft nodes before linearized reading' (duration: 724.335417ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:37.283462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:36.558878Z","time spent":"724.57779ms","remote":"127.0.0.1:38596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-19T02:00:53.562548Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265928387522450,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-19T02:00:53.760031Z","caller":"traceutil/trace.go:171","msg":"trace[1301263319] linearizableReadLoop","detail":"{readStateIndex:840; appliedIndex:839; }","duration":"698.419256ms","start":"2026-05-19T02:00:53.061586Z","end":"2026-05-19T02:00:53.760005Z","steps":["trace[1301263319] 'read index received' (duration: 698.131174ms)","trace[1301263319] 'applied index is now lower than readState.Index' (duration: 286.892µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:00:53.760104Z","caller":"traceutil/trace.go:171","msg":"trace[1815777924] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"968.08875ms","start":"2026-05-19T02:00:52.791982Z","end":"2026-05-19T02:00:53.76007Z","steps":["trace[1815777924] 'process raft request' (duration: 967.857289ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:53.760287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:52.791957Z","time spent":"968.223111ms","remote":"127.0.0.1:38510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4023,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T02:00:53.760416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.507825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T02:00:53.760351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"637.514795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-19T02:00:53.760728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.321743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-19T02:00:53.760769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.174384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-19T02:00:53.760833Z","caller":"traceutil/trace.go:171","msg":"trace[121859597] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:810; }","duration":"402.438704ms","start":"2026-05-19T02:00:53.358368Z","end":"2026-05-19T02:00:53.760806Z","steps":["trace[121859597] 'agreement among raft nodes before linearized reading' (duration: 402.172223ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:00:53.760851Z","caller":"traceutil/trace.go:171","msg":"trace[235268671] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:810; }","duration":"415.295325ms","start":"2026-05-19T02:00:53.345544Z","end":"2026-05-19T02:00:53.760839Z","steps":["trace[235268671] 'agreement among raft nodes before linearized reading' (duration: 415.043783ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:53.760904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:53.358354Z","time spent":"402.534755ms","remote":"127.0.0.1:38596","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-05-19T02:00:53.760743Z","caller":"traceutil/trace.go:171","msg":"trace[120861372] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:810; }","duration":"637.958258ms","start":"2026-05-19T02:00:53.122768Z","end":"2026-05-19T02:00:53.760726Z","steps":["trace[120861372] 'agreement among raft nodes before linearized reading' (duration: 637.513355ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:53.761135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:53.122745Z","time spent":"638.346991ms","remote":"127.0.0.1:38380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":9,"response size":30,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"warn","ts":"2026-05-19T02:00:53.761297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:53.345523Z","time spent":"415.755208ms","remote":"127.0.0.1:38596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-19T02:00:53.760548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.854779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-05-19T02:00:53.760611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.052471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T02:00:53.761447Z","caller":"traceutil/trace.go:171","msg":"trace[1753276175] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:810; }","duration":"392.804756ms","start":"2026-05-19T02:00:53.368624Z","end":"2026-05-19T02:00:53.761429Z","steps":["trace[1753276175] 'agreement among raft nodes before linearized reading' (duration: 391.692748ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:53.761572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:53.368551Z","time spent":"393.002158ms","remote":"127.0.0.1:38596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-19T02:00:53.76068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.050772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-19T02:00:53.761624Z","caller":"traceutil/trace.go:171","msg":"trace[1346174244] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:810; }","duration":"399.01506ms","start":"2026-05-19T02:00:53.362595Z","end":"2026-05-19T02:00:53.76161Z","steps":["trace[1346174244] 'agreement among raft nodes before linearized reading' (duration: 398.015873ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:00:53.761552Z","caller":"traceutil/trace.go:171","msg":"trace[509611900] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:810; }","duration":"284.057948ms","start":"2026-05-19T02:00:53.477475Z","end":"2026-05-19T02:00:53.761533Z","steps":["trace[509611900] 'agreement among raft nodes before linearized reading' (duration: 283.01359ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:53.76167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:53.362583Z","time spent":"399.06988ms","remote":"127.0.0.1:38596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-19T02:00:53.760503Z","caller":"traceutil/trace.go:171","msg":"trace[1517137924] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:810; }","duration":"187.621466ms","start":"2026-05-19T02:00:53.572832Z","end":"2026-05-19T02:00:53.760453Z","steps":["trace[1517137924] 'agreement among raft nodes before linearized reading' (duration: 187.510505ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:53.760247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"698.634677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T02:00:53.762631Z","caller":"traceutil/trace.go:171","msg":"trace[887813682] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:810; }","duration":"701.073334ms","start":"2026-05-19T02:00:53.061538Z","end":"2026-05-19T02:00:53.762611Z","steps":["trace[887813682] 'agreement among raft nodes before linearized reading' (duration: 698.613637ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:00:53.762685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:00:53.061517Z","time spent":"701.150075ms","remote":"127.0.0.1:38262","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-05-19T02:01:03.659022Z","caller":"traceutil/trace.go:171","msg":"trace[1397956280] transaction","detail":"{read_only:false; response_revision:929; number_of_response:1; }","duration":"168.795821ms","start":"2026-05-19T02:01:03.490173Z","end":"2026-05-19T02:01:03.658968Z","steps":["trace[1397956280] 'process raft request' (duration: 168.62103ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:01:03.659097Z","caller":"traceutil/trace.go:171","msg":"trace[1691006049] transaction","detail":"{read_only:false; response_revision:930; number_of_response:1; }","duration":"165.917212ms","start":"2026-05-19T02:01:03.493158Z","end":"2026-05-19T02:01:03.659075Z","steps":["trace[1691006049] 'process raft request' (duration: 165.752371ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:01:44.265091Z","caller":"traceutil/trace.go:171","msg":"trace[1234983400] transaction","detail":"{read_only:false; response_revision:1463; number_of_response:1; }","duration":"165.819647ms","start":"2026-05-19T02:01:44.099244Z","end":"2026-05-19T02:01:44.265063Z","steps":["trace[1234983400] 'process raft request' (duration: 165.652822ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:01:44.27499Z","caller":"traceutil/trace.go:171","msg":"trace[2002343151] linearizableReadLoop","detail":"{readStateIndex:1511; appliedIndex:1509; }","duration":"169.814741ms","start":"2026-05-19T02:01:44.10515Z","end":"2026-05-19T02:01:44.274965Z","steps":["trace[2002343151] 'read index received' (duration: 159.719908ms)","trace[2002343151] 'applied index is now lower than readState.Index' (duration: 10.093863ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:01:44.275083Z","caller":"traceutil/trace.go:171","msg":"trace[734980920] transaction","detail":"{read_only:false; response_revision:1464; number_of_response:1; }","duration":"172.69705ms","start":"2026-05-19T02:01:44.102362Z","end":"2026-05-19T02:01:44.275059Z","steps":["trace[734980920] 'process raft request' (duration: 172.478114ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:01:44.27521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.036788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-05-19T02:01:44.275254Z","caller":"traceutil/trace.go:171","msg":"trace[1633566931] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1464; }","duration":"170.138471ms","start":"2026-05-19T02:01:44.105103Z","end":"2026-05-19T02:01:44.275241Z","steps":["trace[1633566931] 'agreement among raft nodes before linearized reading' (duration: 169.979926ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:01:44.275358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.412101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T02:01:44.275468Z","caller":"traceutil/trace.go:171","msg":"trace[798197681] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1464; }","duration":"139.643118ms","start":"2026-05-19T02:01:44.135802Z","end":"2026-05-19T02:01:44.275445Z","steps":["trace[798197681] 'agreement among raft nodes before linearized reading' (duration: 139.390471ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:02:09.45674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.935224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-046ee08f-6707-4a73-a416-6033e252f9c7\" ","response":"range_response_count:1 size:3625"} {"level":"info","ts":"2026-05-19T02:02:09.456836Z","caller":"traceutil/trace.go:171","msg":"trace[1056285717] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-046ee08f-6707-4a73-a416-6033e252f9c7; range_end:; response_count:1; response_revision:1884; }","duration":"304.078618ms","start":"2026-05-19T02:02:09.152737Z","end":"2026-05-19T02:02:09.456816Z","steps":["trace[1056285717] 'range keys from in-memory index tree' (duration: 303.76904ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:02:09.456879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:02:09.152718Z","time spent":"304.15178ms","remote":"127.0.0.1:38510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3648,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-046ee08f-6707-4a73-a416-6033e252f9c7\" "} {"level":"warn","ts":"2026-05-19T02:02:09.456792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.562935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T02:02:09.45674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.38707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-046ee08f-6707-4a73-a416-6033e252f9c7\" ","response":"range_response_count:1 size:3625"} {"level":"info","ts":"2026-05-19T02:02:09.457078Z","caller":"traceutil/trace.go:171","msg":"trace[1700654983] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-046ee08f-6707-4a73-a416-6033e252f9c7; range_end:; response_count:1; response_revision:1884; }","duration":"214.76921ms","start":"2026-05-19T02:02:09.242299Z","end":"2026-05-19T02:02:09.457068Z","steps":["trace[1700654983] 'range keys from in-memory index tree' (duration: 214.255417ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:02:09.457034Z","caller":"traceutil/trace.go:171","msg":"trace[1700377955] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:1884; }","duration":"279.844552ms","start":"2026-05-19T02:02:09.177169Z","end":"2026-05-19T02:02:09.457013Z","steps":["trace[1700377955] 'count revisions from in-memory index tree' (duration: 279.500884ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:02:09.812098Z","caller":"traceutil/trace.go:171","msg":"trace[1691466945] linearizableReadLoop","detail":"{readStateIndex:1960; appliedIndex:1959; }","duration":"318.719772ms","start":"2026-05-19T02:02:09.493353Z","end":"2026-05-19T02:02:09.812073Z","steps":["trace[1691466945] 'read index received' (duration: 318.64771ms)","trace[1691466945] 'applied index is now lower than readState.Index' (duration: 71.082µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:02:09.81224Z","caller":"traceutil/trace.go:171","msg":"trace[123971521] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"347.858785ms","start":"2026-05-19T02:02:09.464367Z","end":"2026-05-19T02:02:09.812226Z","steps":["trace[123971521] 'process raft request' (duration: 347.542948ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:02:09.812563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.198723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-19T02:02:09.812625Z","caller":"traceutil/trace.go:171","msg":"trace[1603153314] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1885; }","duration":"319.299056ms","start":"2026-05-19T02:02:09.493311Z","end":"2026-05-19T02:02:09.812611Z","steps":["trace[1603153314] 'agreement among raft nodes before linearized reading' (duration: 319.119151ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:02:09.812662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:02:09.493298Z","time spent":"319.355797ms","remote":"127.0.0.1:46146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-05-19T02:02:09.813529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:02:09.464344Z","time spent":"347.935868ms","remote":"127.0.0.1:38510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3727,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T02:02:10.127739Z","caller":"traceutil/trace.go:171","msg":"trace[1421513160] transaction","detail":"{read_only:false; response_revision:1886; number_of_response:1; }","duration":"570.61241ms","start":"2026-05-19T02:02:09.557099Z","end":"2026-05-19T02:02:10.127712Z","steps":["trace[1421513160] 'process raft request' (duration: 543.401929ms)","trace[1421513160] 'compare' (duration: 26.785421ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T02:02:10.12788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:02:09.557075Z","time spent":"570.736123ms","remote":"127.0.0.1:38596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T02:02:10.128171Z","caller":"traceutil/trace.go:171","msg":"trace[1859461838] transaction","detail":"{read_only:false; response_revision:1887; number_of_response:1; }","duration":"487.733408ms","start":"2026-05-19T02:02:09.640388Z","end":"2026-05-19T02:02:10.128121Z","steps":["trace[1859461838] 'process raft request' (duration: 487.196345ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:02:10.128349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:02:09.640364Z","time spent":"487.897631ms","remote":"127.0.0.1:38596","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-05-19T02:02:10.1284Z","caller":"traceutil/trace.go:171","msg":"trace[106509373] linearizableReadLoop","detail":"{readStateIndex:1963; appliedIndex:1960; }","duration":"316.202343ms","start":"2026-05-19T02:02:09.812181Z","end":"2026-05-19T02:02:10.128384Z","steps":["trace[106509373] 'read index received' (duration: 288.253764ms)","trace[106509373] 'applied index is now lower than readState.Index' (duration: 27.947079ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:02:10.128475Z","caller":"traceutil/trace.go:171","msg":"trace[614936908] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"482.754807ms","start":"2026-05-19T02:02:09.645713Z","end":"2026-05-19T02:02:10.128468Z","steps":["trace[614936908] 'process raft request' (duration: 481.959318ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:02:10.128526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:02:09.645685Z","time spent":"482.811499ms","remote":"127.0.0.1:38596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T02:02:10.128544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.626504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T02:02:10.128585Z","caller":"traceutil/trace.go:171","msg":"trace[1272748870] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1889; }","duration":"393.708566ms","start":"2026-05-19T02:02:09.734865Z","end":"2026-05-19T02:02:10.128574Z","steps":["trace[1272748870] 'agreement among raft nodes before linearized reading' (duration: 393.642714ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:02:10.12863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:02:09.734845Z","time spent":"393.775217ms","remote":"127.0.0.1:38610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":30,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-19T02:02:10.128639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.971687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10666"} {"level":"info","ts":"2026-05-19T02:02:10.128692Z","caller":"traceutil/trace.go:171","msg":"trace[801833267] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1889; }","duration":"311.050808ms","start":"2026-05-19T02:02:09.817625Z","end":"2026-05-19T02:02:10.128675Z","steps":["trace[801833267] 'agreement among raft nodes before linearized reading' (duration: 310.881554ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:02:10.128734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:02:09.817605Z","time spent":"311.11932ms","remote":"127.0.0.1:38510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":10689,"request content":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" "} {"level":"warn","ts":"2026-05-19T02:02:20.963349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.895786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T02:02:20.963415Z","caller":"traceutil/trace.go:171","msg":"trace[1872043470] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1990; }","duration":"113.020719ms","start":"2026-05-19T02:02:20.850382Z","end":"2026-05-19T02:02:20.963402Z","steps":["trace[1872043470] 'count revisions from in-memory index tree' (duration: 112.805064ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:02:32.315888Z","caller":"traceutil/trace.go:171","msg":"trace[2086243873] transaction","detail":"{read_only:false; response_revision:2065; number_of_response:1; }","duration":"109.697474ms","start":"2026-05-19T02:02:32.206166Z","end":"2026-05-19T02:02:32.315864Z","steps":["trace[2086243873] 'process raft request' (duration: 109.51602ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:02:32.317559Z","caller":"traceutil/trace.go:171","msg":"trace[1452495795] transaction","detail":"{read_only:false; response_revision:2066; number_of_response:1; }","duration":"110.452959ms","start":"2026-05-19T02:02:32.207074Z","end":"2026-05-19T02:02:32.317527Z","steps":["trace[1452495795] 'process raft request' (duration: 110.256105ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:02:38.440829Z","caller":"traceutil/trace.go:171","msg":"trace[1792171803] transaction","detail":"{read_only:false; response_revision:2097; number_of_response:1; }","duration":"103.875416ms","start":"2026-05-19T02:02:38.336931Z","end":"2026-05-19T02:02:38.440806Z","steps":["trace[1792171803] 'process raft request' (duration: 103.707823ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:02:38.446807Z","caller":"traceutil/trace.go:171","msg":"trace[1921186162] linearizableReadLoop","detail":"{readStateIndex:2180; appliedIndex:2178; }","duration":"102.954479ms","start":"2026-05-19T02:02:38.343824Z","end":"2026-05-19T02:02:38.446778Z","steps":["trace[1921186162] 'read index received' (duration: 96.952215ms)","trace[1921186162] 'applied index is now lower than readState.Index' (duration: 6.001194ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:02:38.44683Z","caller":"traceutil/trace.go:171","msg":"trace[1458471169] transaction","detail":"{read_only:false; response_revision:2098; number_of_response:1; }","duration":"109.258978ms","start":"2026-05-19T02:02:38.337559Z","end":"2026-05-19T02:02:38.446818Z","steps":["trace[1458471169] 'process raft request' (duration: 109.091215ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:02:38.447098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.270475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-19T02:02:38.447153Z","caller":"traceutil/trace.go:171","msg":"trace[1891881756] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2098; }","duration":"103.370477ms","start":"2026-05-19T02:02:38.343768Z","end":"2026-05-19T02:02:38.447139Z","steps":["trace[1891881756] 'agreement among raft nodes before linearized reading' (duration: 103.119502ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:02:38.814535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.968153ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T02:02:38.814655Z","caller":"traceutil/trace.go:171","msg":"trace[1278678024] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"295.139306ms","start":"2026-05-19T02:02:38.519494Z","end":"2026-05-19T02:02:38.814633Z","steps":["trace[1278678024] 'process raft request' (duration: 144.986879ms)","trace[1278678024] 'compare' (duration: 149.847001ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:02:38.834213Z","caller":"traceutil/trace.go:171","msg":"trace[292795913] linearizableReadLoop","detail":"{readStateIndex:2185; appliedIndex:2183; }","duration":"190.516485ms","start":"2026-05-19T02:02:38.643678Z","end":"2026-05-19T02:02:38.834194Z","steps":["trace[292795913] 'read index received' (duration: 20.883947ms)","trace[292795913] 'applied index is now lower than readState.Index' (duration: 169.631538ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T02:02:38.834361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.664767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T02:02:38.834415Z","caller":"traceutil/trace.go:171","msg":"trace[1689750517] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:2103; }","duration":"190.78194ms","start":"2026-05-19T02:02:38.643622Z","end":"2026-05-19T02:02:38.834404Z","steps":["trace[1689750517] 'agreement among raft nodes before linearized reading' (duration: 190.676578ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:02:38.834483Z","caller":"traceutil/trace.go:171","msg":"trace[1200963044] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"304.533504ms","start":"2026-05-19T02:02:38.529762Z","end":"2026-05-19T02:02:38.834296Z","steps":["trace[1200963044] 'process raft request' (duration: 304.31792ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:02:38.834843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:02:38.529748Z","time spent":"304.83053ms","remote":"127.0.0.1:38596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T02:02:38.84388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.898214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T02:02:38.84396Z","caller":"traceutil/trace.go:171","msg":"trace[883656398] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:2104; }","duration":"169.014685ms","start":"2026-05-19T02:02:38.674926Z","end":"2026-05-19T02:02:38.843941Z","steps":["trace[883656398] 'agreement among raft nodes before linearized reading' (duration: 168.866163ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:03:43.257638Z","caller":"traceutil/trace.go:171","msg":"trace[637725404] linearizableReadLoop","detail":"{readStateIndex:2591; appliedIndex:2590; }","duration":"175.949367ms","start":"2026-05-19T02:03:43.081665Z","end":"2026-05-19T02:03:43.257614Z","steps":["trace[637725404] 'read index received' (duration: 174.66737ms)","trace[637725404] 'applied index is now lower than readState.Index' (duration: 1.280847ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:03:43.257819Z","caller":"traceutil/trace.go:171","msg":"trace[1401812243] transaction","detail":"{read_only:false; response_revision:2494; number_of_response:1; }","duration":"218.773129ms","start":"2026-05-19T02:03:43.039028Z","end":"2026-05-19T02:03:43.257801Z","steps":["trace[1401812243] 'process raft request' (duration: 217.3646ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:03:43.258005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.354143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-19T02:03:43.258102Z","caller":"traceutil/trace.go:171","msg":"trace[654784221] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2494; }","duration":"176.529605ms","start":"2026-05-19T02:03:43.081549Z","end":"2026-05-19T02:03:43.258078Z","steps":["trace[654784221] 'agreement among raft nodes before linearized reading' (duration: 176.305742ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:03:43.258372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.644966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-05-19T02:03:43.258427Z","caller":"traceutil/trace.go:171","msg":"trace[1864370559] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2494; }","duration":"152.729578ms","start":"2026-05-19T02:03:43.105684Z","end":"2026-05-19T02:03:43.258414Z","steps":["trace[1864370559] 'agreement among raft nodes before linearized reading' (duration: 152.602526ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:03:43.258603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.833755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-19T02:03:43.258657Z","caller":"traceutil/trace.go:171","msg":"trace[1984777922] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2494; }","duration":"112.913677ms","start":"2026-05-19T02:03:43.145729Z","end":"2026-05-19T02:03:43.258642Z","steps":["trace[1984777922] 'agreement among raft nodes before linearized reading' (duration: 112.792515ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:03:52.210189Z","caller":"traceutil/trace.go:171","msg":"trace[983034510] transaction","detail":"{read_only:false; response_revision:2598; number_of_response:1; }","duration":"205.776299ms","start":"2026-05-19T02:03:52.004386Z","end":"2026-05-19T02:03:52.210162Z","steps":["trace[983034510] 'process raft request' (duration: 205.610476ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:04:19.027302Z","caller":"traceutil/trace.go:171","msg":"trace[919485125] transaction","detail":"{read_only:false; response_revision:2748; number_of_response:1; }","duration":"116.985993ms","start":"2026-05-19T02:04:18.910299Z","end":"2026-05-19T02:04:19.027285Z","steps":["trace[919485125] 'process raft request' (duration: 116.718779ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:04:24.944064Z","caller":"traceutil/trace.go:171","msg":"trace[260928828] transaction","detail":"{read_only:false; response_revision:2775; number_of_response:1; }","duration":"151.055657ms","start":"2026-05-19T02:04:24.792982Z","end":"2026-05-19T02:04:24.944037Z","steps":["trace[260928828] 'process raft request' (duration: 150.908015ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:04:25.009606Z","caller":"traceutil/trace.go:171","msg":"trace[697768193] transaction","detail":"{read_only:false; response_revision:2777; number_of_response:1; }","duration":"184.356531ms","start":"2026-05-19T02:04:24.825219Z","end":"2026-05-19T02:04:25.009576Z","steps":["trace[697768193] 'process raft request' (duration: 184.30018ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:04:25.009707Z","caller":"traceutil/trace.go:171","msg":"trace[366627894] transaction","detail":"{read_only:false; response_revision:2776; number_of_response:1; }","duration":"185.20416ms","start":"2026-05-19T02:04:24.824467Z","end":"2026-05-19T02:04:25.009671Z","steps":["trace[366627894] 'process raft request' (duration: 184.952687ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:04:30.406447Z","caller":"traceutil/trace.go:171","msg":"trace[1024624153] linearizableReadLoop","detail":"{readStateIndex:2914; appliedIndex:2913; }","duration":"127.005122ms","start":"2026-05-19T02:04:30.279422Z","end":"2026-05-19T02:04:30.406428Z","steps":["trace[1024624153] 'read index received' (duration: 110.079765ms)","trace[1024624153] 'applied index is now lower than readState.Index' (duration: 16.924367ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T02:04:30.406844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.412467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18b0d52dbfabac03\" ","response":"range_response_count:1 size:777"} {"level":"info","ts":"2026-05-19T02:04:30.406981Z","caller":"traceutil/trace.go:171","msg":"trace[121798158] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18b0d52dbfabac03; range_end:; response_count:1; response_revision:2806; }","duration":"127.596789ms","start":"2026-05-19T02:04:30.279369Z","end":"2026-05-19T02:04:30.406966Z","steps":["trace[121798158] 'agreement among raft nodes before linearized reading' (duration: 127.325116ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:05:58.696743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.830683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T02:05:58.696796Z","caller":"traceutil/trace.go:171","msg":"trace[708307413] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3269; }","duration":"122.933836ms","start":"2026-05-19T02:05:58.573851Z","end":"2026-05-19T02:05:58.696785Z","steps":["trace[708307413] 'range keys from in-memory index tree' (duration: 122.75002ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:06:03.923599Z","caller":"traceutil/trace.go:171","msg":"trace[588743127] transaction","detail":"{read_only:false; response_revision:3296; number_of_response:1; }","duration":"120.960884ms","start":"2026-05-19T02:06:03.802603Z","end":"2026-05-19T02:06:03.923564Z","steps":["trace[588743127] 'process raft request' (duration: 118.504438ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:06:35.829471Z","caller":"traceutil/trace.go:171","msg":"trace[1567559519] transaction","detail":"{read_only:false; response_revision:3560; number_of_response:1; }","duration":"101.552741ms","start":"2026-05-19T02:06:35.727895Z","end":"2026-05-19T02:06:35.829448Z","steps":["trace[1567559519] 'process raft request' (duration: 97.54043ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:06:36.520774Z","caller":"traceutil/trace.go:171","msg":"trace[1313389553] transaction","detail":"{read_only:false; response_revision:3565; number_of_response:1; }","duration":"100.719162ms","start":"2026-05-19T02:06:36.420024Z","end":"2026-05-19T02:06:36.520743Z","steps":["trace[1313389553] 'process raft request' (duration: 47.289489ms)","trace[1313389553] 'compare' (duration: 53.305649ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:07:06.724954Z","caller":"traceutil/trace.go:171","msg":"trace[152402202] transaction","detail":"{read_only:false; response_revision:3727; number_of_response:1; }","duration":"100.156202ms","start":"2026-05-19T02:07:06.624771Z","end":"2026-05-19T02:07:06.724927Z","steps":["trace[152402202] 'process raft request' (duration: 99.992017ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:07:38.230429Z","caller":"traceutil/trace.go:171","msg":"trace[1411892650] transaction","detail":"{read_only:false; response_revision:3963; number_of_response:1; }","duration":"160.63776ms","start":"2026-05-19T02:07:38.069765Z","end":"2026-05-19T02:07:38.230403Z","steps":["trace[1411892650] 'process raft request' (duration: 160.496986ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:07:38.291693Z","caller":"traceutil/trace.go:171","msg":"trace[1354836668] linearizableReadLoop","detail":"{readStateIndex:4127; appliedIndex:4125; }","duration":"129.278125ms","start":"2026-05-19T02:07:38.162396Z","end":"2026-05-19T02:07:38.291674Z","steps":["trace[1354836668] 'read index received' (duration: 67.848639ms)","trace[1354836668] 'applied index is now lower than readState.Index' (duration: 61.428796ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:07:38.291756Z","caller":"traceutil/trace.go:171","msg":"trace[1156445180] transaction","detail":"{read_only:false; response_revision:3964; number_of_response:1; }","duration":"169.394997ms","start":"2026-05-19T02:07:38.122331Z","end":"2026-05-19T02:07:38.291726Z","steps":["trace[1156445180] 'process raft request' (duration: 169.241343ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:07:38.29186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.445269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-19T02:07:38.291894Z","caller":"traceutil/trace.go:171","msg":"trace[255306390] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3964; }","duration":"129.539191ms","start":"2026-05-19T02:07:38.162346Z","end":"2026-05-19T02:07:38.291885Z","steps":["trace[255306390] 'agreement among raft nodes before linearized reading' (duration: 129.395218ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:07:57.57966Z","caller":"traceutil/trace.go:171","msg":"trace[1362853575] linearizableReadLoop","detail":"{readStateIndex:4580; appliedIndex:4579; }","duration":"160.314079ms","start":"2026-05-19T02:07:57.419324Z","end":"2026-05-19T02:07:57.579638Z","steps":["trace[1362853575] 'read index received' (duration: 160.044743ms)","trace[1362853575] 'applied index is now lower than readState.Index' (duration: 268.236µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:07:57.579759Z","caller":"traceutil/trace.go:171","msg":"trace[1558003417] transaction","detail":"{read_only:false; response_revision:4409; number_of_response:1; }","duration":"162.844575ms","start":"2026-05-19T02:07:57.416907Z","end":"2026-05-19T02:07:57.579752Z","steps":["trace[1558003417] 'process raft request' (duration: 162.443386ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:07:57.580246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.881202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-admission-patch-w9q22\" ","response":"range_response_count:1 size:3378"} {"level":"info","ts":"2026-05-19T02:07:57.580371Z","caller":"traceutil/trace.go:171","msg":"trace[1406023641] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-admission-patch-w9q22; range_end:; response_count:1; response_revision:4409; }","duration":"161.031665ms","start":"2026-05-19T02:07:57.419298Z","end":"2026-05-19T02:07:57.58033Z","steps":["trace[1406023641] 'agreement among raft nodes before linearized reading' (duration: 160.521733ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:07:57.584989Z","caller":"traceutil/trace.go:171","msg":"trace[1677643130] transaction","detail":"{read_only:false; response_revision:4410; number_of_response:1; }","duration":"162.800614ms","start":"2026-05-19T02:07:57.42217Z","end":"2026-05-19T02:07:57.58497Z","steps":["trace[1677643130] 'process raft request' (duration: 162.1479ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:07:57.5857Z","caller":"traceutil/trace.go:171","msg":"trace[1744296557] transaction","detail":"{read_only:false; response_revision:4411; number_of_response:1; }","duration":"125.300207ms","start":"2026-05-19T02:07:57.460144Z","end":"2026-05-19T02:07:57.585445Z","steps":["trace[1744296557] 'process raft request' (duration: 124.295434ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:08:00.045114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.504906ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-19T02:08:00.045234Z","caller":"traceutil/trace.go:171","msg":"trace[647175384] linearizableReadLoop","detail":"{readStateIndex:4653; appliedIndex:4652; }","duration":"243.719644ms","start":"2026-05-19T02:07:59.801498Z","end":"2026-05-19T02:08:00.045218Z","steps":["trace[647175384] 'read index received' (duration: 60.980003ms)","trace[647175384] 'applied index is now lower than readState.Index' (duration: 182.738551ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:08:00.045298Z","caller":"traceutil/trace.go:171","msg":"trace[793253391] transaction","detail":"{read_only:false; response_revision:4481; number_of_response:1; }","duration":"297.181561ms","start":"2026-05-19T02:07:59.748106Z","end":"2026-05-19T02:08:00.045287Z","steps":["trace[793253391] 'process raft request' (duration: 114.49405ms)","trace[793253391] 'compare' (duration: 182.223171ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T02:08:00.045791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.282837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/alertmanager-tls\" ","response":"range_response_count:1 size:3238"} {"level":"info","ts":"2026-05-19T02:08:00.045851Z","caller":"traceutil/trace.go:171","msg":"trace[1218526872] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/alertmanager-tls; range_end:; response_count:1; response_revision:4481; }","duration":"244.375669ms","start":"2026-05-19T02:07:59.801459Z","end":"2026-05-19T02:08:00.045834Z","steps":["trace[1218526872] 'agreement among raft nodes before linearized reading' (duration: 244.164514ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:08:00.046095Z","caller":"traceutil/trace.go:171","msg":"trace[596156346] transaction","detail":"{read_only:false; response_revision:4482; number_of_response:1; }","duration":"139.958792ms","start":"2026-05-19T02:07:59.906109Z","end":"2026-05-19T02:08:00.046068Z","steps":["trace[596156346] 'process raft request' (duration: 139.815869ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:08:00.051139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.295672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/alertmanager-tls\" ","response":"range_response_count:1 size:3238"} {"level":"info","ts":"2026-05-19T02:08:00.051198Z","caller":"traceutil/trace.go:171","msg":"trace[602726652] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/alertmanager-tls; range_end:; response_count:1; response_revision:4485; }","duration":"196.396514ms","start":"2026-05-19T02:07:59.854784Z","end":"2026-05-19T02:08:00.05118Z","steps":["trace[602726652] 'agreement among raft nodes before linearized reading' (duration: 196.264291ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:08:00.051396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.222824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" ","response":"range_response_count:1 size:9492"} {"level":"info","ts":"2026-05-19T02:08:00.051426Z","caller":"traceutil/trace.go:171","msg":"trace[1596890496] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:1; response_revision:4485; }","duration":"184.284735ms","start":"2026-05-19T02:07:59.867132Z","end":"2026-05-19T02:08:00.051417Z","steps":["trace[1596890496] 'agreement among raft nodes before linearized reading' (duration: 184.196254ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:08:01.447886Z","caller":"traceutil/trace.go:171","msg":"trace[215303047] linearizableReadLoop","detail":"{readStateIndex:4736; appliedIndex:4735; }","duration":"109.902433ms","start":"2026-05-19T02:08:01.337927Z","end":"2026-05-19T02:08:01.44783Z","steps":["trace[215303047] 'read index received' (duration: 109.442693ms)","trace[215303047] 'applied index is now lower than readState.Index' (duration: 458.35µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:08:01.447918Z","caller":"traceutil/trace.go:171","msg":"trace[176306132] transaction","detail":"{read_only:false; response_revision:4562; number_of_response:1; }","duration":"120.238272ms","start":"2026-05-19T02:08:01.327652Z","end":"2026-05-19T02:08:01.44789Z","steps":["trace[176306132] 'process raft request' (duration: 119.890564ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:08:01.448026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.077157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T02:08:01.448076Z","caller":"traceutil/trace.go:171","msg":"trace[1007099690] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:4562; }","duration":"110.16952ms","start":"2026-05-19T02:08:01.337897Z","end":"2026-05-19T02:08:01.448067Z","steps":["trace[1007099690] 'agreement among raft nodes before linearized reading' (duration: 110.070447ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:08:01.448231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.364041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-05-19T02:08:01.448299Z","caller":"traceutil/trace.go:171","msg":"trace[462357936] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4562; }","duration":"109.492314ms","start":"2026-05-19T02:08:01.338795Z","end":"2026-05-19T02:08:01.448288Z","steps":["trace[462357936] 'agreement among raft nodes before linearized reading' (duration: 109.251659ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:08:06.234469Z","caller":"traceutil/trace.go:171","msg":"trace[1805280740] transaction","detail":"{read_only:false; response_revision:4662; number_of_response:1; }","duration":"125.480617ms","start":"2026-05-19T02:08:06.108965Z","end":"2026-05-19T02:08:06.234445Z","steps":["trace[1805280740] 'process raft request' (duration: 125.331494ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:08:12.541615Z","caller":"traceutil/trace.go:171","msg":"trace[883459397] transaction","detail":"{read_only:false; response_revision:4779; number_of_response:1; }","duration":"368.118353ms","start":"2026-05-19T02:08:12.173474Z","end":"2026-05-19T02:08:12.541592Z","steps":["trace[883459397] 'process raft request' (duration: 367.914389ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:08:12.54227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:08:12.173449Z","time spent":"368.715696ms","remote":"127.0.0.1:51372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7493,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T02:08:12.622788Z","caller":"traceutil/trace.go:171","msg":"trace[2055630558] transaction","detail":"{read_only:false; response_revision:4780; number_of_response:1; }","duration":"345.763896ms","start":"2026-05-19T02:08:12.276988Z","end":"2026-05-19T02:08:12.622752Z","steps":["trace[2055630558] 'process raft request' (duration: 345.175743ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:08:12.623004Z","caller":"traceutil/trace.go:171","msg":"trace[1522447520] transaction","detail":"{read_only:false; response_revision:4782; number_of_response:1; }","duration":"142.611787ms","start":"2026-05-19T02:08:12.48036Z","end":"2026-05-19T02:08:12.622972Z","steps":["trace[1522447520] 'process raft request' (duration: 142.222878ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:08:12.623086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:08:12.27696Z","time spent":"345.983131ms","remote":"127.0.0.1:38596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T02:08:12.62327Z","caller":"traceutil/trace.go:171","msg":"trace[1865349648] transaction","detail":"{read_only:false; response_revision:4781; number_of_response:1; }","duration":"254.1876ms","start":"2026-05-19T02:08:12.369066Z","end":"2026-05-19T02:08:12.623254Z","steps":["trace[1865349648] 'process raft request' (duration: 253.382382ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:08:12.976159Z","caller":"traceutil/trace.go:171","msg":"trace[1365037940] linearizableReadLoop","detail":"{readStateIndex:4968; appliedIndex:4967; }","duration":"151.153578ms","start":"2026-05-19T02:08:12.82498Z","end":"2026-05-19T02:08:12.976134Z","steps":["trace[1365037940] 'read index received' (duration: 151.033656ms)","trace[1365037940] 'applied index is now lower than readState.Index' (duration: 118.972µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:08:12.97629Z","caller":"traceutil/trace.go:171","msg":"trace[1852285015] transaction","detail":"{read_only:false; response_revision:4787; number_of_response:1; }","duration":"151.999146ms","start":"2026-05-19T02:08:12.824279Z","end":"2026-05-19T02:08:12.976278Z","steps":["trace[1852285015] 'process raft request' (duration: 151.659619ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:08:12.976498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.498165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-d7f7546b7-mkd7d.18b0d567260ad0b4\" ","response":"range_response_count:1 size:895"} {"level":"info","ts":"2026-05-19T02:08:12.976579Z","caller":"traceutil/trace.go:171","msg":"trace[166371880] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-d7f7546b7-mkd7d.18b0d567260ad0b4; range_end:; response_count:1; response_revision:4787; }","duration":"151.623149ms","start":"2026-05-19T02:08:12.824942Z","end":"2026-05-19T02:08:12.976565Z","steps":["trace[166371880] 'agreement among raft nodes before linearized reading' (duration: 151.413264ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:08:13.086946Z","caller":"traceutil/trace.go:171","msg":"trace[727205828] linearizableReadLoop","detail":"{readStateIndex:4969; appliedIndex:4968; }","duration":"110.68863ms","start":"2026-05-19T02:08:12.976232Z","end":"2026-05-19T02:08:13.086921Z","steps":["trace[727205828] 'read index received' (duration: 110.443954ms)","trace[727205828] 'applied index is now lower than readState.Index' (duration: 242.966µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:08:13.087143Z","caller":"traceutil/trace.go:171","msg":"trace[1883552563] transaction","detail":"{read_only:false; response_revision:4788; number_of_response:1; }","duration":"254.311647ms","start":"2026-05-19T02:08:12.832675Z","end":"2026-05-19T02:08:13.086987Z","steps":["trace[1883552563] 'process raft request' (duration: 254.053871ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:08:13.087277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.222306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-05-19T02:08:13.087369Z","caller":"traceutil/trace.go:171","msg":"trace[1862661706] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4788; }","duration":"262.362049ms","start":"2026-05-19T02:08:12.824985Z","end":"2026-05-19T02:08:13.087347Z","steps":["trace[1862661706] 'agreement among raft nodes before linearized reading' (duration: 262.029252ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:08:13.094954Z","caller":"traceutil/trace.go:171","msg":"trace[1988613961] transaction","detail":"{read_only:false; response_revision:4789; number_of_response:1; }","duration":"115.924741ms","start":"2026-05-19T02:08:12.978995Z","end":"2026-05-19T02:08:13.09492Z","steps":["trace[1988613961] 'process raft request' (duration: 115.785198ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:08:13.256826Z","caller":"traceutil/trace.go:171","msg":"trace[1683991121] transaction","detail":"{read_only:false; response_revision:4794; number_of_response:1; }","duration":"115.280815ms","start":"2026-05-19T02:08:13.141519Z","end":"2026-05-19T02:08:13.2568Z","steps":["trace[1683991121] 'process raft request' (duration: 94.125495ms)","trace[1683991121] 'compare' (duration: 20.628599ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:08:13.25701Z","caller":"traceutil/trace.go:171","msg":"trace[1615040553] linearizableReadLoop","detail":"{readStateIndex:4976; appliedIndex:4974; }","duration":"108.085792ms","start":"2026-05-19T02:08:13.148904Z","end":"2026-05-19T02:08:13.25699Z","steps":["trace[1615040553] 'read index received' (duration: 86.720147ms)","trace[1615040553] 'applied index is now lower than readState.Index' (duration: 21.364505ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:08:13.257056Z","caller":"traceutil/trace.go:171","msg":"trace[1496999635] transaction","detail":"{read_only:false; response_revision:4795; number_of_response:1; }","duration":"114.819515ms","start":"2026-05-19T02:08:13.142226Z","end":"2026-05-19T02:08:13.257045Z","steps":["trace[1496999635] 'process raft request' (duration: 114.517219ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:08:13.257249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.320467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-24fdb0c6-f0b6-45af-9215-0435f38c9a25\" ","response":"range_response_count:1 size:1435"} {"level":"info","ts":"2026-05-19T02:08:13.257829Z","caller":"traceutil/trace.go:171","msg":"trace[1735419952] range","detail":"{range_begin:/registry/persistentvolumes/pvc-24fdb0c6-f0b6-45af-9215-0435f38c9a25; range_end:; response_count:1; response_revision:4795; }","duration":"108.91655ms","start":"2026-05-19T02:08:13.148889Z","end":"2026-05-19T02:08:13.257806Z","steps":["trace[1735419952] 'agreement among raft nodes before linearized reading' (duration: 108.193244ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:08:13.268328Z","caller":"traceutil/trace.go:171","msg":"trace[54344919] transaction","detail":"{read_only:false; response_revision:4796; number_of_response:1; }","duration":"117.883121ms","start":"2026-05-19T02:08:13.150421Z","end":"2026-05-19T02:08:13.268304Z","steps":["trace[54344919] 'process raft request' (duration: 117.482953ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:08:13.387396Z","caller":"traceutil/trace.go:171","msg":"trace[1109599273] transaction","detail":"{read_only:false; response_revision:4797; number_of_response:1; }","duration":"112.068657ms","start":"2026-05-19T02:08:13.2753Z","end":"2026-05-19T02:08:13.387369Z","steps":["trace[1109599273] 'process raft request' (duration: 107.596422ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:08:13.390224Z","caller":"traceutil/trace.go:171","msg":"trace[1965036155] transaction","detail":"{read_only:false; response_revision:4800; number_of_response:1; }","duration":"113.757653ms","start":"2026-05-19T02:08:13.276438Z","end":"2026-05-19T02:08:13.390195Z","steps":["trace[1965036155] 'process raft request' (duration: 113.702292ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:08:13.390579Z","caller":"traceutil/trace.go:171","msg":"trace[1673120405] transaction","detail":"{read_only:false; response_revision:4799; number_of_response:1; }","duration":"114.379257ms","start":"2026-05-19T02:08:13.276186Z","end":"2026-05-19T02:08:13.390565Z","steps":["trace[1673120405] 'process raft request' (duration: 113.905317ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:08:13.390722Z","caller":"traceutil/trace.go:171","msg":"trace[1735433528] transaction","detail":"{read_only:false; response_revision:4798; number_of_response:1; }","duration":"115.239385ms","start":"2026-05-19T02:08:13.275475Z","end":"2026-05-19T02:08:13.390715Z","steps":["trace[1735433528] 'process raft request' (duration: 114.487129ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:08:22.927447Z","caller":"traceutil/trace.go:171","msg":"trace[458372827] transaction","detail":"{read_only:false; response_revision:4936; number_of_response:1; }","duration":"134.197778ms","start":"2026-05-19T02:08:22.793215Z","end":"2026-05-19T02:08:22.927412Z","steps":["trace[458372827] 'process raft request' (duration: 59.583778ms)","trace[458372827] 'compare' (duration: 74.368735ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:08:22.932158Z","caller":"traceutil/trace.go:171","msg":"trace[602110412] transaction","detail":"{read_only:false; response_revision:4937; number_of_response:1; }","duration":"136.807672ms","start":"2026-05-19T02:08:22.795327Z","end":"2026-05-19T02:08:22.932134Z","steps":["trace[602110412] 'process raft request' (duration: 136.670549ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:08:27.233852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.126728ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T02:08:27.234187Z","caller":"traceutil/trace.go:171","msg":"trace[310967270] transaction","detail":"{read_only:false; response_revision:4970; number_of_response:1; }","duration":"763.332183ms","start":"2026-05-19T02:08:26.470825Z","end":"2026-05-19T02:08:27.234157Z","steps":["trace[310967270] 'process raft request' (duration: 339.821937ms)","trace[310967270] 'compare' (duration: 422.701479ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T02:08:27.234339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:08:26.470794Z","time spent":"763.462745ms","remote":"127.0.0.1:38776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10925,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T02:08:27.234691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"729.289652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-05-19T02:08:27.234741Z","caller":"traceutil/trace.go:171","msg":"trace[906259887] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4970; }","duration":"729.335813ms","start":"2026-05-19T02:08:26.505391Z","end":"2026-05-19T02:08:27.234727Z","steps":["trace[906259887] 'agreement among raft nodes before linearized reading' (duration: 729.19953ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:08:27.234777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:08:26.505331Z","time spent":"729.438865ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3339,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"info","ts":"2026-05-19T02:08:27.237517Z","caller":"traceutil/trace.go:171","msg":"trace[1563533045] linearizableReadLoop","detail":"{readStateIndex:5157; appliedIndex:5156; }","duration":"728.535277ms","start":"2026-05-19T02:08:26.505406Z","end":"2026-05-19T02:08:27.233942Z","steps":["trace[1563533045] 'read index received' (duration: 305.337978ms)","trace[1563533045] 'applied index is now lower than readState.Index' (duration: 423.196149ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:08:27.33246Z","caller":"traceutil/trace.go:171","msg":"trace[2024797151] transaction","detail":"{read_only:false; response_revision:4971; number_of_response:1; }","duration":"640.92591ms","start":"2026-05-19T02:08:26.691495Z","end":"2026-05-19T02:08:27.332421Z","steps":["trace[2024797151] 'process raft request' (duration: 640.686025ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:08:27.3325Z","caller":"traceutil/trace.go:171","msg":"trace[1163785449] transaction","detail":"{read_only:false; response_revision:4972; number_of_response:1; }","duration":"585.787337ms","start":"2026-05-19T02:08:26.746686Z","end":"2026-05-19T02:08:27.332474Z","steps":["trace[1163785449] 'process raft request' (duration: 585.619823ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:08:27.332692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:08:26.746659Z","time spent":"585.93261ms","remote":"127.0.0.1:38596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T02:08:27.332785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:08:26.691429Z","time spent":"641.117694ms","remote":"127.0.0.1:38596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T02:08:27.332778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.30216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T02:08:27.332854Z","caller":"traceutil/trace.go:171","msg":"trace[1030763356] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:4974; }","duration":"359.412452ms","start":"2026-05-19T02:08:26.973424Z","end":"2026-05-19T02:08:27.332837Z","steps":["trace[1030763356] 'agreement among raft nodes before linearized reading' (duration: 359.224198ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:08:27.332895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:08:26.973355Z","time spent":"359.530484ms","remote":"127.0.0.1:38364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-05-19T02:08:27.332989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"818.044692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T02:08:27.333035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.359214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-19T02:08:27.333062Z","caller":"traceutil/trace.go:171","msg":"trace[784153682] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:4974; }","duration":"818.174865ms","start":"2026-05-19T02:08:26.514871Z","end":"2026-05-19T02:08:27.333046Z","steps":["trace[784153682] 'agreement among raft nodes before linearized reading' (duration: 818.051062ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:08:27.333072Z","caller":"traceutil/trace.go:171","msg":"trace[636624056] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4974; }","duration":"210.432696ms","start":"2026-05-19T02:08:27.122627Z","end":"2026-05-19T02:08:27.33306Z","steps":["trace[636624056] 'agreement among raft nodes before linearized reading' (duration: 210.292713ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:08:27.333105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:08:26.51485Z","time spent":"818.243816ms","remote":"127.0.0.1:38718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "} {"level":"warn","ts":"2026-05-19T02:08:27.33318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.292944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-05-19T02:08:27.333214Z","caller":"traceutil/trace.go:171","msg":"trace[1433424704] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4974; }","duration":"349.344825ms","start":"2026-05-19T02:08:26.983858Z","end":"2026-05-19T02:08:27.333203Z","steps":["trace[1433424704] 'agreement among raft nodes before linearized reading' (duration: 349.222712ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:08:27.333245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:08:26.983851Z","time spent":"349.385566ms","remote":"127.0.0.1:38468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1958,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"info","ts":"2026-05-19T02:08:27.333321Z","caller":"traceutil/trace.go:171","msg":"trace[261508628] transaction","detail":"{read_only:false; response_revision:4973; number_of_response:1; }","duration":"584.587732ms","start":"2026-05-19T02:08:26.748722Z","end":"2026-05-19T02:08:27.333309Z","steps":["trace[261508628] 'process raft request' (duration: 583.629612ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:08:27.333383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:08:26.7487Z","time spent":"584.647184ms","remote":"127.0.0.1:38596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T02:08:27.333447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.056991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"warn","ts":"2026-05-19T02:08:27.333469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.635161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-19T02:08:27.333516Z","caller":"traceutil/trace.go:171","msg":"trace[1952695114] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4974; }","duration":"384.682512ms","start":"2026-05-19T02:08:26.948819Z","end":"2026-05-19T02:08:27.333502Z","steps":["trace[1952695114] 'agreement among raft nodes before linearized reading' (duration: 384.471908ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:08:27.333557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:08:26.948785Z","time spent":"384.764084ms","remote":"127.0.0.1:38596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-19T02:08:27.333476Z","caller":"traceutil/trace.go:171","msg":"trace[157553694] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4974; }","duration":"352.123542ms","start":"2026-05-19T02:08:26.981344Z","end":"2026-05-19T02:08:27.333467Z","steps":["trace[157553694] 'agreement among raft nodes before linearized reading' (duration: 352.03253ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:08:27.333715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:08:26.981328Z","time spent":"352.374807ms","remote":"127.0.0.1:38510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12236,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-05-19T02:08:27.333772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.077321ms","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-05-19T02:08:27.333801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.832776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:13873"} {"level":"info","ts":"2026-05-19T02:08:27.333811Z","caller":"traceutil/trace.go:171","msg":"trace[82442724] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4974; }","duration":"388.150133ms","start":"2026-05-19T02:08:26.945647Z","end":"2026-05-19T02:08:27.333797Z","steps":["trace[82442724] 'agreement among raft nodes before linearized reading' (duration: 388.02265ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:08:27.333479Z","caller":"traceutil/trace.go:171","msg":"trace[988324774] transaction","detail":"{read_only:false; response_revision:4974; number_of_response:1; }","duration":"583.428818ms","start":"2026-05-19T02:08:26.750039Z","end":"2026-05-19T02:08:27.333468Z","steps":["trace[988324774] 'process raft request' (duration: 582.361176ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:08:27.333835Z","caller":"traceutil/trace.go:171","msg":"trace[1798986752] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4974; }","duration":"475.911438ms","start":"2026-05-19T02:08:26.857914Z","end":"2026-05-19T02:08:27.333825Z","steps":["trace[1798986752] 'agreement among raft nodes before linearized reading' (duration: 475.803875ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:08:27.333846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:08:26.945626Z","time spent":"388.211125ms","remote":"127.0.0.1:38596","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-05-19T02:08:27.333863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:08:26.85789Z","time spent":"475.966658ms","remote":"127.0.0.1:38510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":1,"response size":13896,"request content":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"warn","ts":"2026-05-19T02:08:27.333874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:08:26.750029Z","time spent":"583.813706ms","remote":"127.0.0.1:38596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T02:08:27.454058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.298372ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T02:08:27.454238Z","caller":"traceutil/trace.go:171","msg":"trace[1477584675] transaction","detail":"{read_only:false; response_revision:4975; number_of_response:1; }","duration":"115.047499ms","start":"2026-05-19T02:08:27.339165Z","end":"2026-05-19T02:08:27.454212Z","steps":["trace[1477584675] 'compare' (duration: 112.121389ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:08:27.454299Z","caller":"traceutil/trace.go:171","msg":"trace[594856782] transaction","detail":"{read_only:false; response_revision:4977; number_of_response:1; }","duration":"112.838903ms","start":"2026-05-19T02:08:27.341443Z","end":"2026-05-19T02:08:27.454282Z","steps":["trace[594856782] 'process raft request' (duration: 112.799233ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:08:27.454425Z","caller":"traceutil/trace.go:171","msg":"trace[785333876] linearizableReadLoop","detail":"{readStateIndex:5162; appliedIndex:5161; }","duration":"114.052918ms","start":"2026-05-19T02:08:27.340362Z","end":"2026-05-19T02:08:27.454415Z","steps":["trace[785333876] 'read index received' (duration: 1.276646ms)","trace[785333876] 'applied index is now lower than readState.Index' (duration: 112.775132ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:08:27.454743Z","caller":"traceutil/trace.go:171","msg":"trace[1726946909] transaction","detail":"{read_only:false; response_revision:4976; number_of_response:1; }","duration":"114.130901ms","start":"2026-05-19T02:08:27.340598Z","end":"2026-05-19T02:08:27.454729Z","steps":["trace[1726946909] 'process raft request' (duration: 113.551159ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:08:27.455555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.497987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-05-19T02:08:27.455611Z","caller":"traceutil/trace.go:171","msg":"trace[1173995505] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4977; }","duration":"115.252553ms","start":"2026-05-19T02:08:27.340341Z","end":"2026-05-19T02:08:27.455594Z","steps":["trace[1173995505] 'agreement among raft nodes before linearized reading' (duration: 114.394696ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:08:27.462673Z","caller":"traceutil/trace.go:171","msg":"trace[1886031092] transaction","detail":"{read_only:false; response_revision:4978; number_of_response:1; }","duration":"115.875046ms","start":"2026-05-19T02:08:27.346783Z","end":"2026-05-19T02:08:27.462658Z","steps":["trace[1886031092] 'process raft request' (duration: 115.733613ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:08:27.463318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.41093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone-nodes\" ","response":"range_response_count:1 size:1265"} {"level":"info","ts":"2026-05-19T02:08:27.463382Z","caller":"traceutil/trace.go:171","msg":"trace[557601380] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone-nodes; range_end:; response_count:1; response_revision:4978; }","duration":"122.493692ms","start":"2026-05-19T02:08:27.340873Z","end":"2026-05-19T02:08:27.463367Z","steps":["trace[557601380] 'agreement among raft nodes before linearized reading' (duration: 122.321208ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:08:27.463527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.91356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-94762625-f947-43e4-b2be-aa53f83a653a\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-05-19T02:08:27.463633Z","caller":"traceutil/trace.go:171","msg":"trace[849869796] range","detail":"{range_begin:/registry/persistentvolumes/pvc-94762625-f947-43e4-b2be-aa53f83a653a; range_end:; response_count:1; response_revision:4978; }","duration":"123.102664ms","start":"2026-05-19T02:08:27.340514Z","end":"2026-05-19T02:08:27.463617Z","steps":["trace[849869796] 'agreement among raft nodes before linearized reading' (duration: 122.869499ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:08:27.597528Z","caller":"traceutil/trace.go:171","msg":"trace[978180225] linearizableReadLoop","detail":"{readStateIndex:5169; appliedIndex:5167; }","duration":"114.924316ms","start":"2026-05-19T02:08:27.482578Z","end":"2026-05-19T02:08:27.597503Z","steps":["trace[978180225] 'read index received' (duration: 114.59459ms)","trace[978180225] 'applied index is now lower than readState.Index' (duration: 328.676µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:08:27.597666Z","caller":"traceutil/trace.go:171","msg":"trace[2010370423] transaction","detail":"{read_only:false; response_revision:4981; number_of_response:1; }","duration":"120.439829ms","start":"2026-05-19T02:08:27.477207Z","end":"2026-05-19T02:08:27.597647Z","steps":["trace[2010370423] 'process raft request' (duration: 120.040251ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:08:27.598001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.98825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-5afd276d-9e78-429c-a74b-025c4ca1637e\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-05-19T02:08:27.598072Z","caller":"traceutil/trace.go:171","msg":"trace[117000344] range","detail":"{range_begin:/registry/persistentvolumes/pvc-5afd276d-9e78-429c-a74b-025c4ca1637e; range_end:; response_count:1; response_revision:4982; }","duration":"120.115953ms","start":"2026-05-19T02:08:27.477934Z","end":"2026-05-19T02:08:27.59805Z","steps":["trace[117000344] 'agreement among raft nodes before linearized reading' (duration: 119.800796ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:08:27.598115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.221241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-05-19T02:08:27.598247Z","caller":"traceutil/trace.go:171","msg":"trace[1620010133] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4982; }","duration":"113.397395ms","start":"2026-05-19T02:08:27.484822Z","end":"2026-05-19T02:08:27.59822Z","steps":["trace[1620010133] 'agreement among raft nodes before linearized reading' (duration: 113.070138ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:08:27.598728Z","caller":"traceutil/trace.go:171","msg":"trace[541762892] transaction","detail":"{read_only:false; response_revision:4982; number_of_response:1; }","duration":"117.646352ms","start":"2026-05-19T02:08:27.481052Z","end":"2026-05-19T02:08:27.598698Z","steps":["trace[541762892] 'process raft request' (duration: 116.378506ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:09:03.750495Z","caller":"traceutil/trace.go:171","msg":"trace[3270617] transaction","detail":"{read_only:false; response_revision:5289; number_of_response:1; }","duration":"172.875944ms","start":"2026-05-19T02:09:03.577595Z","end":"2026-05-19T02:09:03.75047Z","steps":["trace[3270617] 'process raft request' (duration: 172.180161ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:09:03.750768Z","caller":"traceutil/trace.go:171","msg":"trace[1395799785] linearizableReadLoop","detail":"{readStateIndex:5486; appliedIndex:5483; }","duration":"115.84239ms","start":"2026-05-19T02:09:03.634899Z","end":"2026-05-19T02:09:03.750741Z","steps":["trace[1395799785] 'read index received' (duration: 114.833931ms)","trace[1395799785] 'applied index is now lower than readState.Index' (duration: 1.007259ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:09:03.750854Z","caller":"traceutil/trace.go:171","msg":"trace[783788913] transaction","detail":"{read_only:false; response_revision:5291; number_of_response:1; }","duration":"169.671114ms","start":"2026-05-19T02:09:03.581175Z","end":"2026-05-19T02:09:03.750846Z","steps":["trace[783788913] 'process raft request' (duration: 169.44888ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:09:03.75084Z","caller":"traceutil/trace.go:171","msg":"trace[203099371] transaction","detail":"{read_only:false; response_revision:5290; number_of_response:1; }","duration":"169.939959ms","start":"2026-05-19T02:09:03.580875Z","end":"2026-05-19T02:09:03.750815Z","steps":["trace[203099371] 'process raft request' (duration: 169.546921ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:09:03.751119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.207067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-19T02:09:03.751192Z","caller":"traceutil/trace.go:171","msg":"trace[784335034] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5291; }","duration":"116.320959ms","start":"2026-05-19T02:09:03.634851Z","end":"2026-05-19T02:09:03.751172Z","steps":["trace[784335034] 'agreement among raft nodes before linearized reading' (duration: 116.136756ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:09:22.476951Z","caller":"traceutil/trace.go:171","msg":"trace[2123465385] transaction","detail":"{read_only:false; response_revision:5422; number_of_response:1; }","duration":"160.919493ms","start":"2026-05-19T02:09:22.315995Z","end":"2026-05-19T02:09:22.476914Z","steps":["trace[2123465385] 'process raft request' (duration: 160.70489ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:09:52.344751Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2923} {"level":"info","ts":"2026-05-19T02:09:52.44393Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2923,"took":"97.755938ms","hash":4265586829,"current-db-size-bytes":52563968,"current-db-size":"53 MB","current-db-size-in-use-bytes":29122560,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-19T02:09:52.443982Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4265586829,"revision":2923,"compact-revision":-1} {"level":"info","ts":"2026-05-19T02:12:36.69192Z","caller":"traceutil/trace.go:171","msg":"trace[896411995] transaction","detail":"{read_only:false; response_revision:6771; number_of_response:1; }","duration":"127.243083ms","start":"2026-05-19T02:12:36.564655Z","end":"2026-05-19T02:12:36.691898Z","steps":["trace[896411995] 'process raft request' (duration: 76.5145ms)","trace[896411995] 'compare' (duration: 50.591191ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:12:36.692197Z","caller":"traceutil/trace.go:171","msg":"trace[611618057] transaction","detail":"{read_only:false; response_revision:6772; number_of_response:1; }","duration":"123.131212ms","start":"2026-05-19T02:12:36.569038Z","end":"2026-05-19T02:12:36.69217Z","steps":["trace[611618057] 'process raft request' (duration: 122.822437ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:12:37.07153Z","caller":"traceutil/trace.go:171","msg":"trace[1712379718] transaction","detail":"{read_only:false; response_revision:6777; number_of_response:1; }","duration":"126.380908ms","start":"2026-05-19T02:12:36.945076Z","end":"2026-05-19T02:12:37.071457Z","steps":["trace[1712379718] 'process raft request' (duration: 126.337597ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:12:37.0718Z","caller":"traceutil/trace.go:171","msg":"trace[128337799] transaction","detail":"{read_only:false; response_revision:6774; number_of_response:1; }","duration":"131.358311ms","start":"2026-05-19T02:12:36.940435Z","end":"2026-05-19T02:12:37.071793Z","steps":["trace[128337799] 'process raft request' (duration: 123.08269ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:12:37.071887Z","caller":"traceutil/trace.go:171","msg":"trace[743767551] transaction","detail":"{read_only:false; response_revision:6775; number_of_response:1; }","duration":"131.419002ms","start":"2026-05-19T02:12:36.940462Z","end":"2026-05-19T02:12:37.071881Z","steps":["trace[743767551] 'process raft request' (duration: 130.895704ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:12:37.071961Z","caller":"traceutil/trace.go:171","msg":"trace[1860914058] transaction","detail":"{read_only:false; response_revision:6776; number_of_response:1; }","duration":"131.477542ms","start":"2026-05-19T02:12:36.940478Z","end":"2026-05-19T02:12:37.071955Z","steps":["trace[1860914058] 'process raft request' (duration: 130.910874ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:14:52.363712Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5638} {"level":"info","ts":"2026-05-19T02:14:52.509891Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5638,"took":"144.734568ms","hash":1963833812,"current-db-size-bytes":52563968,"current-db-size":"53 MB","current-db-size-in-use-bytes":18202624,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-19T02:14:52.509979Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1963833812,"revision":5638,"compact-revision":2923} {"level":"info","ts":"2026-05-19T02:14:59.943007Z","caller":"traceutil/trace.go:171","msg":"trace[1863892506] linearizableReadLoop","detail":"{readStateIndex:7798; appliedIndex:7797; }","duration":"118.63345ms","start":"2026-05-19T02:14:59.824348Z","end":"2026-05-19T02:14:59.942982Z","steps":["trace[1863892506] 'read index received' (duration: 98.636796ms)","trace[1863892506] 'applied index is now lower than readState.Index' (duration: 19.995654ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:14:59.943131Z","caller":"traceutil/trace.go:171","msg":"trace[1777630702] transaction","detail":"{read_only:false; response_revision:7520; number_of_response:1; }","duration":"120.39482ms","start":"2026-05-19T02:14:59.822724Z","end":"2026-05-19T02:14:59.943119Z","steps":["trace[1777630702] 'process raft request' (duration: 100.299643ms)","trace[1777630702] 'compare' (duration: 19.83535ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T02:14:59.943559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.178555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/\" range_end:\"/registry/events/default0\" limit:500 ","response":"range_response_count:19 size:12563"} {"level":"info","ts":"2026-05-19T02:14:59.943618Z","caller":"traceutil/trace.go:171","msg":"trace[417646815] range","detail":"{range_begin:/registry/events/default/; range_end:/registry/events/default0; response_count:19; response_revision:7520; }","duration":"119.274258ms","start":"2026-05-19T02:14:59.824329Z","end":"2026-05-19T02:14:59.943603Z","steps":["trace[417646815] 'agreement among raft nodes before linearized reading' (duration: 118.933838ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:14:59.943782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.736838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/ingress-nginx/\" range_end:\"/registry/cronjobs/ingress-nginx0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T02:14:59.943893Z","caller":"traceutil/trace.go:171","msg":"trace[2047973739] range","detail":"{range_begin:/registry/cronjobs/ingress-nginx/; range_end:/registry/cronjobs/ingress-nginx0; response_count:0; response_revision:7520; }","duration":"115.882532ms","start":"2026-05-19T02:14:59.827989Z","end":"2026-05-19T02:14:59.943872Z","steps":["trace[2047973739] 'agreement among raft nodes before linearized reading' (duration: 115.600684ms)"],"step_count":1}