{"level":"warn","ts":"2026-05-29T05:50:27.403165Z","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-29T05:50:27.403267Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.113: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.113:2380","--initial-cluster=instance=https://199.204.45.113:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.113:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.113: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-29T05:50:27.403421Z","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-29T05:50:27.403438Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.113:2380"]} {"level":"info","ts":"2026-05-29T05:50:27.403467Z","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-29T05:50:27.404644Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"]} {"level":"info","ts":"2026-05-29T05:50:27.404766Z","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.113:2380"],"listen-peer-urls":["https://199.204.45.113:2380"],"advertise-client-urls":["https://199.204.45.113:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.113: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-29T05:50:27.411041Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.938474ms"} {"level":"info","ts":"2026-05-29T05:50:27.416226Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a31e123290fcf0df","cluster-id":"37661d6ee45ed9e8"} {"level":"info","ts":"2026-05-29T05:50:27.416316Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=()"} {"level":"info","ts":"2026-05-29T05:50:27.416344Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became follower at term 0"} {"level":"info","ts":"2026-05-29T05:50:27.416364Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a31e123290fcf0df [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-29T05:50:27.416382Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became follower at term 1"} {"level":"info","ts":"2026-05-29T05:50:27.416431Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=(11753852085873733855)"} {"level":"warn","ts":"2026-05-29T05:50:27.421862Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-29T05:50:27.423583Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-29T05:50:27.426325Z","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-29T05:50:27.429544Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a31e123290fcf0df","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-29T05:50:27.430113Z","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-29T05:50:27.430157Z","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-29T05:50:27.430167Z","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-29T05:50:27.430136Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a31e123290fcf0df","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-29T05:50:27.433321Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=(11753852085873733855)"} {"level":"info","ts":"2026-05-29T05:50:27.433961Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"37661d6ee45ed9e8","local-member-id":"a31e123290fcf0df","added-peer-id":"a31e123290fcf0df","added-peer-peer-urls":["https://199.204.45.113:2380"]} {"level":"info","ts":"2026-05-29T05:50:27.435239Z","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-29T05:50:27.435473Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a31e123290fcf0df","initial-advertise-peer-urls":["https://199.204.45.113:2380"],"listen-peer-urls":["https://199.204.45.113:2380"],"advertise-client-urls":["https://199.204.45.113:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-29T05:50:27.435501Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-29T05:50:27.435609Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.113:2380"} {"level":"info","ts":"2026-05-29T05:50:27.435618Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.113:2380"} {"level":"info","ts":"2026-05-29T05:50:27.817359Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df is starting a new election at term 1"} {"level":"info","ts":"2026-05-29T05:50:27.817409Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became pre-candidate at term 1"} {"level":"info","ts":"2026-05-29T05:50:27.817435Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df received MsgPreVoteResp from a31e123290fcf0df at term 1"} {"level":"info","ts":"2026-05-29T05:50:27.817449Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became candidate at term 2"} {"level":"info","ts":"2026-05-29T05:50:27.817459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df received MsgVoteResp from a31e123290fcf0df at term 2"} {"level":"info","ts":"2026-05-29T05:50:27.817469Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became leader at term 2"} {"level":"info","ts":"2026-05-29T05:50:27.817479Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a31e123290fcf0df elected leader a31e123290fcf0df at term 2"} {"level":"info","ts":"2026-05-29T05:50:27.818422Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T05:50:27.819101Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a31e123290fcf0df","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.113:2379]}","request-path":"/0/members/a31e123290fcf0df/attributes","cluster-id":"37661d6ee45ed9e8","publish-timeout":"7s"} {"level":"info","ts":"2026-05-29T05:50:27.819414Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-29T05:50:27.81944Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-29T05:50:27.819897Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"37661d6ee45ed9e8","local-member-id":"a31e123290fcf0df","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T05:50:27.82008Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-29T05:50:27.820104Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-29T05:50:27.820178Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T05:50:27.820246Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T05:50:27.823022Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.113:2379"} {"level":"info","ts":"2026-05-29T05:50:27.8236Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-29T05:50:29.446253Z","caller":"traceutil/trace.go:171","msg":"trace[1163174610] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"249.91359ms","start":"2026-05-29T05:50:29.196313Z","end":"2026-05-29T05:50:29.446227Z","steps":["trace[1163174610] 'process raft request' (duration: 249.729636ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:50:29.451978Z","caller":"traceutil/trace.go:171","msg":"trace[1268502180] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"256.090458ms","start":"2026-05-29T05:50:29.195873Z","end":"2026-05-29T05:50:29.451963Z","steps":["trace[1268502180] 'process raft request' (duration: 255.132719ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:50:29.452223Z","caller":"traceutil/trace.go:171","msg":"trace[1674952804] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"241.848744ms","start":"2026-05-29T05:50:29.210275Z","end":"2026-05-29T05:50:29.452124Z","steps":["trace[1674952804] 'read index received' (duration: 235.9005ms)","trace[1674952804] 'applied index is now lower than readState.Index' (duration: 5.947184ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:50:29.452418Z","caller":"traceutil/trace.go:171","msg":"trace[930776550] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"179.687487ms","start":"2026-05-29T05:50:29.272712Z","end":"2026-05-29T05:50:29.452399Z","steps":["trace[930776550] 'process raft request' (duration: 179.256259ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:50:29.452414Z","caller":"traceutil/trace.go:171","msg":"trace[1895561718] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"180.108806ms","start":"2026-05-29T05:50:29.272261Z","end":"2026-05-29T05:50:29.45237Z","steps":["trace[1895561718] 'process raft request' (duration: 179.556856ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:50:29.452359Z","caller":"traceutil/trace.go:171","msg":"trace[397157542] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"179.582086ms","start":"2026-05-29T05:50:29.272683Z","end":"2026-05-29T05:50:29.452265Z","steps":["trace[397157542] 'process raft request' (duration: 179.25825ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:29.452659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.338433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T05:50:29.452925Z","caller":"traceutil/trace.go:171","msg":"trace[724777595] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"242.67002ms","start":"2026-05-29T05:50:29.21024Z","end":"2026-05-29T05:50:29.45291Z","steps":["trace[724777595] 'agreement among raft nodes before linearized reading' (duration: 242.258462ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:50:29.453073Z","caller":"traceutil/trace.go:171","msg":"trace[82689963] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"170.253516ms","start":"2026-05-29T05:50:29.282808Z","end":"2026-05-29T05:50:29.453062Z","steps":["trace[82689963] 'process raft request' (duration: 169.281408ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:50:29.453078Z","caller":"traceutil/trace.go:171","msg":"trace[51034527] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"180.354401ms","start":"2026-05-29T05:50:29.272675Z","end":"2026-05-29T05:50:29.45303Z","steps":["trace[51034527] 'process raft request' (duration: 179.230929ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:50:29.453182Z","caller":"traceutil/trace.go:171","msg":"trace[577077271] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"180.33581ms","start":"2026-05-29T05:50:29.272746Z","end":"2026-05-29T05:50:29.453082Z","steps":["trace[577077271] 'process raft request' (duration: 179.258299ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:50:29.453556Z","caller":"traceutil/trace.go:171","msg":"trace[649147434] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"180.931651ms","start":"2026-05-29T05:50:29.27261Z","end":"2026-05-29T05:50:29.453542Z","steps":["trace[649147434] 'process raft request' (duration: 179.252789ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:50:29.453653Z","caller":"traceutil/trace.go:171","msg":"trace[19239135] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"170.99178ms","start":"2026-05-29T05:50:29.282586Z","end":"2026-05-29T05:50:29.453578Z","steps":["trace[19239135] 'process raft request' (duration: 169.464621ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:29.453765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.038003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T05:50:29.453813Z","caller":"traceutil/trace.go:171","msg":"trace[877971554] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"181.083414ms","start":"2026-05-29T05:50:29.27272Z","end":"2026-05-29T05:50:29.453803Z","steps":["trace[877971554] 'agreement among raft nodes before linearized reading' (duration: 181.027623ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:29.454027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.290769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T05:50:29.454066Z","caller":"traceutil/trace.go:171","msg":"trace[1929562494] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"206.358491ms","start":"2026-05-29T05:50:29.247698Z","end":"2026-05-29T05:50:29.454057Z","steps":["trace[1929562494] 'agreement among raft nodes before linearized reading' (duration: 206.30298ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:29.454199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.971612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T05:50:29.454233Z","caller":"traceutil/trace.go:171","msg":"trace[1122860242] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"207.038253ms","start":"2026-05-29T05:50:29.247187Z","end":"2026-05-29T05:50:29.454225Z","steps":["trace[1122860242] 'agreement among raft nodes before linearized reading' (duration: 206.985382ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:29.454039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.562522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.113\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T05:50:29.454466Z","caller":"traceutil/trace.go:171","msg":"trace[190494099] range","detail":"{range_begin:/registry/masterleases/199.204.45.113; range_end:; response_count:0; response_revision:11; }","duration":"185.071372ms","start":"2026-05-29T05:50:29.26938Z","end":"2026-05-29T05:50:29.454451Z","steps":["trace[190494099] 'agreement among raft nodes before linearized reading' (duration: 184.47214ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:29.453697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.991393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-29T05:50:29.454655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.983301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T05:50:29.454676Z","caller":"traceutil/trace.go:171","msg":"trace[27794014] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"207.904561ms","start":"2026-05-29T05:50:29.246694Z","end":"2026-05-29T05:50:29.454598Z","steps":["trace[27794014] 'agreement among raft nodes before linearized reading' (duration: 206.976333ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:50:29.454713Z","caller":"traceutil/trace.go:171","msg":"trace[138234034] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"182.091734ms","start":"2026-05-29T05:50:29.272605Z","end":"2026-05-29T05:50:29.454697Z","steps":["trace[138234034] 'agreement among raft nodes before linearized reading' (duration: 181.978772ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:29.453732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.552152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T05:50:29.454838Z","caller":"traceutil/trace.go:171","msg":"trace[809547857] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"131.654113ms","start":"2026-05-29T05:50:29.323174Z","end":"2026-05-29T05:50:29.454828Z","steps":["trace[809547857] 'agreement among raft nodes before linearized reading' (duration: 130.542812ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:31.171472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.528263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:113"} {"level":"info","ts":"2026-05-29T05:50:31.171601Z","caller":"traceutil/trace.go:171","msg":"trace[490187361] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:192; }","duration":"206.714117ms","start":"2026-05-29T05:50:30.964858Z","end":"2026-05-29T05:50:31.171572Z","steps":["trace[490187361] 'range keys from in-memory index tree' (duration: 206.398411ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:50:31.437549Z","caller":"traceutil/trace.go:171","msg":"trace[257100330] linearizableReadLoop","detail":"{readStateIndex:202; appliedIndex:201; }","duration":"204.856761ms","start":"2026-05-29T05:50:31.232647Z","end":"2026-05-29T05:50:31.437504Z","steps":["trace[257100330] 'read index received' (duration: 197.799975ms)","trace[257100330] 'applied index is now lower than readState.Index' (duration: 7.055096ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:50:31.437659Z","caller":"traceutil/trace.go:171","msg":"trace[1097528377] transaction","detail":"{read_only:false; response_revision:197; number_of_response:1; }","duration":"212.407115ms","start":"2026-05-29T05:50:31.225196Z","end":"2026-05-29T05:50:31.437603Z","steps":["trace[1097528377] 'process raft request' (duration: 205.310349ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:31.437807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.059102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T05:50:31.438062Z","caller":"traceutil/trace.go:171","msg":"trace[1082745147] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:0; response_revision:197; }","duration":"208.367228ms","start":"2026-05-29T05:50:31.229676Z","end":"2026-05-29T05:50:31.438043Z","steps":["trace[1082745147] 'agreement among raft nodes before linearized reading' (duration: 207.97935ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:37.834868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.783974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-29T05:50:37.834975Z","caller":"traceutil/trace.go:171","msg":"trace[768452913] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:291; }","duration":"277.926446ms","start":"2026-05-29T05:50:37.55703Z","end":"2026-05-29T05:50:37.834957Z","steps":["trace[768452913] 'range keys from in-memory index tree' (duration: 277.61522ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:37.834999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.387744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6965"} {"level":"warn","ts":"2026-05-29T05:50:37.835044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.070303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-29T05:50:37.835141Z","caller":"traceutil/trace.go:171","msg":"trace[884737891] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:291; }","duration":"596.591038ms","start":"2026-05-29T05:50:37.23852Z","end":"2026-05-29T05:50:37.835111Z","steps":["trace[884737891] 'range keys from in-memory index tree' (duration: 596.250832ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:50:37.835165Z","caller":"traceutil/trace.go:171","msg":"trace[858299025] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:291; }","duration":"313.251317ms","start":"2026-05-29T05:50:37.521887Z","end":"2026-05-29T05:50:37.835138Z","steps":["trace[858299025] 'range keys from in-memory index tree' (duration: 312.974171ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:37.835199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.615453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-29T05:50:37.835234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.178554013s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-29T05:50:37.835262Z","caller":"traceutil/trace.go:171","msg":"trace[467262589] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:291; }","duration":"300.687154ms","start":"2026-05-29T05:50:37.53455Z","end":"2026-05-29T05:50:37.835237Z","steps":["trace[467262589] 'range keys from in-memory index tree' (duration: 300.48341ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:37.835207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:50:37.238489Z","time spent":"596.70365ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":6988,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"warn","ts":"2026-05-29T05:50:37.835231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:50:37.521864Z","time spent":"313.353319ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-29T05:50:37.835289Z","caller":"traceutil/trace.go:171","msg":"trace[599134522] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:291; }","duration":"1.178654506s","start":"2026-05-29T05:50:36.656622Z","end":"2026-05-29T05:50:37.835276Z","steps":["trace[599134522] 'range keys from in-memory index tree' (duration: 1.178414471s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:37.835304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:50:37.53454Z","time spent":"300.756176ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-29T05:50:37.835324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:50:36.656596Z","time spent":"1.178720758s","remote":"127.0.0.1:34336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-29T05:50:38.444315Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356765702592289460,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-29T05:50:38.476411Z","caller":"traceutil/trace.go:171","msg":"trace[115728090] transaction","detail":"{read_only:false; response_revision:292; number_of_response:1; }","duration":"636.600698ms","start":"2026-05-29T05:50:37.839782Z","end":"2026-05-29T05:50:38.476382Z","steps":["trace[115728090] 'process raft request' (duration: 636.322983ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:50:38.476851Z","caller":"traceutil/trace.go:171","msg":"trace[411927700] transaction","detail":"{read_only:false; response_revision:293; number_of_response:1; }","duration":"636.545497ms","start":"2026-05-29T05:50:37.83979Z","end":"2026-05-29T05:50:38.476335Z","steps":["trace[411927700] 'process raft request' (duration: 636.456635ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:38.477417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:50:37.839759Z","time spent":"637.006797ms","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":219,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T05:50:38.477955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:50:37.839764Z","time spent":"637.18187ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T05:50:39.76422Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.288224337s","expected-duration":"1s"} {"level":"info","ts":"2026-05-29T05:50:39.764798Z","caller":"traceutil/trace.go:171","msg":"trace[587381140] transaction","detail":"{read_only:false; response_revision:294; number_of_response:1; }","duration":"1.924745025s","start":"2026-05-29T05:50:37.83998Z","end":"2026-05-29T05:50:39.764725Z","steps":["trace[587381140] 'process raft request' (duration: 1.924440849s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:39.764917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.821731543s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-29T05:50:39.764987Z","caller":"traceutil/trace.go:171","msg":"trace[573918879] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:296; }","duration":"1.821869807s","start":"2026-05-29T05:50:37.943105Z","end":"2026-05-29T05:50:39.764975Z","steps":["trace[573918879] 'agreement among raft nodes before linearized reading' (duration: 1.821737214s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:39.76502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:50:37.943072Z","time spent":"1.821937928s","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-29T05:50:39.765177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:50:37.839971Z","time spent":"1.924888237s","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T05:50:39.764791Z","caller":"traceutil/trace.go:171","msg":"trace[695219937] linearizableReadLoop","detail":"{readStateIndex:305; appliedIndex:300; }","duration":"1.821583621s","start":"2026-05-29T05:50:37.943188Z","end":"2026-05-29T05:50:39.764772Z","steps":["trace[695219937] 'read index received' (duration: 532.909795ms)","trace[695219937] 'applied index is now lower than readState.Index' (duration: 1.288672836s)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:50:39.765402Z","caller":"traceutil/trace.go:171","msg":"trace[1331228053] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"1.923013833s","start":"2026-05-29T05:50:37.84236Z","end":"2026-05-29T05:50:39.765374Z","steps":["trace[1331228053] 'process raft request' (duration: 1.922185477s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:39.765516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:50:37.842304Z","time spent":"1.923160356s","remote":"127.0.0.1:34498","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-29T05:50:39.76557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.284365934s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T05:50:39.765689Z","caller":"traceutil/trace.go:171","msg":"trace[1509828116] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:0; response_revision:296; }","duration":"1.284529976s","start":"2026-05-29T05:50:38.481113Z","end":"2026-05-29T05:50:39.765643Z","steps":["trace[1509828116] 'agreement among raft nodes before linearized reading' (duration: 1.284338432s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:39.765747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:50:38.481092Z","time spent":"1.284645319s","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"info","ts":"2026-05-29T05:50:39.766132Z","caller":"traceutil/trace.go:171","msg":"trace[1660457373] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"1.921275918s","start":"2026-05-29T05:50:37.84475Z","end":"2026-05-29T05:50:39.766026Z","steps":["trace[1660457373] 'process raft request' (duration: 1.919886281s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:39.766509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:50:37.844721Z","time spent":"1.921680357s","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6950,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T05:50:39.873578Z","caller":"traceutil/trace.go:171","msg":"trace[1988139255] linearizableReadLoop","detail":"{readStateIndex:306; appliedIndex:305; }","duration":"103.94071ms","start":"2026-05-29T05:50:39.76961Z","end":"2026-05-29T05:50:39.873551Z","steps":["trace[1988139255] 'read index received' (duration: 102.640705ms)","trace[1988139255] 'applied index is now lower than readState.Index' (duration: 1.298905ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:50:39.873699Z","caller":"traceutil/trace.go:171","msg":"trace[617614634] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"104.213144ms","start":"2026-05-29T05:50:39.769476Z","end":"2026-05-29T05:50:39.873689Z","steps":["trace[617614634] 'process raft request' (duration: 102.870308ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:39.87387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.087705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6965"} {"level":"info","ts":"2026-05-29T05:50:39.873952Z","caller":"traceutil/trace.go:171","msg":"trace[1134677285] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:297; }","duration":"101.209487ms","start":"2026-05-29T05:50:39.772724Z","end":"2026-05-29T05:50:39.873933Z","steps":["trace[1134677285] 'agreement among raft nodes before linearized reading' (duration: 101.074974ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:39.87395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.332197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-29T05:50:39.874003Z","caller":"traceutil/trace.go:171","msg":"trace[764515104] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:297; }","duration":"104.936489ms","start":"2026-05-29T05:50:39.769052Z","end":"2026-05-29T05:50:39.873989Z","steps":["trace[764515104] 'agreement among raft nodes before linearized reading' (duration: 104.842627ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:50:56.130476Z","caller":"traceutil/trace.go:171","msg":"trace[413269064] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"259.728896ms","start":"2026-05-29T05:50:55.870715Z","end":"2026-05-29T05:50:56.130444Z","steps":["trace[413269064] 'process raft request' (duration: 259.579454ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:56.32714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.345157ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T05:50:56.327305Z","caller":"traceutil/trace.go:171","msg":"trace[1384032160] linearizableReadLoop","detail":"{readStateIndex:440; appliedIndex:438; }","duration":"377.529704ms","start":"2026-05-29T05:50:55.949754Z","end":"2026-05-29T05:50:56.327284Z","steps":["trace[1384032160] 'read index received' (duration: 180.546114ms)","trace[1384032160] 'applied index is now lower than readState.Index' (duration: 196.98189ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:50:56.327359Z","caller":"traceutil/trace.go:171","msg":"trace[926792268] transaction","detail":"{read_only:false; response_revision:426; number_of_response:1; }","duration":"454.217419ms","start":"2026-05-29T05:50:55.873101Z","end":"2026-05-29T05:50:56.327318Z","steps":["trace[926792268] 'process raft request' (duration: 310.430683ms)","trace[926792268] 'compare' (duration: 143.205885ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T05:50:56.327413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.677136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-29T05:50:56.327464Z","caller":"traceutil/trace.go:171","msg":"trace[1137589263] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:426; }","duration":"377.769108ms","start":"2026-05-29T05:50:55.949682Z","end":"2026-05-29T05:50:56.327451Z","steps":["trace[1137589263] 'agreement among raft nodes before linearized reading' (duration: 377.669786ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:56.327517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:50:55.949661Z","time spent":"377.844549ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-29T05:50:56.327526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:50:55.873094Z","time spent":"454.346402ms","remote":"127.0.0.1:34498","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-29T05:51:06.672448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.676514ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-29T05:51:06.672536Z","caller":"traceutil/trace.go:171","msg":"trace[871881494] linearizableReadLoop","detail":"{readStateIndex:464; appliedIndex:463; }","duration":"503.621729ms","start":"2026-05-29T05:51:06.168901Z","end":"2026-05-29T05:51:06.672523Z","steps":["trace[871881494] 'read index received' (duration: 175.789512ms)","trace[871881494] 'applied index is now lower than readState.Index' (duration: 327.831167ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T05:51:06.672645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.202793ms","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-29T05:51:06.67267Z","caller":"traceutil/trace.go:171","msg":"trace[6434151] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:447; }","duration":"304.269213ms","start":"2026-05-29T05:51:06.368392Z","end":"2026-05-29T05:51:06.672661Z","steps":["trace[6434151] 'agreement among raft nodes before linearized reading' (duration: 304.203322ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:06.672659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.752161ms","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-29T05:51:06.672699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:51:06.368368Z","time spent":"304.325515ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-29T05:51:06.67273Z","caller":"traceutil/trace.go:171","msg":"trace[1859635971] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:447; }","duration":"503.863453ms","start":"2026-05-29T05:51:06.16885Z","end":"2026-05-29T05:51:06.672714Z","steps":["trace[1859635971] 'agreement among raft nodes before linearized reading' (duration: 503.715471ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:06.672724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.612195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T05:51:06.672812Z","caller":"traceutil/trace.go:171","msg":"trace[866029977] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:447; }","duration":"180.758009ms","start":"2026-05-29T05:51:06.492032Z","end":"2026-05-29T05:51:06.67279Z","steps":["trace[866029977] 'agreement among raft nodes before linearized reading' (duration: 180.607215ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:06.672763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:51:06.168827Z","time spent":"503.930225ms","remote":"127.0.0.1:34498","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-29T05:51:06.672869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.312741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-29T05:51:06.672946Z","caller":"traceutil/trace.go:171","msg":"trace[1887561838] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:447; }","duration":"296.427823ms","start":"2026-05-29T05:51:06.376506Z","end":"2026-05-29T05:51:06.672933Z","steps":["trace[1887561838] 'agreement among raft nodes before linearized reading' (duration: 296.24274ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:51:10.137448Z","caller":"traceutil/trace.go:171","msg":"trace[746457592] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"289.433028ms","start":"2026-05-29T05:51:09.847989Z","end":"2026-05-29T05:51:10.137422Z","steps":["trace[746457592] 'process raft request' (duration: 289.245645ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:51:10.328747Z","caller":"traceutil/trace.go:171","msg":"trace[478325905] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"466.957764ms","start":"2026-05-29T05:51:09.86177Z","end":"2026-05-29T05:51:10.328727Z","steps":["trace[478325905] 'process raft request' (duration: 466.618107ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:10.328882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:51:09.861761Z","time spent":"467.036376ms","remote":"127.0.0.1:34262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T05:51:10.328867Z","caller":"traceutil/trace.go:171","msg":"trace[1013732932] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"462.447038ms","start":"2026-05-29T05:51:09.866379Z","end":"2026-05-29T05:51:10.328826Z","steps":["trace[1013732932] 'process raft request' (duration: 462.153213ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:51:10.329012Z","caller":"traceutil/trace.go:171","msg":"trace[1085518841] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"475.187983ms","start":"2026-05-29T05:51:09.853816Z","end":"2026-05-29T05:51:10.329004Z","steps":["trace[1085518841] 'process raft request' (duration: 474.291735ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:10.329028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:51:09.866376Z","time spent":"462.580151ms","remote":"127.0.0.1:34262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T05:51:10.329045Z","caller":"traceutil/trace.go:171","msg":"trace[1630086136] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"462.481257ms","start":"2026-05-29T05:51:09.866555Z","end":"2026-05-29T05:51:10.329037Z","steps":["trace[1630086136] 'process raft request' (duration: 462.021759ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:10.329051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:51:09.853796Z","time spent":"475.239764ms","remote":"127.0.0.1:34262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T05:51:10.329115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:51:09.866549Z","time spent":"462.528588ms","remote":"127.0.0.1:34262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T05:51:10.329129Z","caller":"traceutil/trace.go:171","msg":"trace[714572009] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"467.613767ms","start":"2026-05-29T05:51:09.861509Z","end":"2026-05-29T05:51:10.329123Z","steps":["trace[714572009] 'process raft request' (duration: 466.73686ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:51:10.329153Z","caller":"traceutil/trace.go:171","msg":"trace[1073683129] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"462.818885ms","start":"2026-05-29T05:51:09.866324Z","end":"2026-05-29T05:51:10.329143Z","steps":["trace[1073683129] 'process raft request' (duration: 462.166793ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:10.329193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:51:09.86149Z","time spent":"467.685738ms","remote":"127.0.0.1:34262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T05:51:10.329195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:51:09.866307Z","time spent":"462.868326ms","remote":"127.0.0.1:34262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T05:51:10.329265Z","caller":"traceutil/trace.go:171","msg":"trace[1809469020] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"467.686317ms","start":"2026-05-29T05:51:09.861571Z","end":"2026-05-29T05:51:10.329257Z","steps":["trace[1809469020] 'process raft request' (duration: 466.714788ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:51:10.329291Z","caller":"traceutil/trace.go:171","msg":"trace[321285842] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"443.626585ms","start":"2026-05-29T05:51:09.885655Z","end":"2026-05-29T05:51:10.329281Z","steps":["trace[321285842] 'process raft request' (duration: 442.974193ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:51:10.329354Z","caller":"traceutil/trace.go:171","msg":"trace[936857514] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"434.03821ms","start":"2026-05-29T05:51:09.895309Z","end":"2026-05-29T05:51:10.329348Z","steps":["trace[936857514] 'process raft request' (duration: 433.436549ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:10.329385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:51:09.895291Z","time spent":"434.082371ms","remote":"127.0.0.1:34262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T05:51:10.329432Z","caller":"traceutil/trace.go:171","msg":"trace[1611697214] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"416.115745ms","start":"2026-05-29T05:51:09.913289Z","end":"2026-05-29T05:51:10.329405Z","steps":["trace[1611697214] 'process raft request' (duration: 415.509814ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:10.329513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:51:09.913271Z","time spent":"416.208357ms","remote":"127.0.0.1:34262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T05:51:10.329309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:51:09.861566Z","time spent":"467.717869ms","remote":"127.0.0.1:34262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T05:51:10.328966Z","caller":"traceutil/trace.go:171","msg":"trace[621601154] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"289.825337ms","start":"2026-05-29T05:51:10.039122Z","end":"2026-05-29T05:51:10.328947Z","steps":["trace[621601154] 'process raft request' (duration: 289.763505ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:10.329466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:51:09.885641Z","time spent":"443.725997ms","remote":"127.0.0.1:34262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T05:51:10.33387Z","caller":"traceutil/trace.go:171","msg":"trace[263115749] transaction","detail":"{read_only:false; number_of_response:1; response_revision:503; }","duration":"184.738984ms","start":"2026-05-29T05:51:10.149116Z","end":"2026-05-29T05:51:10.333855Z","steps":["trace[263115749] 'process raft request' (duration: 184.708904ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:51:10.333935Z","caller":"traceutil/trace.go:171","msg":"trace[448585022] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"187.970366ms","start":"2026-05-29T05:51:10.14593Z","end":"2026-05-29T05:51:10.333901Z","steps":["trace[448585022] 'process raft request' (duration: 187.790103ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:51:10.334236Z","caller":"traceutil/trace.go:171","msg":"trace[71188424] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"185.402667ms","start":"2026-05-29T05:51:10.148824Z","end":"2026-05-29T05:51:10.334227Z","steps":["trace[71188424] 'process raft request' (duration: 184.956558ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:51:16.789641Z","caller":"traceutil/trace.go:171","msg":"trace[415127402] linearizableReadLoop","detail":"{readStateIndex:619; appliedIndex:618; }","duration":"297.034234ms","start":"2026-05-29T05:51:16.492573Z","end":"2026-05-29T05:51:16.789608Z","steps":["trace[415127402] 'read index received' (duration: 295.867092ms)","trace[415127402] 'applied index is now lower than readState.Index' (duration: 1.165862ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:51:16.789824Z","caller":"traceutil/trace.go:171","msg":"trace[1182541449] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"483.165745ms","start":"2026-05-29T05:51:16.306644Z","end":"2026-05-29T05:51:16.78981Z","steps":["trace[1182541449] 'process raft request' (duration: 482.174327ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:16.790005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:51:16.306611Z","time spent":"483.260737ms","remote":"127.0.0.1:34320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036277,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T05:51:16.790488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.925252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T05:51:16.790535Z","caller":"traceutil/trace.go:171","msg":"trace[1092597088] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:598; }","duration":"298.020103ms","start":"2026-05-29T05:51:16.492503Z","end":"2026-05-29T05:51:16.790523Z","steps":["trace[1092597088] 'agreement among raft nodes before linearized reading' (duration: 297.951272ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:51:16.899408Z","caller":"traceutil/trace.go:171","msg":"trace[650455643] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"103.615473ms","start":"2026-05-29T05:51:16.795727Z","end":"2026-05-29T05:51:16.899343Z","steps":["trace[650455643] 'process raft request' (duration: 103.355148ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:51:16.899543Z","caller":"traceutil/trace.go:171","msg":"trace[382936058] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"103.563962ms","start":"2026-05-29T05:51:16.795949Z","end":"2026-05-29T05:51:16.899513Z","steps":["trace[382936058] 'process raft request' (duration: 103.171324ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:51:16.899545Z","caller":"traceutil/trace.go:171","msg":"trace[1536591910] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"104.076383ms","start":"2026-05-29T05:51:16.795441Z","end":"2026-05-29T05:51:16.899517Z","steps":["trace[1536591910] 'process raft request' (duration: 103.531912ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:51:17.524816Z","caller":"traceutil/trace.go:171","msg":"trace[1257708670] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"201.194ms","start":"2026-05-29T05:51:17.32356Z","end":"2026-05-29T05:51:17.524754Z","steps":["trace[1257708670] 'process raft request' (duration: 200.16361ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:18.991782Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356765702592290084,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T05:51:19.158515Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.490013175s","expected-duration":"1s"} {"level":"info","ts":"2026-05-29T05:51:19.158883Z","caller":"traceutil/trace.go:171","msg":"trace[1660747537] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:626; }","duration":"667.658125ms","start":"2026-05-29T05:51:18.491198Z","end":"2026-05-29T05:51:19.158856Z","steps":["trace[1660747537] 'read index received' (duration: 667.452222ms)","trace[1660747537] 'applied index is now lower than readState.Index' (duration: 204.883µs)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:51:19.158982Z","caller":"traceutil/trace.go:171","msg":"trace[1525394511] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"1.490635136s","start":"2026-05-29T05:51:17.668331Z","end":"2026-05-29T05:51:19.158967Z","steps":["trace[1525394511] 'process raft request' (duration: 1.490395532s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:19.159078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:51:17.668306Z","time spent":"1.490710417s","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T05:51:19.159211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"668.013963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T05:51:19.159248Z","caller":"traceutil/trace.go:171","msg":"trace[1786738058] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:606; }","duration":"668.093074ms","start":"2026-05-29T05:51:18.491146Z","end":"2026-05-29T05:51:19.159239Z","steps":["trace[1786738058] 'agreement among raft nodes before linearized reading' (duration: 668.006083ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:19.159277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:51:18.491127Z","time spent":"668.144775ms","remote":"127.0.0.1:34232","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-29T05:51:19.159608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.495416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-29T05:51:19.159654Z","caller":"traceutil/trace.go:171","msg":"trace[1817666257] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:606; }","duration":"254.587328ms","start":"2026-05-29T05:51:18.905057Z","end":"2026-05-29T05:51:19.159644Z","steps":["trace[1817666257] 'agreement among raft nodes before linearized reading' (duration: 254.436215ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:19.159668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.662354ms","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-29T05:51:19.159672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.606319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-29T05:51:19.159747Z","caller":"traceutil/trace.go:171","msg":"trace[1915424575] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:606; }","duration":"261.784866ms","start":"2026-05-29T05:51:18.897939Z","end":"2026-05-29T05:51:19.159724Z","steps":["trace[1915424575] 'agreement among raft nodes before linearized reading' (duration: 261.407499ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:51:19.159762Z","caller":"traceutil/trace.go:171","msg":"trace[413314977] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:606; }","duration":"254.750011ms","start":"2026-05-29T05:51:18.904989Z","end":"2026-05-29T05:51:19.159739Z","steps":["trace[413314977] 'agreement among raft nodes before linearized reading' (duration: 254.400034ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:19.159889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.982495ms","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-29T05:51:19.160009Z","caller":"traceutil/trace.go:171","msg":"trace[746760080] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:606; }","duration":"255.138508ms","start":"2026-05-29T05:51:18.904849Z","end":"2026-05-29T05:51:19.159987Z","steps":["trace[746760080] 'agreement among raft nodes before linearized reading' (duration: 254.66842ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:19.657188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.945221ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-29T05:51:19.6576Z","caller":"traceutil/trace.go:171","msg":"trace[1459745664] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"491.68234ms","start":"2026-05-29T05:51:19.165896Z","end":"2026-05-29T05:51:19.657578Z","steps":["trace[1459745664] 'process raft request' (duration: 491.505955ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:51:19.657667Z","caller":"traceutil/trace.go:171","msg":"trace[1726513393] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"491.840623ms","start":"2026-05-29T05:51:19.165798Z","end":"2026-05-29T05:51:19.657638Z","steps":["trace[1726513393] 'process raft request' (duration: 491.536296ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:19.657722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:51:19.165889Z","time spent":"491.764131ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T05:51:19.657709Z","caller":"traceutil/trace.go:171","msg":"trace[213624306] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"491.70685ms","start":"2026-05-29T05:51:19.165962Z","end":"2026-05-29T05:51:19.657669Z","steps":["trace[213624306] 'process raft request' (duration: 491.475905ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:51:19.657708Z","caller":"traceutil/trace.go:171","msg":"trace[923969888] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"491.463095ms","start":"2026-05-29T05:51:19.166229Z","end":"2026-05-29T05:51:19.657692Z","steps":["trace[923969888] 'process raft request' (duration: 491.27518ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:19.657843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:51:19.165776Z","time spent":"491.977225ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T05:51:19.657877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:51:19.165956Z","time spent":"491.829293ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T05:51:19.657946Z","caller":"traceutil/trace.go:171","msg":"trace[95722633] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"490.723981ms","start":"2026-05-29T05:51:19.167212Z","end":"2026-05-29T05:51:19.657936Z","steps":["trace[95722633] 'process raft request' (duration: 490.385755ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:51:19.657976Z","caller":"traceutil/trace.go:171","msg":"trace[1453137787] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:627; }","duration":"166.32059ms","start":"2026-05-29T05:51:19.491617Z","end":"2026-05-29T05:51:19.657938Z","steps":["trace[1453137787] 'read index received' (duration: 164.022166ms)","trace[1453137787] 'applied index is now lower than readState.Index' (duration: 2.297424ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T05:51:19.658012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:51:19.167195Z","time spent":"490.774482ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T05:51:19.658075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.449343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T05:51:19.658102Z","caller":"traceutil/trace.go:171","msg":"trace[2128224479] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"490.471435ms","start":"2026-05-29T05:51:19.167621Z","end":"2026-05-29T05:51:19.658092Z","steps":["trace[2128224479] 'process raft request' (duration: 490.228751ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:51:19.658107Z","caller":"traceutil/trace.go:171","msg":"trace[167652007] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:614; }","duration":"166.525364ms","start":"2026-05-29T05:51:19.491571Z","end":"2026-05-29T05:51:19.658096Z","steps":["trace[167652007] 'agreement among raft nodes before linearized reading' (duration: 166.441993ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:19.658158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:51:19.16761Z","time spent":"490.517156ms","remote":"127.0.0.1:34482","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T05:51:19.657732Z","caller":"traceutil/trace.go:171","msg":"trace[436040109] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"491.661849ms","start":"2026-05-29T05:51:19.166009Z","end":"2026-05-29T05:51:19.657671Z","steps":["trace[436040109] 'process raft request' (duration: 491.464035ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:19.658393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:51:19.166003Z","time spent":"492.349592ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T05:51:19.657447Z","caller":"traceutil/trace.go:171","msg":"trace[1220883797] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"492.28605ms","start":"2026-05-29T05:51:19.165123Z","end":"2026-05-29T05:51:19.657409Z","steps":["trace[1220883797] 'process raft request' (duration: 323.010703ms)","trace[1220883797] 'compare' (duration: 168.797308ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T05:51:19.657863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:51:19.166197Z","time spent":"491.630448ms","remote":"127.0.0.1:34290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T05:51:19.658974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:51:19.165102Z","time spent":"493.746798ms","remote":"127.0.0.1:34290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T05:51:21.04391Z","caller":"traceutil/trace.go:171","msg":"trace[1279833228] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"104.424787ms","start":"2026-05-29T05:51:20.939456Z","end":"2026-05-29T05:51:21.043881Z","steps":["trace[1279833228] 'process raft request' (duration: 101.221045ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:51:21.258212Z","caller":"traceutil/trace.go:171","msg":"trace[20980659] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"159.059853ms","start":"2026-05-29T05:51:21.099117Z","end":"2026-05-29T05:51:21.258177Z","steps":["trace[20980659] 'process raft request' (duration: 140.165067ms)","trace[20980659] 'compare' (duration: 18.338124ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:51:21.767641Z","caller":"traceutil/trace.go:171","msg":"trace[753489198] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:661; }","duration":"275.40202ms","start":"2026-05-29T05:51:21.492201Z","end":"2026-05-29T05:51:21.767603Z","steps":["trace[753489198] 'read index received' (duration: 275.130094ms)","trace[753489198] 'applied index is now lower than readState.Index' (duration: 270.276µs)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:51:21.767754Z","caller":"traceutil/trace.go:171","msg":"trace[847398307] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"304.463462ms","start":"2026-05-29T05:51:21.463254Z","end":"2026-05-29T05:51:21.767717Z","steps":["trace[847398307] 'process raft request' (duration: 304.124115ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:21.768017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:51:21.46323Z","time spent":"304.696136ms","remote":"127.0.0.1:34262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4234,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T05:51:21.768064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.833948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T05:51:21.768136Z","caller":"traceutil/trace.go:171","msg":"trace[530550427] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:640; }","duration":"275.978301ms","start":"2026-05-29T05:51:21.492142Z","end":"2026-05-29T05:51:21.76812Z","steps":["trace[530550427] 'agreement among raft nodes before linearized reading' (duration: 275.663675ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:21.772014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.648159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-29T05:51:21.772178Z","caller":"traceutil/trace.go:171","msg":"trace[73968520] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:641; }","duration":"108.823942ms","start":"2026-05-29T05:51:21.663298Z","end":"2026-05-29T05:51:21.772122Z","steps":["trace[73968520] 'agreement among raft nodes before linearized reading' (duration: 108.421254ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:51:21.772779Z","caller":"traceutil/trace.go:171","msg":"trace[124615522] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"108.316992ms","start":"2026-05-29T05:51:21.664404Z","end":"2026-05-29T05:51:21.772721Z","steps":["trace[124615522] 'process raft request' (duration: 107.029827ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:21.773217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.355344ms","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-29T05:51:21.773339Z","caller":"traceutil/trace.go:171","msg":"trace[686023080] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:641; }","duration":"107.451706ms","start":"2026-05-29T05:51:21.66583Z","end":"2026-05-29T05:51:21.773282Z","steps":["trace[686023080] 'agreement among raft nodes before linearized reading' (duration: 107.248301ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:21.773661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.432705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-29T05:51:21.773781Z","caller":"traceutil/trace.go:171","msg":"trace[915750209] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:641; }","duration":"108.596948ms","start":"2026-05-29T05:51:21.665163Z","end":"2026-05-29T05:51:21.77376Z","steps":["trace[915750209] 'agreement among raft nodes before linearized reading' (duration: 108.285653ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:21.773876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.428814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-29T05:51:21.773985Z","caller":"traceutil/trace.go:171","msg":"trace[390602637] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:641; }","duration":"108.630908ms","start":"2026-05-29T05:51:21.665331Z","end":"2026-05-29T05:51:21.773962Z","steps":["trace[390602637] 'agreement among raft nodes before linearized reading' (duration: 108.252561ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:51:24.685413Z","caller":"traceutil/trace.go:171","msg":"trace[1972820734] linearizableReadLoop","detail":"{readStateIndex:705; appliedIndex:704; }","duration":"223.617088ms","start":"2026-05-29T05:51:24.461765Z","end":"2026-05-29T05:51:24.685382Z","steps":["trace[1972820734] 'read index received' (duration: 223.294262ms)","trace[1972820734] 'applied index is now lower than readState.Index' (duration: 321.086µs)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:51:24.685523Z","caller":"traceutil/trace.go:171","msg":"trace[1035393613] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"249.922138ms","start":"2026-05-29T05:51:24.435531Z","end":"2026-05-29T05:51:24.685454Z","steps":["trace[1035393613] 'process raft request' (duration: 249.652562ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:24.68569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.493177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T05:51:24.685737Z","caller":"traceutil/trace.go:171","msg":"trace[2129581915] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:683; }","duration":"194.604249ms","start":"2026-05-29T05:51:24.491119Z","end":"2026-05-29T05:51:24.685723Z","steps":["trace[2129581915] 'agreement among raft nodes before linearized reading' (duration: 194.425565ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:24.685812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.017748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"info","ts":"2026-05-29T05:51:24.685916Z","caller":"traceutil/trace.go:171","msg":"trace[1474396325] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:683; }","duration":"224.196991ms","start":"2026-05-29T05:51:24.461695Z","end":"2026-05-29T05:51:24.685892Z","steps":["trace[1474396325] 'agreement among raft nodes before linearized reading' (duration: 223.829914ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:31.73148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.227329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T05:51:31.731596Z","caller":"traceutil/trace.go:171","msg":"trace[1780607717] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:744; }","duration":"241.392073ms","start":"2026-05-29T05:51:31.49018Z","end":"2026-05-29T05:51:31.731572Z","steps":["trace[1780607717] 'range keys from in-memory index tree' (duration: 241.149138ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:34.764256Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356765702592290374,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T05:51:35.097837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.367275ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T05:51:35.097995Z","caller":"traceutil/trace.go:171","msg":"trace[940301380] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:762; }","duration":"325.554948ms","start":"2026-05-29T05:51:34.772417Z","end":"2026-05-29T05:51:35.097972Z","steps":["trace[940301380] 'range keys from in-memory index tree' (duration: 325.344045ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:35.264584Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356765702592290374,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T05:51:35.320106Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.360426479s","expected-duration":"1s"} {"level":"info","ts":"2026-05-29T05:51:35.320524Z","caller":"traceutil/trace.go:171","msg":"trace[249155456] linearizableReadLoop","detail":"{readStateIndex:789; appliedIndex:788; }","duration":"1.056992007s","start":"2026-05-29T05:51:34.263497Z","end":"2026-05-29T05:51:35.320489Z","steps":["trace[249155456] 'read index received' (duration: 1.056709722s)","trace[249155456] 'applied index is now lower than readState.Index' (duration: 281.155µs)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:51:35.320799Z","caller":"traceutil/trace.go:171","msg":"trace[1528183661] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"1.361260204s","start":"2026-05-29T05:51:33.95952Z","end":"2026-05-29T05:51:35.32078Z","steps":["trace[1528183661] 'process raft request' (duration: 1.360765525s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:35.320919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"829.604735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T05:51:35.321003Z","caller":"traceutil/trace.go:171","msg":"trace[1871752186] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:763; }","duration":"829.726537ms","start":"2026-05-29T05:51:34.491255Z","end":"2026-05-29T05:51:35.320982Z","steps":["trace[1871752186] 'agreement among raft nodes before linearized reading' (duration: 829.579414ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:35.321079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"823.795903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-29T05:51:35.320999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"782.550555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-29T05:51:35.321154Z","caller":"traceutil/trace.go:171","msg":"trace[1474642895] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:763; }","duration":"823.930065ms","start":"2026-05-29T05:51:34.497208Z","end":"2026-05-29T05:51:35.321138Z","steps":["trace[1474642895] 'agreement among raft nodes before linearized reading' (duration: 823.791043ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:35.321065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:51:34.491244Z","time spent":"829.806839ms","remote":"127.0.0.1:34218","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-29T05:51:35.321163Z","caller":"traceutil/trace.go:171","msg":"trace[496639881] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:763; }","duration":"782.716909ms","start":"2026-05-29T05:51:34.538429Z","end":"2026-05-29T05:51:35.321146Z","steps":["trace[496639881] 'agreement among raft nodes before linearized reading' (duration: 782.483954ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:35.321197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:51:34.497182Z","time spent":"824.004836ms","remote":"127.0.0.1:34514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":28,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-29T05:51:35.321187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.057659421s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-fskt8\" ","response":"range_response_count:1 size:3965"} {"level":"warn","ts":"2026-05-29T05:51:35.321214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:51:34.538395Z","time spent":"782.808131ms","remote":"127.0.0.1:51346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":73,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-05-29T05:51:35.321327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:51:33.959481Z","time spent":"1.361379126s","remote":"127.0.0.1:34390","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4905,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T05:51:35.321273Z","caller":"traceutil/trace.go:171","msg":"trace[1929813773] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-fskt8; range_end:; response_count:1; response_revision:763; }","duration":"1.057783212s","start":"2026-05-29T05:51:34.263463Z","end":"2026-05-29T05:51:35.321246Z","steps":["trace[1929813773] 'agreement among raft nodes before linearized reading' (duration: 1.057549158s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:35.321497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:51:34.263447Z","time spent":"1.058033198s","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-fskt8\" "} {"level":"warn","ts":"2026-05-29T05:51:35.321258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.283468ms","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-29T05:51:35.32166Z","caller":"traceutil/trace.go:171","msg":"trace[63973865] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:763; }","duration":"172.743847ms","start":"2026-05-29T05:51:35.148896Z","end":"2026-05-29T05:51:35.32164Z","steps":["trace[63973865] 'agreement among raft nodes before linearized reading' (duration: 172.138645ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:35.32233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.24039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-29T05:51:35.322388Z","caller":"traceutil/trace.go:171","msg":"trace[2004424785] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:763; }","duration":"432.364431ms","start":"2026-05-29T05:51:34.890009Z","end":"2026-05-29T05:51:35.322373Z","steps":["trace[2004424785] 'agreement among raft nodes before linearized reading' (duration: 430.848021ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:35.322427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:51:34.889993Z","time spent":"432.423263ms","remote":"127.0.0.1:51276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-05-29T05:51:49.693948Z","caller":"traceutil/trace.go:171","msg":"trace[1146335956] transaction","detail":"{read_only:false; response_revision:898; number_of_response:1; }","duration":"263.798516ms","start":"2026-05-29T05:51:49.430122Z","end":"2026-05-29T05:51:49.69392Z","steps":["trace[1146335956] 'process raft request' (duration: 263.618562ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:51:50.522678Z","caller":"traceutil/trace.go:171","msg":"trace[1190456483] linearizableReadLoop","detail":"{readStateIndex:940; appliedIndex:939; }","duration":"150.532347ms","start":"2026-05-29T05:51:50.372121Z","end":"2026-05-29T05:51:50.522653Z","steps":["trace[1190456483] 'read index received' (duration: 150.316823ms)","trace[1190456483] 'applied index is now lower than readState.Index' (duration: 214.474µs)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:51:50.522721Z","caller":"traceutil/trace.go:171","msg":"trace[607886086] transaction","detail":"{read_only:false; response_revision:911; number_of_response:1; }","duration":"170.002144ms","start":"2026-05-29T05:51:50.352692Z","end":"2026-05-29T05:51:50.522694Z","steps":["trace[607886086] 'process raft request' (duration: 169.79443ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:50.522837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.702781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T05:51:50.522878Z","caller":"traceutil/trace.go:171","msg":"trace[1891255492] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:911; }","duration":"150.795042ms","start":"2026-05-29T05:51:50.372072Z","end":"2026-05-29T05:51:50.522867Z","steps":["trace[1891255492] 'agreement among raft nodes before linearized reading' (duration: 150.712581ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:10.645106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.934783ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T05:52:10.645223Z","caller":"traceutil/trace.go:171","msg":"trace[581804328] linearizableReadLoop","detail":"{readStateIndex:1016; appliedIndex:1014; }","duration":"362.621494ms","start":"2026-05-29T05:52:10.282584Z","end":"2026-05-29T05:52:10.645205Z","steps":["trace[581804328] 'read index received' (duration: 10.314978ms)","trace[581804328] 'applied index is now lower than readState.Index' (duration: 352.305426ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T05:52:10.645382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.24751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T05:52:10.645417Z","caller":"traceutil/trace.go:171","msg":"trace[1789006517] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:982; }","duration":"270.297241ms","start":"2026-05-29T05:52:10.375111Z","end":"2026-05-29T05:52:10.645408Z","steps":["trace[1789006517] 'agreement among raft nodes before linearized reading' (duration: 270.220309ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:10.645491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.877529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-29T05:52:10.645563Z","caller":"traceutil/trace.go:171","msg":"trace[1566710348] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:982; }","duration":"362.978221ms","start":"2026-05-29T05:52:10.282568Z","end":"2026-05-29T05:52:10.645546Z","steps":["trace[1566710348] 'agreement among raft nodes before linearized reading' (duration: 362.755777ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:52:10.645557Z","caller":"traceutil/trace.go:171","msg":"trace[960292629] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"386.037877ms","start":"2026-05-29T05:52:10.259487Z","end":"2026-05-29T05:52:10.645525Z","steps":["trace[960292629] 'process raft request' (duration: 113.594364ms)","trace[960292629] 'compare' (duration: 271.826331ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T05:52:10.645593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:10.282562Z","time spent":"363.025742ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-29T05:52:10.645639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.939573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T05:52:10.645777Z","caller":"traceutil/trace.go:171","msg":"trace[2084671537] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:982; }","duration":"154.118077ms","start":"2026-05-29T05:52:10.491629Z","end":"2026-05-29T05:52:10.645747Z","steps":["trace[2084671537] 'agreement among raft nodes before linearized reading' (duration: 153.887263ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:10.645679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:10.259478Z","time spent":"386.140789ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T05:52:11.671747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.309153ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T05:52:11.671831Z","caller":"traceutil/trace.go:171","msg":"trace[28662278] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"535.463283ms","start":"2026-05-29T05:52:11.136354Z","end":"2026-05-29T05:52:11.671817Z","steps":["trace[28662278] 'process raft request' (duration: 414.006897ms)","trace[28662278] 'compare' (duration: 121.084059ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T05:52:11.67187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:11.136325Z","time spent":"535.526354ms","remote":"127.0.0.1:34252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T05:52:11.715631Z","caller":"traceutil/trace.go:171","msg":"trace[216977268] linearizableReadLoop","detail":"{readStateIndex:1020; appliedIndex:1018; }","duration":"374.005285ms","start":"2026-05-29T05:52:11.341605Z","end":"2026-05-29T05:52:11.71561Z","steps":["trace[216977268] 'read index received' (duration: 208.767093ms)","trace[216977268] 'applied index is now lower than readState.Index' (duration: 165.236842ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T05:52:11.715774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.142977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T05:52:11.715813Z","caller":"traceutil/trace.go:171","msg":"trace[299045644] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:985; }","duration":"374.236408ms","start":"2026-05-29T05:52:11.341564Z","end":"2026-05-29T05:52:11.7158Z","steps":["trace[299045644] 'agreement among raft nodes before linearized reading' (duration: 374.155877ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:11.715842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:11.34155Z","time spent":"374.28509ms","remote":"127.0.0.1:47152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-29T05:52:11.715938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.119388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T05:52:11.71606Z","caller":"traceutil/trace.go:171","msg":"trace[626302624] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:985; }","duration":"225.292712ms","start":"2026-05-29T05:52:11.490741Z","end":"2026-05-29T05:52:11.716034Z","steps":["trace[626302624] 'agreement among raft nodes before linearized reading' (duration: 225.117587ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:52:11.716806Z","caller":"traceutil/trace.go:171","msg":"trace[331188970] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"396.843065ms","start":"2026-05-29T05:52:11.318903Z","end":"2026-05-29T05:52:11.715737Z","steps":["trace[331188970] 'process raft request' (duration: 396.56541ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:11.716984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:11.318883Z","time spent":"398.018058ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T05:52:12.778273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"940.448856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-29T05:52:12.778356Z","caller":"traceutil/trace.go:171","msg":"trace[1125277172] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:985; }","duration":"940.582777ms","start":"2026-05-29T05:52:11.837755Z","end":"2026-05-29T05:52:12.778338Z","steps":["trace[1125277172] 'range keys from in-memory index tree' (duration: 940.218321ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:12.778399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:11.837733Z","time spent":"940.65496ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-29T05:52:12.778656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.373096ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T05:52:12.778812Z","caller":"traceutil/trace.go:171","msg":"trace[1761799217] linearizableReadLoop","detail":"{readStateIndex:1021; appliedIndex:1020; }","duration":"886.251509ms","start":"2026-05-29T05:52:11.892533Z","end":"2026-05-29T05:52:12.778784Z","steps":["trace[1761799217] 'read index received' (duration: 358.597286ms)","trace[1761799217] 'applied index is now lower than readState.Index' (duration: 527.652193ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T05:52:12.779273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"886.725537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-29T05:52:12.779269Z","caller":"traceutil/trace.go:171","msg":"trace[1940804793] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"893.865655ms","start":"2026-05-29T05:52:11.885364Z","end":"2026-05-29T05:52:12.779229Z","steps":["trace[1940804793] 'process raft request' (duration: 365.764224ms)","trace[1940804793] 'compare' (duration: 527.158052ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:52:12.779319Z","caller":"traceutil/trace.go:171","msg":"trace[1317704145] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:986; }","duration":"886.812029ms","start":"2026-05-29T05:52:11.892495Z","end":"2026-05-29T05:52:12.779307Z","steps":["trace[1317704145] 'agreement among raft nodes before linearized reading' (duration: 886.672717ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:12.779355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:11.892477Z","time spent":"886.86935ms","remote":"127.0.0.1:51316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":4,"response size":30,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"warn","ts":"2026-05-29T05:52:12.779452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:11.885344Z","time spent":"894.000619ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T05:52:12.779565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.123623ms","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-29T05:52:12.779608Z","caller":"traceutil/trace.go:171","msg":"trace[766624375] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:986; }","duration":"130.168304ms","start":"2026-05-29T05:52:12.649426Z","end":"2026-05-29T05:52:12.779594Z","steps":["trace[766624375] 'agreement among raft nodes before linearized reading' (duration: 130.033031ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:12.779681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.945969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-05-29T05:52:12.779639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"672.315567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-29T05:52:12.779746Z","caller":"traceutil/trace.go:171","msg":"trace[1425642648] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:986; }","duration":"482.048141ms","start":"2026-05-29T05:52:12.297679Z","end":"2026-05-29T05:52:12.779727Z","steps":["trace[1425642648] 'agreement among raft nodes before linearized reading' (duration: 481.792126ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:52:12.77976Z","caller":"traceutil/trace.go:171","msg":"trace[1494959078] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:986; }","duration":"672.486379ms","start":"2026-05-29T05:52:12.107252Z","end":"2026-05-29T05:52:12.779738Z","steps":["trace[1494959078] 'agreement among raft nodes before linearized reading' (duration: 672.189664ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:12.779998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:12.297661Z","time spent":"482.327346ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-29T05:52:12.779991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:12.107215Z","time spent":"672.766115ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-29T05:52:35.290315Z","caller":"traceutil/trace.go:171","msg":"trace[203909944] transaction","detail":"{read_only:false; response_revision:1064; number_of_response:1; }","duration":"207.651657ms","start":"2026-05-29T05:52:35.082632Z","end":"2026-05-29T05:52:35.290284Z","steps":["trace[203909944] 'process raft request' (duration: 207.463314ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:35.861801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.706416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T05:52:35.861882Z","caller":"traceutil/trace.go:171","msg":"trace[1822410819] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1064; }","duration":"369.826569ms","start":"2026-05-29T05:52:35.492035Z","end":"2026-05-29T05:52:35.861862Z","steps":["trace[1822410819] 'range keys from in-memory index tree' (duration: 369.632905ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:35.86192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:35.492017Z","time spent":"369.89468ms","remote":"127.0.0.1:34218","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-29T05:52:36.542834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.300436ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-29T05:52:37.101619Z","caller":"traceutil/trace.go:171","msg":"trace[1670323849] transaction","detail":"{read_only:false; response_revision:1066; number_of_response:1; }","duration":"124.386197ms","start":"2026-05-29T05:52:36.97721Z","end":"2026-05-29T05:52:37.101596Z","steps":["trace[1670323849] 'process raft request' (duration: 124.213334ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:37.478135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.748912ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T05:52:37.478597Z","caller":"traceutil/trace.go:171","msg":"trace[831879295] transaction","detail":"{read_only:false; response_revision:1067; number_of_response:1; }","duration":"372.213245ms","start":"2026-05-29T05:52:37.10632Z","end":"2026-05-29T05:52:37.478534Z","steps":["trace[831879295] 'process raft request' (duration: 181.921792ms)","trace[831879295] 'compare' (duration: 189.560479ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T05:52:37.478915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:37.106303Z","time spent":"372.52156ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T05:52:37.50592Z","caller":"traceutil/trace.go:171","msg":"trace[320217293] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"399.417767ms","start":"2026-05-29T05:52:37.10647Z","end":"2026-05-29T05:52:37.505888Z","steps":["trace[320217293] 'process raft request' (duration: 399.225563ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:37.506083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:37.106445Z","time spent":"399.549758ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T05:52:37.506401Z","caller":"traceutil/trace.go:171","msg":"trace[509701561] transaction","detail":"{read_only:false; response_revision:1069; number_of_response:1; }","duration":"399.862554ms","start":"2026-05-29T05:52:37.106504Z","end":"2026-05-29T05:52:37.506367Z","steps":["trace[509701561] 'process raft request' (duration: 399.339445ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:37.50659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:37.106481Z","time spent":"400.011319ms","remote":"127.0.0.1:34498","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-29T05:52:37.506956Z","caller":"traceutil/trace.go:171","msg":"trace[1303532383] transaction","detail":"{read_only:false; response_revision:1070; number_of_response:1; }","duration":"399.858386ms","start":"2026-05-29T05:52:37.107083Z","end":"2026-05-29T05:52:37.506941Z","steps":["trace[1303532383] 'process raft request' (duration: 399.187253ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:37.507044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:37.107068Z","time spent":"399.936227ms","remote":"127.0.0.1:34498","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-29T05:52:39.983604Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356765702592291120,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-29T05:52:40.101526Z","caller":"traceutil/trace.go:171","msg":"trace[1087866646] linearizableReadLoop","detail":"{readStateIndex:1112; appliedIndex:1111; }","duration":"618.642415ms","start":"2026-05-29T05:52:39.482846Z","end":"2026-05-29T05:52:40.101488Z","steps":["trace[1087866646] 'read index received' (duration: 618.518052ms)","trace[1087866646] 'applied index is now lower than readState.Index' (duration: 123.263µs)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:52:40.101554Z","caller":"traceutil/trace.go:171","msg":"trace[1333914514] transaction","detail":"{read_only:false; response_revision:1072; number_of_response:1; }","duration":"990.611965ms","start":"2026-05-29T05:52:39.110911Z","end":"2026-05-29T05:52:40.101523Z","steps":["trace[1333914514] 'process raft request' (duration: 990.424692ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:40.101712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:39.110898Z","time spent":"990.725637ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T05:52:40.101773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"618.90482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-29T05:52:40.101816Z","caller":"traceutil/trace.go:171","msg":"trace[2088042434] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1072; }","duration":"619.007991ms","start":"2026-05-29T05:52:39.482795Z","end":"2026-05-29T05:52:40.101803Z","steps":["trace[2088042434] 'agreement among raft nodes before linearized reading' (duration: 618.839948ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:40.101884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:39.482776Z","time spent":"619.096774ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-29T05:52:40.601804Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356765702592291123,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T05:52:40.852363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.027038ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T05:52:40.852476Z","caller":"traceutil/trace.go:171","msg":"trace[597405692] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"856.756135ms","start":"2026-05-29T05:52:39.995701Z","end":"2026-05-29T05:52:40.852458Z","steps":["trace[597405692] 'process raft request' (duration: 718.531943ms)","trace[597405692] 'compare' (duration: 137.924947ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T05:52:40.852533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:39.995674Z","time spent":"856.833137ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T05:52:40.886088Z","caller":"traceutil/trace.go:171","msg":"trace[1307690342] linearizableReadLoop","detail":"{readStateIndex:1114; appliedIndex:1112; }","duration":"784.451257ms","start":"2026-05-29T05:52:40.101607Z","end":"2026-05-29T05:52:40.886058Z","steps":["trace[1307690342] 'read index received' (duration: 612.775352ms)","trace[1307690342] 'applied index is now lower than readState.Index' (duration: 171.674225ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:52:40.886365Z","caller":"traceutil/trace.go:171","msg":"trace[1958013730] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"779.115146ms","start":"2026-05-29T05:52:40.107226Z","end":"2026-05-29T05:52:40.886342Z","steps":["trace[1958013730] 'process raft request' (duration: 778.680247ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:40.88647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.376112456s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-05-29T05:52:40.886534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:40.107194Z","time spent":"779.226818ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T05:52:40.886581Z","caller":"traceutil/trace.go:171","msg":"trace[925324657] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1074; }","duration":"1.376259188s","start":"2026-05-29T05:52:39.510307Z","end":"2026-05-29T05:52:40.886567Z","steps":["trace[925324657] 'agreement among raft nodes before linearized reading' (duration: 1.375948681s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:40.886613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.430303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-29T05:52:40.886677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.395446277s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T05:52:40.88671Z","caller":"traceutil/trace.go:171","msg":"trace[1421803905] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1074; }","duration":"1.395496737s","start":"2026-05-29T05:52:39.491202Z","end":"2026-05-29T05:52:40.886699Z","steps":["trace[1421803905] 'agreement among raft nodes before linearized reading' (duration: 1.395445946s)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:52:40.886708Z","caller":"traceutil/trace.go:171","msg":"trace[1069308396] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1074; }","duration":"330.587036ms","start":"2026-05-29T05:52:40.556096Z","end":"2026-05-29T05:52:40.886683Z","steps":["trace[1069308396] 'agreement among raft nodes before linearized reading' (duration: 330.428833ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:40.886744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:39.491191Z","time spent":"1.395546228s","remote":"127.0.0.1:34218","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-29T05:52:40.886777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:40.556076Z","time spent":"330.683827ms","remote":"127.0.0.1:34390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":30,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"warn","ts":"2026-05-29T05:52:40.886765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:39.510296Z","time spent":"1.376312969s","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-29T05:52:40.886643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.375152417s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-05-29T05:52:40.887057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.375511563s","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-29T05:52:40.887146Z","caller":"traceutil/trace.go:171","msg":"trace[893843654] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1074; }","duration":"1.375762299s","start":"2026-05-29T05:52:39.511363Z","end":"2026-05-29T05:52:40.887125Z","steps":["trace[893843654] 'agreement among raft nodes before linearized reading' (duration: 1.374824741s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:40.887481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:39.511353Z","time spent":"1.376097615s","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-29T05:52:40.887356Z","caller":"traceutil/trace.go:171","msg":"trace[535427918] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1074; }","duration":"1.37587111s","start":"2026-05-29T05:52:39.511462Z","end":"2026-05-29T05:52:40.887333Z","steps":["trace[535427918] 'agreement among raft nodes before linearized reading' (duration: 1.375379551s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:40.888045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:39.511438Z","time spent":"1.376591864s","remote":"127.0.0.1:34498","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-29T05:52:41.13151Z","caller":"traceutil/trace.go:171","msg":"trace[1581753464] linearizableReadLoop","detail":"{readStateIndex:1117; appliedIndex:1114; }","duration":"235.208145ms","start":"2026-05-29T05:52:40.896278Z","end":"2026-05-29T05:52:41.131486Z","steps":["trace[1581753464] 'read index received' (duration: 42.847662ms)","trace[1581753464] 'applied index is now lower than readState.Index' (duration: 192.359393ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:52:41.131566Z","caller":"traceutil/trace.go:171","msg":"trace[55934207] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"239.203122ms","start":"2026-05-29T05:52:40.892333Z","end":"2026-05-29T05:52:41.131536Z","steps":["trace[55934207] 'process raft request' (duration: 238.965847ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:52:41.131632Z","caller":"traceutil/trace.go:171","msg":"trace[1223335712] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"237.721604ms","start":"2026-05-29T05:52:40.893898Z","end":"2026-05-29T05:52:41.13162Z","steps":["trace[1223335712] 'process raft request' (duration: 237.54628ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:41.131807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.514391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T05:52:41.131846Z","caller":"traceutil/trace.go:171","msg":"trace[445479263] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1077; }","duration":"235.588412ms","start":"2026-05-29T05:52:40.896249Z","end":"2026-05-29T05:52:41.131837Z","steps":["trace[445479263] 'agreement among raft nodes before linearized reading' (duration: 235.5096ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:41.132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.490489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.113\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-29T05:52:41.13209Z","caller":"traceutil/trace.go:171","msg":"trace[1668884836] range","detail":"{range_begin:/registry/masterleases/199.204.45.113; range_end:; response_count:1; response_revision:1077; }","duration":"162.634122ms","start":"2026-05-29T05:52:40.969438Z","end":"2026-05-29T05:52:41.132072Z","steps":["trace[1668884836] 'agreement among raft nodes before linearized reading' (duration: 162.361257ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:41.650522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.638742ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-05-29T05:52:41.65061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:41.133208Z","time spent":"517.398761ms","remote":"127.0.0.1:34252","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-29T05:52:42.144457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.633242ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T05:52:42.144718Z","caller":"traceutil/trace.go:171","msg":"trace[1564484534] transaction","detail":"{read_only:false; response_revision:1078; number_of_response:1; }","duration":"492.8358ms","start":"2026-05-29T05:52:41.651838Z","end":"2026-05-29T05:52:42.144674Z","steps":["trace[1564484534] 'process raft request' (duration: 230.669098ms)","trace[1564484534] 'compare' (duration: 261.097591ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T05:52:42.144982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:41.651816Z","time spent":"492.990133ms","remote":"127.0.0.1:34252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T05:52:42.452473Z","caller":"traceutil/trace.go:171","msg":"trace[2132126478] linearizableReadLoop","detail":"{readStateIndex:1120; appliedIndex:1119; }","duration":"301.629319ms","start":"2026-05-29T05:52:42.150805Z","end":"2026-05-29T05:52:42.452434Z","steps":["trace[2132126478] 'read index received' (duration: 209.867399ms)","trace[2132126478] 'applied index is now lower than readState.Index' (duration: 91.76095ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T05:52:42.452615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.800092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-05-29T05:52:42.452944Z","caller":"traceutil/trace.go:171","msg":"trace[1545594466] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:1079; }","duration":"302.188439ms","start":"2026-05-29T05:52:42.150741Z","end":"2026-05-29T05:52:42.452929Z","steps":["trace[1545594466] 'agreement among raft nodes before linearized reading' (duration: 301.798992ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:42.452996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:42.150718Z","time spent":"302.263861ms","remote":"127.0.0.1:34502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"info","ts":"2026-05-29T05:52:42.452965Z","caller":"traceutil/trace.go:171","msg":"trace[1147233256] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"303.201849ms","start":"2026-05-29T05:52:42.149715Z","end":"2026-05-29T05:52:42.452917Z","steps":["trace[1147233256] 'process raft request' (duration: 210.949529ms)","trace[1147233256] 'compare' (duration: 91.661359ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T05:52:42.453462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:42.149702Z","time spent":"303.560487ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T05:52:43.039142Z","caller":"traceutil/trace.go:171","msg":"trace[2108950908] linearizableReadLoop","detail":"{readStateIndex:1121; appliedIndex:1120; }","duration":"147.649824ms","start":"2026-05-29T05:52:42.891465Z","end":"2026-05-29T05:52:43.039115Z","steps":["trace[2108950908] 'read index received' (duration: 147.508241ms)","trace[2108950908] 'applied index is now lower than readState.Index' (duration: 139.423µs)"],"step_count":2} {"level":"warn","ts":"2026-05-29T05:52:43.039423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.932179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-29T05:52:43.039517Z","caller":"traceutil/trace.go:171","msg":"trace[380325472] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"180.184619ms","start":"2026-05-29T05:52:42.859001Z","end":"2026-05-29T05:52:43.039186Z","steps":["trace[380325472] 'process raft request' (duration: 179.953735ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:52:43.039559Z","caller":"traceutil/trace.go:171","msg":"trace[1649238080] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1080; }","duration":"148.115093ms","start":"2026-05-29T05:52:42.891428Z","end":"2026-05-29T05:52:43.039543Z","steps":["trace[1649238080] 'agreement among raft nodes before linearized reading' (duration: 147.836568ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:43.483126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.893693ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T05:52:43.483626Z","caller":"traceutil/trace.go:171","msg":"trace[674638743] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"439.811533ms","start":"2026-05-29T05:52:43.04379Z","end":"2026-05-29T05:52:43.483601Z","steps":["trace[674638743] 'process raft request' (duration: 97.347639ms)","trace[674638743] 'compare' (duration: 341.74076ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T05:52:43.483718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:43.043768Z","time spent":"439.907875ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T05:52:43.484139Z","caller":"traceutil/trace.go:171","msg":"trace[1646435348] linearizableReadLoop","detail":"{readStateIndex:1123; appliedIndex:1121; }","duration":"346.624774ms","start":"2026-05-29T05:52:43.137502Z","end":"2026-05-29T05:52:43.484127Z","steps":["trace[1646435348] 'read index received' (duration: 3.650581ms)","trace[1646435348] 'applied index is now lower than readState.Index' (duration: 342.973243ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:52:43.484257Z","caller":"traceutil/trace.go:171","msg":"trace[232826851] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"439.605848ms","start":"2026-05-29T05:52:43.044641Z","end":"2026-05-29T05:52:43.484246Z","steps":["trace[232826851] 'process raft request' (duration: 439.393264ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:43.484321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:43.044624Z","time spent":"439.660879ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T05:52:43.484425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.919079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-29T05:52:43.484493Z","caller":"traceutil/trace.go:171","msg":"trace[1614437115] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1082; }","duration":"347.023192ms","start":"2026-05-29T05:52:43.137454Z","end":"2026-05-29T05:52:43.484477Z","steps":["trace[1614437115] 'agreement among raft nodes before linearized reading' (duration: 346.835948ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:43.484548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:43.137436Z","time spent":"347.099673ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-29T05:52:43.55037Z","caller":"traceutil/trace.go:171","msg":"trace[1312350631] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"221.331089ms","start":"2026-05-29T05:52:43.329012Z","end":"2026-05-29T05:52:43.550343Z","steps":["trace[1312350631] 'process raft request' (duration: 221.146035ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:43.550434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.514928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-29T05:52:43.550489Z","caller":"traceutil/trace.go:171","msg":"trace[606751427] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1083; }","duration":"412.601319ms","start":"2026-05-29T05:52:43.137873Z","end":"2026-05-29T05:52:43.550474Z","steps":["trace[606751427] 'agreement among raft nodes before linearized reading' (duration: 412.404545ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:43.550529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:43.137861Z","time spent":"412.65643ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-29T05:52:44.952888Z","caller":"traceutil/trace.go:171","msg":"trace[1565956441] linearizableReadLoop","detail":"{readStateIndex:1127; appliedIndex:1126; }","duration":"460.271285ms","start":"2026-05-29T05:52:44.492595Z","end":"2026-05-29T05:52:44.952866Z","steps":["trace[1565956441] 'read index received' (duration: 460.054971ms)","trace[1565956441] 'applied index is now lower than readState.Index' (duration: 215.354µs)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:52:44.953022Z","caller":"traceutil/trace.go:171","msg":"trace[634034142] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"490.75262ms","start":"2026-05-29T05:52:44.462251Z","end":"2026-05-29T05:52:44.953003Z","steps":["trace[634034142] 'process raft request' (duration: 490.465435ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:44.953237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:44.462229Z","time spent":"490.827651ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T05:52:44.953345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.748284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-29T05:52:44.953259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.98302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T05:52:44.953441Z","caller":"traceutil/trace.go:171","msg":"trace[101130165] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:1086; }","duration":"434.217445ms","start":"2026-05-29T05:52:44.519199Z","end":"2026-05-29T05:52:44.953417Z","steps":["trace[101130165] 'agreement among raft nodes before linearized reading' (duration: 433.846678ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:44.953525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:44.519183Z","time spent":"434.318497ms","remote":"127.0.0.1:53016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"info","ts":"2026-05-29T05:52:44.953405Z","caller":"traceutil/trace.go:171","msg":"trace[1682085756] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1086; }","duration":"460.839626ms","start":"2026-05-29T05:52:44.492548Z","end":"2026-05-29T05:52:44.953388Z","steps":["trace[1682085756] 'agreement among raft nodes before linearized reading' (duration: 460.768714ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:44.953718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:44.492526Z","time spent":"461.173292ms","remote":"127.0.0.1:34218","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-29T05:52:45.697931Z","caller":"traceutil/trace.go:171","msg":"trace[1291704400] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"653.110846ms","start":"2026-05-29T05:52:45.044765Z","end":"2026-05-29T05:52:45.697875Z","steps":["trace[1291704400] 'process raft request' (duration: 652.956104ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:45.698472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:45.044741Z","time spent":"653.507633ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T05:52:45.826715Z","caller":"traceutil/trace.go:171","msg":"trace[147254071] linearizableReadLoop","detail":"{readStateIndex:1129; appliedIndex:1127; }","duration":"336.329206ms","start":"2026-05-29T05:52:45.490364Z","end":"2026-05-29T05:52:45.826694Z","steps":["trace[147254071] 'read index received' (duration: 207.465543ms)","trace[147254071] 'applied index is now lower than readState.Index' (duration: 128.860343ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:52:45.826796Z","caller":"traceutil/trace.go:171","msg":"trace[1616811502] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"369.878879ms","start":"2026-05-29T05:52:45.456881Z","end":"2026-05-29T05:52:45.826759Z","steps":["trace[1616811502] 'process raft request' (duration: 320.018432ms)","trace[1616811502] 'compare' (duration: 49.685034ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T05:52:45.826964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:45.456856Z","time spent":"370.020622ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T05:52:45.827162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.860249ms","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-29T05:52:45.827239Z","caller":"traceutil/trace.go:171","msg":"trace[1583106742] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1088; }","duration":"197.045861ms","start":"2026-05-29T05:52:45.630154Z","end":"2026-05-29T05:52:45.8272Z","steps":["trace[1583106742] 'agreement among raft nodes before linearized reading' (duration: 196.736256ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:45.82736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.880212ms","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-29T05:52:45.827408Z","caller":"traceutil/trace.go:171","msg":"trace[1159278205] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1088; }","duration":"243.029234ms","start":"2026-05-29T05:52:45.584366Z","end":"2026-05-29T05:52:45.827395Z","steps":["trace[1159278205] 'agreement among raft nodes before linearized reading' (duration: 242.79048ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:45.827376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.943957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-29T05:52:45.827564Z","caller":"traceutil/trace.go:171","msg":"trace[448161662] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1088; }","duration":"337.204853ms","start":"2026-05-29T05:52:45.490339Z","end":"2026-05-29T05:52:45.827544Z","steps":["trace[448161662] 'agreement among raft nodes before linearized reading' (duration: 336.440658ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:45.827792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:45.490328Z","time spent":"337.364006ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-29T05:52:45.828063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.769435ms","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-29T05:52:45.828104Z","caller":"traceutil/trace.go:171","msg":"trace[1720195973] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1088; }","duration":"336.862957ms","start":"2026-05-29T05:52:45.491231Z","end":"2026-05-29T05:52:45.828094Z","steps":["trace[1720195973] 'agreement among raft nodes before linearized reading' (duration: 335.625063ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:45.828134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:52:45.491217Z","time spent":"336.908488ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-29T05:53:01.91008Z","caller":"traceutil/trace.go:171","msg":"trace[1841021543] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"123.806886ms","start":"2026-05-29T05:53:01.786248Z","end":"2026-05-29T05:53:01.910055Z","steps":["trace[1841021543] 'process raft request' (duration: 123.675234ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:02.495038Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356765702592291399,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-29T05:53:02.66384Z","caller":"traceutil/trace.go:171","msg":"trace[835629549] linearizableReadLoop","detail":"{readStateIndex:1240; appliedIndex:1239; }","duration":"669.228896ms","start":"2026-05-29T05:53:01.994587Z","end":"2026-05-29T05:53:02.663815Z","steps":["trace[835629549] 'read index received' (duration: 664.474676ms)","trace[835629549] 'applied index is now lower than readState.Index' (duration: 4.7531ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T05:53:02.664196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.613769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-29T05:53:02.664241Z","caller":"traceutil/trace.go:171","msg":"trace[1119947239] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1193; }","duration":"575.701491ms","start":"2026-05-29T05:53:02.088528Z","end":"2026-05-29T05:53:02.664229Z","steps":["trace[1119947239] 'agreement among raft nodes before linearized reading' (duration: 575.554708ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:02.664258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"669.612864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-29T05:53:02.664371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.564304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T05:53:02.664404Z","caller":"traceutil/trace.go:171","msg":"trace[1052840572] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1193; }","duration":"171.628355ms","start":"2026-05-29T05:53:02.492767Z","end":"2026-05-29T05:53:02.664395Z","steps":["trace[1052840572] 'agreement among raft nodes before linearized reading' (duration: 171.586664ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:53:02.664383Z","caller":"traceutil/trace.go:171","msg":"trace[1602971923] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1193; }","duration":"669.832069ms","start":"2026-05-29T05:53:01.994533Z","end":"2026-05-29T05:53:02.664365Z","steps":["trace[1602971923] 'agreement among raft nodes before linearized reading' (duration: 669.491112ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:02.664494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:01.994512Z","time spent":"669.969281ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-29T05:53:02.664627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.842893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-29T05:53:02.664661Z","caller":"traceutil/trace.go:171","msg":"trace[1266102562] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1193; }","duration":"575.906814ms","start":"2026-05-29T05:53:02.088747Z","end":"2026-05-29T05:53:02.664653Z","steps":["trace[1266102562] 'agreement among raft nodes before linearized reading' (duration: 575.815452ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:02.66432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:02.088512Z","time spent":"575.759683ms","remote":"127.0.0.1:34498","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-29T05:53:02.664688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:02.088729Z","time spent":"575.952495ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-29T05:53:02.664746Z","caller":"traceutil/trace.go:171","msg":"trace[829617931] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"732.275786ms","start":"2026-05-29T05:53:01.932454Z","end":"2026-05-29T05:53:02.66473Z","steps":["trace[829617931] 'process raft request' (duration: 726.597307ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:02.664867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:01.932442Z","time spent":"732.362888ms","remote":"127.0.0.1:34498","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-29T05:53:04.990738Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356765702592291407,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T05:53:05.4911Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356765702592291407,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T05:53:05.936518Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.021520544s","expected-duration":"1s"} {"level":"info","ts":"2026-05-29T05:53:05.937154Z","caller":"traceutil/trace.go:171","msg":"trace[111222630] transaction","detail":"{read_only:false; response_revision:1198; number_of_response:1; }","duration":"2.022206837s","start":"2026-05-29T05:53:03.914923Z","end":"2026-05-29T05:53:05.93713Z","steps":["trace[111222630] 'process raft request' (duration: 2.022035214s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:05.937336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:03.914906Z","time spent":"2.022320218s","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T05:53:05.945518Z","caller":"traceutil/trace.go:171","msg":"trace[1358368475] linearizableReadLoop","detail":"{readStateIndex:1246; appliedIndex:1245; }","duration":"1.455664691s","start":"2026-05-29T05:53:04.489823Z","end":"2026-05-29T05:53:05.945488Z","steps":["trace[1358368475] 'read index received' (duration: 1.447356432s)","trace[1358368475] 'applied index is now lower than readState.Index' (duration: 8.306939ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:53:05.945605Z","caller":"traceutil/trace.go:171","msg":"trace[362922513] transaction","detail":"{read_only:false; response_revision:1199; number_of_response:1; }","duration":"1.818386934s","start":"2026-05-29T05:53:04.127193Z","end":"2026-05-29T05:53:05.945579Z","steps":["trace[362922513] 'process raft request' (duration: 1.818070748s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:05.945708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.455867475s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T05:53:05.945801Z","caller":"traceutil/trace.go:171","msg":"trace[1901404929] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1199; }","duration":"1.455977547s","start":"2026-05-29T05:53:04.489806Z","end":"2026-05-29T05:53:05.945784Z","steps":["trace[1901404929] 'agreement among raft nodes before linearized reading' (duration: 1.455837914s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:05.945802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.274590126s","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-29T05:53:05.945855Z","caller":"traceutil/trace.go:171","msg":"trace[1017881431] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1199; }","duration":"1.274651337s","start":"2026-05-29T05:53:04.671191Z","end":"2026-05-29T05:53:05.945842Z","steps":["trace[1017881431] 'agreement among raft nodes before linearized reading' (duration: 1.274509234s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:05.94585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:04.489732Z","time spent":"1.456106161s","remote":"127.0.0.1:34218","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-29T05:53:05.945881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:04.671138Z","time spent":"1.274735848s","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-29T05:53:05.946009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.270685482s","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-29T05:53:05.946024Z","caller":"traceutil/trace.go:171","msg":"trace[1690615779] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1199; }","duration":"1.270729693s","start":"2026-05-29T05:53:04.675288Z","end":"2026-05-29T05:53:05.946018Z","steps":["trace[1690615779] 'agreement among raft nodes before linearized reading' (duration: 1.270684172s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:05.945739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:04.127171Z","time spent":"1.818481195s","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T05:53:05.946075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.27214814s","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-29T05:53:05.946089Z","caller":"traceutil/trace.go:171","msg":"trace[98215643] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1199; }","duration":"1.27217521s","start":"2026-05-29T05:53:04.67391Z","end":"2026-05-29T05:53:05.946085Z","steps":["trace[98215643] 'agreement among raft nodes before linearized reading' (duration: 1.272133459s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:05.946104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:04.673904Z","time spent":"1.2721974s","remote":"127.0.0.1:34498","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-29T05:53:05.946035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:04.675269Z","time spent":"1.270763583s","remote":"127.0.0.1:34498","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-29T05:53:05.946187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"857.49907ms","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-29T05:53:05.946198Z","caller":"traceutil/trace.go:171","msg":"trace[926363890] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1199; }","duration":"857.540971ms","start":"2026-05-29T05:53:05.088653Z","end":"2026-05-29T05:53:05.946194Z","steps":["trace[926363890] 'agreement among raft nodes before linearized reading' (duration: 857.506081ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:05.946209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:05.088635Z","time spent":"857.571721ms","remote":"127.0.0.1:34498","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":"warn","ts":"2026-05-29T05:53:05.945908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.270217452s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-29T05:53:05.946357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.15078193s","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":"info","ts":"2026-05-29T05:53:05.946403Z","caller":"traceutil/trace.go:171","msg":"trace[1616565719] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1199; }","duration":"1.150859822s","start":"2026-05-29T05:53:04.795531Z","end":"2026-05-29T05:53:05.94639Z","steps":["trace[1616565719] 'agreement among raft nodes before linearized reading' (duration: 1.15077048s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:05.946441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:04.795516Z","time spent":"1.150914243s","remote":"127.0.0.1:34320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":11,"response size":30,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"info","ts":"2026-05-29T05:53:05.946339Z","caller":"traceutil/trace.go:171","msg":"trace[760901593] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1199; }","duration":"1.270655412s","start":"2026-05-29T05:53:04.675671Z","end":"2026-05-29T05:53:05.946326Z","steps":["trace[760901593] 'agreement among raft nodes before linearized reading' (duration: 1.270125751s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:05.947659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:04.675664Z","time spent":"1.271926486s","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-29T05:53:18.555723Z","caller":"traceutil/trace.go:171","msg":"trace[2029804774] linearizableReadLoop","detail":"{readStateIndex:1289; appliedIndex:1288; }","duration":"499.404837ms","start":"2026-05-29T05:53:18.05629Z","end":"2026-05-29T05:53:18.555695Z","steps":["trace[2029804774] 'read index received' (duration: 499.186512ms)","trace[2029804774] 'applied index is now lower than readState.Index' (duration: 216.935µs)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:53:18.55577Z","caller":"traceutil/trace.go:171","msg":"trace[988871380] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"578.697758ms","start":"2026-05-29T05:53:17.977029Z","end":"2026-05-29T05:53:18.555727Z","steps":["trace[988871380] 'process raft request' (duration: 578.447313ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:18.555927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:17.976993Z","time spent":"578.842761ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T05:53:18.555959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.652811ms","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-29T05:53:18.555993Z","caller":"traceutil/trace.go:171","msg":"trace[1103940114] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1239; }","duration":"499.752483ms","start":"2026-05-29T05:53:18.05623Z","end":"2026-05-29T05:53:18.555982Z","steps":["trace[1103940114] 'agreement among raft nodes before linearized reading' (duration: 499.59939ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:18.556026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:18.056203Z","time spent":"499.815594ms","remote":"127.0.0.1:34498","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":"warn","ts":"2026-05-29T05:53:18.556113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.998282ms","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-29T05:53:18.556179Z","caller":"traceutil/trace.go:171","msg":"trace[1819731400] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1239; }","duration":"482.108724ms","start":"2026-05-29T05:53:18.07405Z","end":"2026-05-29T05:53:18.556158Z","steps":["trace[1819731400] 'agreement among raft nodes before linearized reading' (duration: 481.904831ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:18.55621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.519485ms","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-29T05:53:18.556236Z","caller":"traceutil/trace.go:171","msg":"trace[1767398931] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1239; }","duration":"465.565627ms","start":"2026-05-29T05:53:18.090662Z","end":"2026-05-29T05:53:18.556228Z","steps":["trace[1767398931] 'agreement among raft nodes before linearized reading' (duration: 465.486875ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:18.556244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:18.074028Z","time spent":"482.191805ms","remote":"127.0.0.1:34498","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-29T05:53:18.556268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:18.090651Z","time spent":"465.611457ms","remote":"127.0.0.1:34498","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-29T05:53:18.556495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.208977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-29T05:53:18.556547Z","caller":"traceutil/trace.go:171","msg":"trace[1052452894] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1239; }","duration":"481.301889ms","start":"2026-05-29T05:53:18.075231Z","end":"2026-05-29T05:53:18.556532Z","steps":["trace[1052452894] 'agreement among raft nodes before linearized reading' (duration: 481.145056ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:18.556586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:18.075215Z","time spent":"481.35621ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-29T05:53:18.556704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.371351ms","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-29T05:53:18.556785Z","caller":"traceutil/trace.go:171","msg":"trace[689369132] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1239; }","duration":"480.491202ms","start":"2026-05-29T05:53:18.076273Z","end":"2026-05-29T05:53:18.556764Z","steps":["trace[689369132] 'agreement among raft nodes before linearized reading' (duration: 480.227058ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:18.556828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:18.076262Z","time spent":"480.558115ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-29T05:53:19.256042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.823223ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T05:53:19.256158Z","caller":"traceutil/trace.go:171","msg":"trace[740254333] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"694.891689ms","start":"2026-05-29T05:53:18.561245Z","end":"2026-05-29T05:53:19.256136Z","steps":["trace[740254333] 'process raft request' (duration: 478.879633ms)","trace[740254333] 'compare' (duration: 215.71233ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T05:53:19.256219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:18.561211Z","time spent":"694.98031ms","remote":"127.0.0.1:34498","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-29T05:53:19.293005Z","caller":"traceutil/trace.go:171","msg":"trace[594599431] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"731.006192ms","start":"2026-05-29T05:53:18.561979Z","end":"2026-05-29T05:53:19.292985Z","steps":["trace[594599431] 'process raft request' (duration: 730.9293ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:53:19.293047Z","caller":"traceutil/trace.go:171","msg":"trace[2109890879] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"731.304567ms","start":"2026-05-29T05:53:18.561707Z","end":"2026-05-29T05:53:19.293011Z","steps":["trace[2109890879] 'process raft request' (duration: 731.071363ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:19.29311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:18.561949Z","time spent":"731.110934ms","remote":"127.0.0.1:34498","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-29T05:53:19.293203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:18.561691Z","time spent":"731.425599ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T05:53:19.293354Z","caller":"traceutil/trace.go:171","msg":"trace[58574021] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"731.083283ms","start":"2026-05-29T05:53:18.562238Z","end":"2026-05-29T05:53:19.293321Z","steps":["trace[58574021] 'process raft request' (duration: 730.713346ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:53:19.293425Z","caller":"traceutil/trace.go:171","msg":"trace[1441104002] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"729.572465ms","start":"2026-05-29T05:53:18.563829Z","end":"2026-05-29T05:53:19.293401Z","steps":["trace[1441104002] 'process raft request' (duration: 729.410591ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:19.293521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:18.562223Z","time spent":"731.201327ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T05:53:19.293611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:18.563815Z","time spent":"729.716018ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T05:53:21.390732Z","caller":"traceutil/trace.go:171","msg":"trace[1612332610] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"125.176722ms","start":"2026-05-29T05:53:21.265524Z","end":"2026-05-29T05:53:21.3907Z","steps":["trace[1612332610] 'process raft request' (duration: 124.951158ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:53:22.471004Z","caller":"traceutil/trace.go:171","msg":"trace[1921995836] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"157.35402ms","start":"2026-05-29T05:53:22.31363Z","end":"2026-05-29T05:53:22.470984Z","steps":["trace[1921995836] 'process raft request' (duration: 157.224048ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:23.844431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.468549ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T05:53:23.84458Z","caller":"traceutil/trace.go:171","msg":"trace[701175476] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"350.172191ms","start":"2026-05-29T05:53:23.494386Z","end":"2026-05-29T05:53:23.844558Z","steps":["trace[701175476] 'process raft request' (duration: 38.474458ms)","trace[701175476] 'compare' (duration: 311.205164ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T05:53:23.844644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:23.494374Z","time spent":"350.238872ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T05:53:23.89253Z","caller":"traceutil/trace.go:171","msg":"trace[778877120] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"397.632753ms","start":"2026-05-29T05:53:23.494879Z","end":"2026-05-29T05:53:23.892512Z","steps":["trace[778877120] 'process raft request' (duration: 397.47864ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:23.892626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:23.494857Z","time spent":"397.726824ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T05:53:23.892809Z","caller":"traceutil/trace.go:171","msg":"trace[1332995386] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"397.683334ms","start":"2026-05-29T05:53:23.495107Z","end":"2026-05-29T05:53:23.89279Z","steps":["trace[1332995386] 'process raft request' (duration: 397.584522ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:53:23.892838Z","caller":"traceutil/trace.go:171","msg":"trace[438611493] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"397.949688ms","start":"2026-05-29T05:53:23.494861Z","end":"2026-05-29T05:53:23.892811Z","steps":["trace[438611493] 'process raft request' (duration: 397.611852ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:23.892931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:23.495087Z","time spent":"397.776136ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T05:53:23.892986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:23.494833Z","time spent":"398.065602ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T05:53:24.955694Z","caller":"traceutil/trace.go:171","msg":"trace[16031615] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"337.272974ms","start":"2026-05-29T05:53:24.618395Z","end":"2026-05-29T05:53:24.955668Z","steps":["trace[16031615] 'process raft request' (duration: 337.103459ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:24.955852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:24.61837Z","time spent":"337.402916ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T05:53:25.896765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.226461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-29T05:53:25.896845Z","caller":"traceutil/trace.go:171","msg":"trace[126184170] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1266; }","duration":"488.359964ms","start":"2026-05-29T05:53:25.408468Z","end":"2026-05-29T05:53:25.896828Z","steps":["trace[126184170] 'range keys from in-memory index tree' (duration: 488.037118ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:25.896882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:25.408447Z","time spent":"488.428146ms","remote":"127.0.0.1:34498","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-29T05:53:25.89689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.791433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T05:53:25.896945Z","caller":"traceutil/trace.go:171","msg":"trace[1236843237] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1266; }","duration":"413.890815ms","start":"2026-05-29T05:53:25.483039Z","end":"2026-05-29T05:53:25.89693Z","steps":["trace[1236843237] 'count revisions from in-memory index tree' (duration: 413.713932ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:25.89697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:25.48302Z","time spent":"413.944156ms","remote":"127.0.0.1:33742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "} {"level":"warn","ts":"2026-05-29T05:53:25.897108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.193558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-29T05:53:25.897222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.397701ms","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-29T05:53:25.897356Z","caller":"traceutil/trace.go:171","msg":"trace[1969563647] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1266; }","duration":"542.589485ms","start":"2026-05-29T05:53:25.354747Z","end":"2026-05-29T05:53:25.897337Z","steps":["trace[1969563647] 'count revisions from in-memory index tree' (duration: 542.31508ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:25.897397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:25.354726Z","time spent":"542.660356ms","remote":"127.0.0.1:34304","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":"info","ts":"2026-05-29T05:53:25.897591Z","caller":"traceutil/trace.go:171","msg":"trace[1911958477] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1266; }","duration":"405.429951ms","start":"2026-05-29T05:53:25.491841Z","end":"2026-05-29T05:53:25.897271Z","steps":["trace[1911958477] 'range keys from in-memory index tree' (duration: 405.124196ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:25.899727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:25.491826Z","time spent":"407.886739ms","remote":"127.0.0.1:34218","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-29T05:53:26.513974Z","caller":"traceutil/trace.go:171","msg":"trace[1245368362] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"106.78321ms","start":"2026-05-29T05:53:26.40716Z","end":"2026-05-29T05:53:26.513943Z","steps":["trace[1245368362] 'process raft request' (duration: 14.918646ms)","trace[1245368362] 'compare' (duration: 91.69402ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:53:27.634544Z","caller":"traceutil/trace.go:171","msg":"trace[1169892272] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"1.027136906s","start":"2026-05-29T05:53:26.607373Z","end":"2026-05-29T05:53:27.63451Z","steps":["trace[1169892272] 'process raft request' (duration: 931.906968ms)","trace[1169892272] 'compare' (duration: 94.865751ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T05:53:27.634717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:26.607353Z","time spent":"1.027281449s","remote":"127.0.0.1:34498","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-29T05:53:27.667213Z","caller":"traceutil/trace.go:171","msg":"trace[1240890042] linearizableReadLoop","detail":"{readStateIndex:1327; appliedIndex:1325; }","duration":"173.991639ms","start":"2026-05-29T05:53:27.493194Z","end":"2026-05-29T05:53:27.667185Z","steps":["trace[1240890042] 'read index received' (duration: 46.109155ms)","trace[1240890042] 'applied index is now lower than readState.Index' (duration: 127.881284ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T05:53:27.66741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.189853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T05:53:27.667456Z","caller":"traceutil/trace.go:171","msg":"trace[1834715551] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1275; }","duration":"174.283415ms","start":"2026-05-29T05:53:27.493159Z","end":"2026-05-29T05:53:27.667442Z","steps":["trace[1834715551] 'agreement among raft nodes before linearized reading' (duration: 174.127422ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:53:27.667773Z","caller":"traceutil/trace.go:171","msg":"trace[763366605] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"705.295919ms","start":"2026-05-29T05:53:26.962444Z","end":"2026-05-29T05:53:27.66774Z","steps":["trace[763366605] 'process raft request' (duration: 704.606925ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:27.667944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:26.96241Z","time spent":"705.445392ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T05:53:28.379609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.72998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-29T05:53:28.379701Z","caller":"traceutil/trace.go:171","msg":"trace[1518851382] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1275; }","duration":"378.889304ms","start":"2026-05-29T05:53:28.000786Z","end":"2026-05-29T05:53:28.379675Z","steps":["trace[1518851382] 'range keys from in-memory index tree' (duration: 378.504755ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:28.379773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:28.000757Z","time spent":"378.998065ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-29T05:53:28.379764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.453615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-29T05:53:28.379857Z","caller":"traceutil/trace.go:171","msg":"trace[1473525675] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1275; }","duration":"377.566977ms","start":"2026-05-29T05:53:28.00227Z","end":"2026-05-29T05:53:28.379837Z","steps":["trace[1473525675] 'range keys from in-memory index tree' (duration: 377.322932ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:28.379868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.052138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-29T05:53:28.379909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:28.002261Z","time spent":"377.635458ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-29T05:53:28.379938Z","caller":"traceutil/trace.go:171","msg":"trace[1528638590] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1275; }","duration":"377.155089ms","start":"2026-05-29T05:53:28.002766Z","end":"2026-05-29T05:53:28.379921Z","steps":["trace[1528638590] 'range keys from in-memory index tree' (duration: 376.858353ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:28.379946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.15108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-29T05:53:28.379979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:28.002745Z","time spent":"377.22498ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-29T05:53:28.380013Z","caller":"traceutil/trace.go:171","msg":"trace[1368497590] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1275; }","duration":"351.241352ms","start":"2026-05-29T05:53:28.028755Z","end":"2026-05-29T05:53:28.379996Z","steps":["trace[1368497590] 'count revisions from in-memory index tree' (duration: 351.073378ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:28.380063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:28.028741Z","time spent":"351.309814ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":13,"response size":30,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"warn","ts":"2026-05-29T05:53:28.380267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.81973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-29T05:53:28.380348Z","caller":"traceutil/trace.go:171","msg":"trace[1641854897] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1275; }","duration":"379.958734ms","start":"2026-05-29T05:53:28.000371Z","end":"2026-05-29T05:53:28.380329Z","steps":["trace[1641854897] 'range keys from in-memory index tree' (duration: 379.604146ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:28.380389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:28.000341Z","time spent":"380.038896ms","remote":"127.0.0.1:34498","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-29T05:53:28.379858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.003631ms","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-29T05:53:28.380472Z","caller":"traceutil/trace.go:171","msg":"trace[1194799524] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1275; }","duration":"459.762816ms","start":"2026-05-29T05:53:27.920693Z","end":"2026-05-29T05:53:28.380456Z","steps":["trace[1194799524] 'range keys from in-memory index tree' (duration: 458.842257ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:28.380517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:27.92067Z","time spent":"459.833597ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-29T05:53:28.934291Z","caller":"traceutil/trace.go:171","msg":"trace[216315063] transaction","detail":"{read_only:false; response_revision:1279; number_of_response:1; }","duration":"547.393157ms","start":"2026-05-29T05:53:28.386874Z","end":"2026-05-29T05:53:28.934267Z","steps":["trace[216315063] 'process raft request' (duration: 547.300475ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:53:28.934537Z","caller":"traceutil/trace.go:171","msg":"trace[1712490732] transaction","detail":"{read_only:false; response_revision:1280; number_of_response:1; }","duration":"547.596642ms","start":"2026-05-29T05:53:28.386909Z","end":"2026-05-29T05:53:28.934506Z","steps":["trace[1712490732] 'process raft request' (duration: 547.316606ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:28.934719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:28.386889Z","time spent":"547.723354ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T05:53:28.934337Z","caller":"traceutil/trace.go:171","msg":"trace[1420731998] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"547.567311ms","start":"2026-05-29T05:53:28.386701Z","end":"2026-05-29T05:53:28.934268Z","steps":["trace[1420731998] 'process raft request' (duration: 547.166774ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:28.935034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:28.386687Z","time spent":"548.234404ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T05:53:28.935228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:28.386865Z","time spent":"547.596552ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T05:53:30.1861Z","caller":"traceutil/trace.go:171","msg":"trace[1358898934] linearizableReadLoop","detail":"{readStateIndex:1333; appliedIndex:1332; }","duration":"355.997123ms","start":"2026-05-29T05:53:29.83008Z","end":"2026-05-29T05:53:30.186077Z","steps":["trace[1358898934] 'read index received' (duration: 355.8231ms)","trace[1358898934] 'applied index is now lower than readState.Index' (duration: 172.723µs)"],"step_count":2} {"level":"warn","ts":"2026-05-29T05:53:30.186349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.406411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-29T05:53:30.186394Z","caller":"traceutil/trace.go:171","msg":"trace[1495175225] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1281; }","duration":"207.508263ms","start":"2026-05-29T05:53:29.978875Z","end":"2026-05-29T05:53:30.186383Z","steps":["trace[1495175225] 'agreement among raft nodes before linearized reading' (duration: 207.408282ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:30.186436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.268089ms","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-29T05:53:30.186167Z","caller":"traceutil/trace.go:171","msg":"trace[1509625126] transaction","detail":"{read_only:false; response_revision:1281; number_of_response:1; }","duration":"512.202052ms","start":"2026-05-29T05:53:29.67393Z","end":"2026-05-29T05:53:30.186132Z","steps":["trace[1509625126] 'process raft request' (duration: 511.985338ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:53:30.186621Z","caller":"traceutil/trace.go:171","msg":"trace[717924225] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1281; }","duration":"356.554524ms","start":"2026-05-29T05:53:29.830037Z","end":"2026-05-29T05:53:30.186591Z","steps":["trace[717924225] 'agreement among raft nodes before linearized reading' (duration: 356.224377ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:30.186873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:29.83002Z","time spent":"356.784399ms","remote":"127.0.0.1:52976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-05-29T05:53:30.186945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:29.673904Z","time spent":"512.761484ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T05:53:30.999185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.296963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T05:53:30.999269Z","caller":"traceutil/trace.go:171","msg":"trace[721001987] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:1281; }","duration":"306.431126ms","start":"2026-05-29T05:53:30.692819Z","end":"2026-05-29T05:53:30.99925Z","steps":["trace[721001987] 'count revisions from in-memory index tree' (duration: 306.215732ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:30.999313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:30.692799Z","time spent":"306.502708ms","remote":"127.0.0.1:47136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-05-29T05:53:30.999436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.216903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T05:53:30.999488Z","caller":"traceutil/trace.go:171","msg":"trace[1965501852] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1281; }","duration":"507.314855ms","start":"2026-05-29T05:53:30.492161Z","end":"2026-05-29T05:53:30.999476Z","steps":["trace[1965501852] 'range keys from in-memory index tree' (duration: 507.124071ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:30.999511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:30.49214Z","time spent":"507.365916ms","remote":"127.0.0.1:34218","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-29T05:53:30.99964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.087861ms","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-29T05:53:30.999658Z","caller":"traceutil/trace.go:171","msg":"trace[1662869606] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1281; }","duration":"508.114973ms","start":"2026-05-29T05:53:30.491537Z","end":"2026-05-29T05:53:30.999652Z","steps":["trace[1662869606] 'range keys from in-memory index tree' (duration: 508.032801ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:30.999684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:30.491534Z","time spent":"508.137723ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-29T05:53:30.999818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.319836ms","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-29T05:53:30.999895Z","caller":"traceutil/trace.go:171","msg":"trace[1785413247] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1281; }","duration":"508.431009ms","start":"2026-05-29T05:53:30.491444Z","end":"2026-05-29T05:53:30.999875Z","steps":["trace[1785413247] 'range keys from in-memory index tree' (duration: 508.110433ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:30.999936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:30.491425Z","time spent":"508.502841ms","remote":"127.0.0.1:34498","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":"info","ts":"2026-05-29T05:53:31.36736Z","caller":"traceutil/trace.go:171","msg":"trace[468160947] transaction","detail":"{read_only:false; response_revision:1286; number_of_response:1; }","duration":"361.412717ms","start":"2026-05-29T05:53:31.00592Z","end":"2026-05-29T05:53:31.367333Z","steps":["trace[468160947] 'process raft request' (duration: 361.358086ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:53:31.367391Z","caller":"traceutil/trace.go:171","msg":"trace[1428113348] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"362.773276ms","start":"2026-05-29T05:53:31.004595Z","end":"2026-05-29T05:53:31.367368Z","steps":["trace[1428113348] 'process raft request' (duration: 362.557741ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:53:31.367659Z","caller":"traceutil/trace.go:171","msg":"trace[1228852949] transaction","detail":"{read_only:false; response_revision:1285; number_of_response:1; }","duration":"361.766105ms","start":"2026-05-29T05:53:31.005855Z","end":"2026-05-29T05:53:31.367621Z","steps":["trace[1228852949] 'process raft request' (duration: 361.388057ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:53:31.367652Z","caller":"traceutil/trace.go:171","msg":"trace[2064759961] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"363.44991ms","start":"2026-05-29T05:53:31.004177Z","end":"2026-05-29T05:53:31.367627Z","steps":["trace[2064759961] 'process raft request' (duration: 362.823477ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:53:31.36758Z","caller":"traceutil/trace.go:171","msg":"trace[1765737284] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"362.763566ms","start":"2026-05-29T05:53:31.004744Z","end":"2026-05-29T05:53:31.367508Z","steps":["trace[1765737284] 'process raft request' (duration: 362.46696ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:31.368578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:31.004733Z","time spent":"363.784388ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T05:53:31.367585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:31.005914Z","time spent":"361.520199ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T05:53:31.367776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:31.004583Z","time spent":"363.074563ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T05:53:31.36776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:31.005844Z","time spent":"361.855437ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T05:53:31.36783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:31.004159Z","time spent":"363.559852ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T05:53:31.422281Z","caller":"traceutil/trace.go:171","msg":"trace[128541586] linearizableReadLoop","detail":"{readStateIndex:1340; appliedIndex:1334; }","duration":"373.433194ms","start":"2026-05-29T05:53:31.04883Z","end":"2026-05-29T05:53:31.422264Z","steps":["trace[128541586] 'read index received' (duration: 318.108976ms)","trace[128541586] 'applied index is now lower than readState.Index' (duration: 55.323248ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:53:31.422504Z","caller":"traceutil/trace.go:171","msg":"trace[1937010865] transaction","detail":"{read_only:false; response_revision:1287; number_of_response:1; }","duration":"374.485606ms","start":"2026-05-29T05:53:31.047887Z","end":"2026-05-29T05:53:31.422373Z","steps":["trace[1937010865] 'process raft request' (duration: 374.292202ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:31.422547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.699149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-29T05:53:31.422641Z","caller":"traceutil/trace.go:171","msg":"trace[511291344] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1287; }","duration":"373.820312ms","start":"2026-05-29T05:53:31.048809Z","end":"2026-05-29T05:53:31.422629Z","steps":["trace[511291344] 'agreement among raft nodes before linearized reading' (duration: 373.556107ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:31.422708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:31.047877Z","time spent":"374.728491ms","remote":"127.0.0.1:34252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T05:53:31.422732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:31.048801Z","time spent":"373.918034ms","remote":"127.0.0.1:34564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":17,"response size":30,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"warn","ts":"2026-05-29T05:53:33.684139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"965.480475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-2chm2\" ","response":"range_response_count:1 size:11061"} {"level":"info","ts":"2026-05-29T05:53:33.684541Z","caller":"traceutil/trace.go:171","msg":"trace[430229962] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-2chm2; range_end:; response_count:1; response_revision:1295; }","duration":"965.900982ms","start":"2026-05-29T05:53:32.718619Z","end":"2026-05-29T05:53:33.68452Z","steps":["trace[430229962] 'range keys from in-memory index tree' (duration: 965.215207ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:33.684643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:32.718602Z","time spent":"966.026706ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":11084,"request content":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-2chm2\" "} {"level":"warn","ts":"2026-05-29T05:53:33.684257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.649686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-29T05:53:33.685126Z","caller":"traceutil/trace.go:171","msg":"trace[440090813] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1295; }","duration":"311.548605ms","start":"2026-05-29T05:53:33.373554Z","end":"2026-05-29T05:53:33.685102Z","steps":["trace[440090813] 'range keys from in-memory index tree' (duration: 310.471203ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:33.685266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:33.373549Z","time spent":"311.684848ms","remote":"127.0.0.1:34498","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-29T05:53:33.684381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.195442322s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-29T05:53:33.684839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.106616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-05-29T05:53:33.68472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.965393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-29T05:53:33.685589Z","caller":"traceutil/trace.go:171","msg":"trace[1853197577] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1295; }","duration":"311.896203ms","start":"2026-05-29T05:53:33.373673Z","end":"2026-05-29T05:53:33.685569Z","steps":["trace[1853197577] 'range keys from in-memory index tree' (duration: 310.016232ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:53:33.685601Z","caller":"traceutil/trace.go:171","msg":"trace[914628085] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1295; }","duration":"311.862102ms","start":"2026-05-29T05:53:33.373719Z","end":"2026-05-29T05:53:33.685581Z","steps":["trace[914628085] 'range keys from in-memory index tree' (duration: 310.271779ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:33.685671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:33.373676Z","time spent":"311.981235ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-29T05:53:33.684788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.320131ms","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-29T05:53:33.685536Z","caller":"traceutil/trace.go:171","msg":"trace[1855271734] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1295; }","duration":"1.196568976s","start":"2026-05-29T05:53:32.488904Z","end":"2026-05-29T05:53:33.685473Z","steps":["trace[1855271734] 'range keys from in-memory index tree' (duration: 1.195366971s)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:53:33.685798Z","caller":"traceutil/trace.go:171","msg":"trace[1755532657] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1295; }","duration":"312.356823ms","start":"2026-05-29T05:53:33.373431Z","end":"2026-05-29T05:53:33.685788Z","steps":["trace[1755532657] 'range keys from in-memory index tree' (duration: 310.554844ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:33.685837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:33.373412Z","time spent":"312.413704ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-29T05:53:33.685623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:33.373646Z","time spent":"311.967685ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-29T05:53:33.685877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:32.488852Z","time spent":"1.196960164s","remote":"127.0.0.1:34218","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-29T05:53:33.684015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.803169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-29T05:53:33.686139Z","caller":"traceutil/trace.go:171","msg":"trace[756526122] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1295; }","duration":"311.980215ms","start":"2026-05-29T05:53:33.374145Z","end":"2026-05-29T05:53:33.686125Z","steps":["trace[756526122] 'range keys from in-memory index tree' (duration: 309.624054ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:33.686223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:33.37412Z","time spent":"312.087737ms","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-29T05:53:36.380994Z","caller":"traceutil/trace.go:171","msg":"trace[1353462111] transaction","detail":"{read_only:false; response_revision:1325; number_of_response:1; }","duration":"176.308495ms","start":"2026-05-29T05:53:36.204646Z","end":"2026-05-29T05:53:36.380955Z","steps":["trace[1353462111] 'process raft request' (duration: 176.105381ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:41.552073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"652.6473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-29T05:53:41.552127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.067017806s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-05-29T05:53:41.552218Z","caller":"traceutil/trace.go:171","msg":"trace[468413641] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1368; }","duration":"1.067167129s","start":"2026-05-29T05:53:40.485026Z","end":"2026-05-29T05:53:41.552193Z","steps":["trace[468413641] 'range keys from in-memory index tree' (duration: 1.066829272s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:41.552273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:40.485001Z","time spent":"1.067260391s","remote":"127.0.0.1:34498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-05-29T05:53:41.552271Z","caller":"traceutil/trace.go:171","msg":"trace[661649834] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1368; }","duration":"652.910066ms","start":"2026-05-29T05:53:40.899339Z","end":"2026-05-29T05:53:41.552249Z","steps":["trace[661649834] 'count revisions from in-memory index tree' (duration: 652.528747ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:41.552324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:40.899315Z","time spent":"652.997548ms","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":45,"response size":30,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"warn","ts":"2026-05-29T05:53:41.552597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"876.787354ms","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-29T05:53:41.55265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.061058438s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T05:53:41.552681Z","caller":"traceutil/trace.go:171","msg":"trace[800405440] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1368; }","duration":"876.903897ms","start":"2026-05-29T05:53:40.675744Z","end":"2026-05-29T05:53:41.552648Z","steps":["trace[800405440] 'count revisions from in-memory index tree' (duration: 876.655052ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:53:41.55273Z","caller":"traceutil/trace.go:171","msg":"trace[1532722535] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1368; }","duration":"1.061184151s","start":"2026-05-29T05:53:40.491527Z","end":"2026-05-29T05:53:41.552712Z","steps":["trace[1532722535] 'range keys from in-memory index tree' (duration: 1.060974827s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:41.552739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:40.675722Z","time spent":"876.999528ms","remote":"127.0.0.1:52932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-29T05:53:41.552798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:40.491511Z","time spent":"1.061277144s","remote":"127.0.0.1:34218","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-29T05:53:41.552867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.707707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.113\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-29T05:53:41.55291Z","caller":"traceutil/trace.go:171","msg":"trace[1576168704] range","detail":"{range_begin:/registry/masterleases/199.204.45.113; range_end:; response_count:1; response_revision:1368; }","duration":"579.793329ms","start":"2026-05-29T05:53:40.973103Z","end":"2026-05-29T05:53:41.552896Z","steps":["trace[1576168704] 'range keys from in-memory index tree' (duration: 579.417591ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:41.55294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:40.973077Z","time spent":"579.855601ms","remote":"127.0.0.1:34252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.113\" "} {"level":"info","ts":"2026-05-29T05:57:21.065443Z","caller":"traceutil/trace.go:171","msg":"trace[239375195] transaction","detail":"{read_only:false; response_revision:2405; number_of_response:1; }","duration":"101.556635ms","start":"2026-05-29T05:57:20.96386Z","end":"2026-05-29T05:57:21.065417Z","steps":["trace[239375195] 'process raft request' (duration: 79.210185ms)","trace[239375195] 'compare' (duration: 22.120796ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T05:57:21.407173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.817749ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T05:57:21.407298Z","caller":"traceutil/trace.go:171","msg":"trace[832496411] transaction","detail":"{read_only:false; response_revision:2409; number_of_response:1; }","duration":"136.916977ms","start":"2026-05-29T05:57:21.270357Z","end":"2026-05-29T05:57:21.407274Z","steps":["trace[832496411] 'process raft request' (duration: 19.900284ms)","trace[832496411] 'compare' (duration: 116.567985ms)"],"step_count":2}