{"level":"warn","ts":"2026-04-08T06:12:01.938493Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-08T06:12:01.938589Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.78: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.78:2380","--initial-cluster=instance=https://199.204.45.78:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.78:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.78:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-08T06:12:01.938667Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-08T06:12:01.938678Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.78:2380"]} {"level":"info","ts":"2026-04-08T06:12:01.938694Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-08T06:12:01.939255Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"]} {"level":"info","ts":"2026-04-08T06:12:01.939329Z","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.78:2380"],"listen-peer-urls":["https://199.204.45.78:2380"],"advertise-client-urls":["https://199.204.45.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.78:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-08T06:12:01.943221Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.692085ms"} {"level":"info","ts":"2026-04-08T06:12:01.954451Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6eb8766b1ec86e92","cluster-id":"9bbfe9e5d45d3718"} {"level":"info","ts":"2026-04-08T06:12:01.954547Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=()"} {"level":"info","ts":"2026-04-08T06:12:01.954574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became follower at term 0"} {"level":"info","ts":"2026-04-08T06:12:01.954591Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6eb8766b1ec86e92 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-08T06:12:01.954601Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became follower at term 1"} {"level":"info","ts":"2026-04-08T06:12:01.954645Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=(7978256942336863890)"} {"level":"warn","ts":"2026-04-08T06:12:01.963722Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-08T06:12:01.969605Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-08T06:12:01.972315Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-08T06:12:01.975528Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6eb8766b1ec86e92","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-08T06:12:01.975693Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6eb8766b1ec86e92","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-08T06:12:01.975815Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-08T06:12:01.975897Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-08T06:12:01.975904Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-08T06:12:01.976608Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=(7978256942336863890)"} {"level":"info","ts":"2026-04-08T06:12:01.976708Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9bbfe9e5d45d3718","local-member-id":"6eb8766b1ec86e92","added-peer-id":"6eb8766b1ec86e92","added-peer-peer-urls":["https://199.204.45.78:2380"]} {"level":"info","ts":"2026-04-08T06:12:01.977661Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-08T06:12:01.97782Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6eb8766b1ec86e92","initial-advertise-peer-urls":["https://199.204.45.78:2380"],"listen-peer-urls":["https://199.204.45.78:2380"],"advertise-client-urls":["https://199.204.45.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-08T06:12:01.977843Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-08T06:12:01.977919Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.78:2380"} {"level":"info","ts":"2026-04-08T06:12:01.97793Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.78:2380"} {"level":"info","ts":"2026-04-08T06:12:02.055235Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 is starting a new election at term 1"} {"level":"info","ts":"2026-04-08T06:12:02.055267Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-08T06:12:02.055286Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 received MsgPreVoteResp from 6eb8766b1ec86e92 at term 1"} {"level":"info","ts":"2026-04-08T06:12:02.055296Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became candidate at term 2"} {"level":"info","ts":"2026-04-08T06:12:02.055301Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 received MsgVoteResp from 6eb8766b1ec86e92 at term 2"} {"level":"info","ts":"2026-04-08T06:12:02.055309Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became leader at term 2"} {"level":"info","ts":"2026-04-08T06:12:02.055318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6eb8766b1ec86e92 elected leader 6eb8766b1ec86e92 at term 2"} {"level":"info","ts":"2026-04-08T06:12:02.05605Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6eb8766b1ec86e92","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.78:2379]}","request-path":"/0/members/6eb8766b1ec86e92/attributes","cluster-id":"9bbfe9e5d45d3718","publish-timeout":"7s"} {"level":"info","ts":"2026-04-08T06:12:02.056131Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T06:12:02.056302Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T06:12:02.056346Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T06:12:02.05671Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-08T06:12:02.056872Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-08T06:12:02.057187Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9bbfe9e5d45d3718","local-member-id":"6eb8766b1ec86e92","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T06:12:02.057393Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T06:12:02.057457Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T06:12:02.057812Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.78:2379"} {"level":"info","ts":"2026-04-08T06:12:02.059662Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-08T06:12:04.025871Z","caller":"traceutil/trace.go:171","msg":"trace[1058211517] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"194.007444ms","start":"2026-04-08T06:12:03.831839Z","end":"2026-04-08T06:12:04.025846Z","steps":["trace[1058211517] 'process raft request' (duration: 127.275643ms)","trace[1058211517] 'compare' (duration: 66.596799ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:12:04.027295Z","caller":"traceutil/trace.go:171","msg":"trace[1358043931] linearizableReadLoop","detail":"{readStateIndex:24; appliedIndex:22; }","duration":"156.619008ms","start":"2026-04-08T06:12:03.870612Z","end":"2026-04-08T06:12:04.027231Z","steps":["trace[1358043931] 'read index received' (duration: 88.659059ms)","trace[1358043931] 'applied index is now lower than readState.Index' (duration: 67.957599ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:12:04.027716Z","caller":"traceutil/trace.go:171","msg":"trace[948273588] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"188.055774ms","start":"2026-04-08T06:12:03.839618Z","end":"2026-04-08T06:12:04.027674Z","steps":["trace[948273588] 'process raft request' (duration: 187.000429ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:04.02785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.870896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3490"} {"level":"info","ts":"2026-04-08T06:12:04.028046Z","caller":"traceutil/trace.go:171","msg":"trace[1831656354] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:20; }","duration":"197.095919ms","start":"2026-04-08T06:12:03.830906Z","end":"2026-04-08T06:12:04.028002Z","steps":["trace[1831656354] 'agreement among raft nodes before linearized reading' (duration: 196.771134ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:04.048617Z","caller":"traceutil/trace.go:171","msg":"trace[1650982088] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"174.967718ms","start":"2026-04-08T06:12:03.87362Z","end":"2026-04-08T06:12:04.048587Z","steps":["trace[1650982088] 'process raft request' (duration: 174.723755ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:04.048711Z","caller":"traceutil/trace.go:171","msg":"trace[1019984186] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"173.900864ms","start":"2026-04-08T06:12:03.874791Z","end":"2026-04-08T06:12:04.048692Z","steps":["trace[1019984186] 'process raft request' (duration: 173.763581ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:04.048757Z","caller":"traceutil/trace.go:171","msg":"trace[1472426320] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"160.640896ms","start":"2026-04-08T06:12:03.888089Z","end":"2026-04-08T06:12:04.04873Z","steps":["trace[1472426320] 'process raft request' (duration: 160.574654ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:04.048762Z","caller":"traceutil/trace.go:171","msg":"trace[955544588] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"173.773012ms","start":"2026-04-08T06:12:03.874955Z","end":"2026-04-08T06:12:04.048728Z","steps":["trace[955544588] 'process raft request' (duration: 173.631219ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:04.04883Z","caller":"traceutil/trace.go:171","msg":"trace[1100646635] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"173.786071ms","start":"2026-04-08T06:12:03.875017Z","end":"2026-04-08T06:12:04.048804Z","steps":["trace[1100646635] 'process raft request' (duration: 173.604978ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:04.048703Z","caller":"traceutil/trace.go:171","msg":"trace[1550933464] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"173.976095ms","start":"2026-04-08T06:12:03.874698Z","end":"2026-04-08T06:12:04.048674Z","steps":["trace[1550933464] 'process raft request' (duration: 173.798762ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:04.049229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.72223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-04-08T06:12:04.049281Z","caller":"traceutil/trace.go:171","msg":"trace[1125687519] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:26; }","duration":"175.821422ms","start":"2026-04-08T06:12:03.873446Z","end":"2026-04-08T06:12:04.049268Z","steps":["trace[1125687519] 'agreement among raft nodes before linearized reading' (duration: 175.634769ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:04.049289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.806712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-08T06:12:04.049344Z","caller":"traceutil/trace.go:171","msg":"trace[1937413148] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:26; }","duration":"101.901573ms","start":"2026-04-08T06:12:03.947426Z","end":"2026-04-08T06:12:04.049327Z","steps":["trace[1937413148] 'agreement among raft nodes before linearized reading' (duration: 101.68198ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:04.049378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.608844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-08T06:12:04.04948Z","caller":"traceutil/trace.go:171","msg":"trace[309330376] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:26; }","duration":"174.749476ms","start":"2026-04-08T06:12:03.874714Z","end":"2026-04-08T06:12:04.049463Z","steps":["trace[309330376] 'agreement among raft nodes before linearized reading' (duration: 174.589444ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:05.81625Z","caller":"traceutil/trace.go:171","msg":"trace[2121940679] transaction","detail":"{read_only:false; response_revision:163; number_of_response:1; }","duration":"122.7701ms","start":"2026-04-08T06:12:05.693439Z","end":"2026-04-08T06:12:05.816209Z","steps":["trace[2121940679] 'process raft request' (duration: 64.819956ms)","trace[2121940679] 'compare' (duration: 57.701071ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:12:06.084063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.697982ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T06:12:06.084347Z","caller":"traceutil/trace.go:171","msg":"trace[363434121] transaction","detail":"{read_only:false; response_revision:171; number_of_response:1; }","duration":"168.182996ms","start":"2026-04-08T06:12:05.916124Z","end":"2026-04-08T06:12:06.084307Z","steps":["trace[363434121] 'process raft request' (duration: 32.657372ms)","trace[363434121] 'compare' (duration: 134.54344ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:12:06.470051Z","caller":"traceutil/trace.go:171","msg":"trace[1766775568] transaction","detail":"{read_only:false; response_revision:183; number_of_response:1; }","duration":"143.384097ms","start":"2026-04-08T06:12:06.32664Z","end":"2026-04-08T06:12:06.470024Z","steps":["trace[1766775568] 'process raft request' (duration: 83.08894ms)","trace[1766775568] 'compare' (duration: 60.179095ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:12:08.735257Z","caller":"traceutil/trace.go:171","msg":"trace[14164149] linearizableReadLoop","detail":"{readStateIndex:261; appliedIndex:260; }","duration":"108.714005ms","start":"2026-04-08T06:12:08.626508Z","end":"2026-04-08T06:12:08.735222Z","steps":["trace[14164149] 'read index received' (duration: 102.011638ms)","trace[14164149] 'applied index is now lower than readState.Index' (duration: 6.701247ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:12:08.735292Z","caller":"traceutil/trace.go:171","msg":"trace[2135290553] transaction","detail":"{read_only:false; response_revision:255; number_of_response:1; }","duration":"115.16909ms","start":"2026-04-08T06:12:08.620075Z","end":"2026-04-08T06:12:08.735244Z","steps":["trace[2135290553] 'process raft request' (duration: 108.427602ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:08.735498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.515246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-04-08T06:12:08.735569Z","caller":"traceutil/trace.go:171","msg":"trace[268104195] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:255; }","duration":"115.648258ms","start":"2026-04-08T06:12:08.619901Z","end":"2026-04-08T06:12:08.73555Z","steps":["trace[268104195] 'agreement among raft nodes before linearized reading' (duration: 115.433494ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:08.73655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.398136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4016"} {"level":"info","ts":"2026-04-08T06:12:08.736618Z","caller":"traceutil/trace.go:171","msg":"trace[1932342387] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:256; }","duration":"107.508728ms","start":"2026-04-08T06:12:08.62909Z","end":"2026-04-08T06:12:08.736599Z","steps":["trace[1932342387] 'agreement among raft nodes before linearized reading' (duration: 107.384806ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:08.73701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.645136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-04-08T06:12:08.737072Z","caller":"traceutil/trace.go:171","msg":"trace[743760903] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:256; }","duration":"106.730077ms","start":"2026-04-08T06:12:08.630323Z","end":"2026-04-08T06:12:08.737053Z","steps":["trace[743760903] 'agreement among raft nodes before linearized reading' (duration: 106.628715ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:09.983191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.899784ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T06:12:09.983274Z","caller":"traceutil/trace.go:171","msg":"trace[2109235] linearizableReadLoop","detail":"{readStateIndex:289; appliedIndex:288; }","duration":"202.572944ms","start":"2026-04-08T06:12:09.78069Z","end":"2026-04-08T06:12:09.983263Z","steps":["trace[2109235] 'read index received' (duration: 95.214723ms)","trace[2109235] 'applied index is now lower than readState.Index' (duration: 107.357501ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:12:09.983357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.673406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:12:09.983382Z","caller":"traceutil/trace.go:171","msg":"trace[1213623597] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:0; response_revision:278; }","duration":"202.745616ms","start":"2026-04-08T06:12:09.780626Z","end":"2026-04-08T06:12:09.983371Z","steps":["trace[1213623597] 'agreement among raft nodes before linearized reading' (duration: 202.706266ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:09.983392Z","caller":"traceutil/trace.go:171","msg":"trace[1512390538] transaction","detail":"{read_only:false; response_revision:278; number_of_response:1; }","duration":"209.240312ms","start":"2026-04-08T06:12:09.774083Z","end":"2026-04-08T06:12:09.983323Z","steps":["trace[1512390538] 'process raft request' (duration: 101.77488ms)","trace[1512390538] 'compare' (duration: 106.741662ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:12:09.983555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.743358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-08T06:12:09.98359Z","caller":"traceutil/trace.go:171","msg":"trace[632048834] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:278; }","duration":"125.766788ms","start":"2026-04-08T06:12:09.857807Z","end":"2026-04-08T06:12:09.983573Z","steps":["trace[632048834] 'agreement among raft nodes before linearized reading' (duration: 125.722288ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:18.653293Z","caller":"traceutil/trace.go:171","msg":"trace[1911584927] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"217.510447ms","start":"2026-04-08T06:12:18.435543Z","end":"2026-04-08T06:12:18.653053Z","steps":["trace[1911584927] 'process raft request' (duration: 212.511916ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:18.821821Z","caller":"traceutil/trace.go:171","msg":"trace[1700342784] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"138.63101ms","start":"2026-04-08T06:12:18.683159Z","end":"2026-04-08T06:12:18.82179Z","steps":["trace[1700342784] 'process raft request' (duration: 129.003295ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:25.172736Z","caller":"traceutil/trace.go:171","msg":"trace[766162573] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"102.008028ms","start":"2026-04-08T06:12:25.070708Z","end":"2026-04-08T06:12:25.172716Z","steps":["trace[766162573] 'process raft request' (duration: 101.864786ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:26.020288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"773.1052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:12:26.020368Z","caller":"traceutil/trace.go:171","msg":"trace[1898677974] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:390; }","duration":"773.246252ms","start":"2026-04-08T06:12:25.247102Z","end":"2026-04-08T06:12:26.020348Z","steps":["trace[1898677974] 'range keys from in-memory index tree' (duration: 772.941698ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:26.020408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:12:25.247073Z","time spent":"773.327453ms","remote":"127.0.0.1:38508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-08T06:12:31.168108Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967603776747939285,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-08T06:12:31.211661Z","caller":"traceutil/trace.go:171","msg":"trace[1329013571] linearizableReadLoop","detail":"{readStateIndex:449; appliedIndex:448; }","duration":"543.622407ms","start":"2026-04-08T06:12:30.668014Z","end":"2026-04-08T06:12:31.211636Z","steps":["trace[1329013571] 'read index received' (duration: 543.352736ms)","trace[1329013571] 'applied index is now lower than readState.Index' (duration: 268.591µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:12:31.211759Z","caller":"traceutil/trace.go:171","msg":"trace[1119254923] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"896.373648ms","start":"2026-04-08T06:12:30.315361Z","end":"2026-04-08T06:12:31.211735Z","steps":["trace[1119254923] 'process raft request' (duration: 896.087496ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:31.211873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:12:30.315337Z","time spent":"896.473733ms","remote":"127.0.0.1:38790","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T06:12:31.211939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.857557ms","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-04-08T06:12:31.212079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.425665ms","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-04-08T06:12:31.212122Z","caller":"traceutil/trace.go:171","msg":"trace[308724416] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:432; }","duration":"544.108508ms","start":"2026-04-08T06:12:30.667993Z","end":"2026-04-08T06:12:31.212101Z","steps":["trace[308724416] 'agreement among raft nodes before linearized reading' (duration: 543.757403ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:31.212139Z","caller":"traceutil/trace.go:171","msg":"trace[578850882] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:432; }","duration":"379.53801ms","start":"2026-04-08T06:12:30.832584Z","end":"2026-04-08T06:12:31.212122Z","steps":["trace[578850882] 'agreement among raft nodes before linearized reading' (duration: 379.397404ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:31.212184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:12:30.667925Z","time spent":"544.244974ms","remote":"127.0.0.1:38790","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-04-08T06:12:31.212183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:12:30.832554Z","time spent":"379.615744ms","remote":"127.0.0.1:38790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-08T06:12:42.210255Z","caller":"traceutil/trace.go:171","msg":"trace[1676429772] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"195.769539ms","start":"2026-04-08T06:12:42.014449Z","end":"2026-04-08T06:12:42.210219Z","steps":["trace[1676429772] 'process raft request' (duration: 195.434927ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:42.210596Z","caller":"traceutil/trace.go:171","msg":"trace[549700246] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"185.501617ms","start":"2026-04-08T06:12:42.02508Z","end":"2026-04-08T06:12:42.210582Z","steps":["trace[549700246] 'process raft request' (duration: 185.036429ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:42.211106Z","caller":"traceutil/trace.go:171","msg":"trace[1791761312] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"125.522ms","start":"2026-04-08T06:12:42.085557Z","end":"2026-04-08T06:12:42.211079Z","steps":["trace[1791761312] 'process raft request' (duration: 125.134955ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:42.211195Z","caller":"traceutil/trace.go:171","msg":"trace[105245159] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"123.825884ms","start":"2026-04-08T06:12:42.087341Z","end":"2026-04-08T06:12:42.211167Z","steps":["trace[105245159] 'process raft request' (duration: 123.520172ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:42.211237Z","caller":"traceutil/trace.go:171","msg":"trace[668419551] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"125.166384ms","start":"2026-04-08T06:12:42.086039Z","end":"2026-04-08T06:12:42.211206Z","steps":["trace[668419551] 'process raft request' (duration: 124.758929ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:42.211299Z","caller":"traceutil/trace.go:171","msg":"trace[1757733172] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"167.119715ms","start":"2026-04-08T06:12:42.044139Z","end":"2026-04-08T06:12:42.211259Z","steps":["trace[1757733172] 'process raft request' (duration: 166.247573ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:42.211351Z","caller":"traceutil/trace.go:171","msg":"trace[82950951] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"156.502841ms","start":"2026-04-08T06:12:42.054827Z","end":"2026-04-08T06:12:42.211329Z","steps":["trace[82950951] 'process raft request' (duration: 155.765313ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:42.211378Z","caller":"traceutil/trace.go:171","msg":"trace[803940969] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"159.231214ms","start":"2026-04-08T06:12:42.052133Z","end":"2026-04-08T06:12:42.211364Z","steps":["trace[803940969] 'process raft request' (duration: 158.300639ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:42.211404Z","caller":"traceutil/trace.go:171","msg":"trace[1788061401] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"183.416958ms","start":"2026-04-08T06:12:42.027975Z","end":"2026-04-08T06:12:42.211392Z","steps":["trace[1788061401] 'process raft request' (duration: 182.354287ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:42.211475Z","caller":"traceutil/trace.go:171","msg":"trace[2145530462] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"159.263805ms","start":"2026-04-08T06:12:42.052202Z","end":"2026-04-08T06:12:42.211465Z","steps":["trace[2145530462] 'process raft request' (duration: 158.277218ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:42.211434Z","caller":"traceutil/trace.go:171","msg":"trace[1136127683] transaction","detail":"{read_only:false; number_of_response:1; response_revision:505; }","duration":"122.790594ms","start":"2026-04-08T06:12:42.08861Z","end":"2026-04-08T06:12:42.211401Z","steps":["trace[1136127683] 'process raft request' (duration: 122.314236ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:42.211481Z","caller":"traceutil/trace.go:171","msg":"trace[1998719633] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"135.818071ms","start":"2026-04-08T06:12:42.075647Z","end":"2026-04-08T06:12:42.211465Z","steps":["trace[1998719633] 'process raft request' (duration: 134.99753ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:42.210901Z","caller":"traceutil/trace.go:171","msg":"trace[1204740822] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"156.278963ms","start":"2026-04-08T06:12:42.05458Z","end":"2026-04-08T06:12:42.210859Z","steps":["trace[1204740822] 'process raft request' (duration: 155.956371ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:42.368169Z","caller":"traceutil/trace.go:171","msg":"trace[1796167137] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"152.694895ms","start":"2026-04-08T06:12:42.215432Z","end":"2026-04-08T06:12:42.368127Z","steps":["trace[1796167137] 'process raft request' (duration: 99.927292ms)","trace[1796167137] 'compare' (duration: 52.577536ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:12:42.374536Z","caller":"traceutil/trace.go:171","msg":"trace[880173176] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"143.197625ms","start":"2026-04-08T06:12:42.231285Z","end":"2026-04-08T06:12:42.374483Z","steps":["trace[880173176] 'process raft request' (duration: 143.152333ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:42.37457Z","caller":"traceutil/trace.go:171","msg":"trace[736449178] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"150.281084ms","start":"2026-04-08T06:12:42.224256Z","end":"2026-04-08T06:12:42.374537Z","steps":["trace[736449178] 'process raft request' (duration: 150.051415ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:42.374946Z","caller":"traceutil/trace.go:171","msg":"trace[368872923] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"143.574649ms","start":"2026-04-08T06:12:42.231366Z","end":"2026-04-08T06:12:42.37494Z","steps":["trace[368872923] 'process raft request' (duration: 143.091071ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:42.375087Z","caller":"traceutil/trace.go:171","msg":"trace[1512284378] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"143.63432ms","start":"2026-04-08T06:12:42.231421Z","end":"2026-04-08T06:12:42.375055Z","steps":["trace[1512284378] 'process raft request' (duration: 143.504475ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:42.375173Z","caller":"traceutil/trace.go:171","msg":"trace[1258259718] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"143.739255ms","start":"2026-04-08T06:12:42.231339Z","end":"2026-04-08T06:12:42.375079Z","steps":["trace[1258259718] 'process raft request' (duration: 143.454165ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:42.375502Z","caller":"traceutil/trace.go:171","msg":"trace[295113504] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"123.726481ms","start":"2026-04-08T06:12:42.251762Z","end":"2026-04-08T06:12:42.375489Z","steps":["trace[295113504] 'process raft request' (duration: 123.646378ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:42.375571Z","caller":"traceutil/trace.go:171","msg":"trace[1437709255] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"131.712315ms","start":"2026-04-08T06:12:42.243845Z","end":"2026-04-08T06:12:42.375557Z","steps":["trace[1437709255] 'process raft request' (duration: 131.141094ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:42.375618Z","caller":"traceutil/trace.go:171","msg":"trace[1218477813] linearizableReadLoop","detail":"{readStateIndex:537; appliedIndex:528; }","duration":"123.671338ms","start":"2026-04-08T06:12:42.251932Z","end":"2026-04-08T06:12:42.375603Z","steps":["trace[1218477813] 'read index received' (duration: 63.429559ms)","trace[1218477813] 'applied index is now lower than readState.Index' (duration: 60.214108ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:12:42.375495Z","caller":"traceutil/trace.go:171","msg":"trace[1071497371] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"127.668762ms","start":"2026-04-08T06:12:42.247813Z","end":"2026-04-08T06:12:42.375482Z","steps":["trace[1071497371] 'process raft request' (duration: 127.478504ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:42.375744Z","caller":"traceutil/trace.go:171","msg":"trace[745304127] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"118.586914ms","start":"2026-04-08T06:12:42.257147Z","end":"2026-04-08T06:12:42.375734Z","steps":["trace[745304127] 'process raft request' (duration: 118.300903ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:42.375766Z","caller":"traceutil/trace.go:171","msg":"trace[301644729] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"118.532382ms","start":"2026-04-08T06:12:42.257219Z","end":"2026-04-08T06:12:42.375752Z","steps":["trace[301644729] 'process raft request' (duration: 118.266472ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:42.375937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.950798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:12:42.376707Z","caller":"traceutil/trace.go:171","msg":"trace[1390387069] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:519; }","duration":"124.79064ms","start":"2026-04-08T06:12:42.251904Z","end":"2026-04-08T06:12:42.376695Z","steps":["trace[1390387069] 'agreement among raft nodes before linearized reading' (duration: 123.742761ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:45.250165Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967603776747939568,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-08T06:12:45.750345Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967603776747939568,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-08T06:12:45.809862Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.123108791s","expected-duration":"1s"} {"level":"info","ts":"2026-04-08T06:12:45.810443Z","caller":"traceutil/trace.go:171","msg":"trace[1363500012] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"1.123810757s","start":"2026-04-08T06:12:44.686587Z","end":"2026-04-08T06:12:45.810398Z","steps":["trace[1363500012] 'process raft request' (duration: 1.12364475s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:45.810735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:12:44.686556Z","time spent":"1.124002634s","remote":"127.0.0.1:38544","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9343,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T06:12:45.860576Z","caller":"traceutil/trace.go:171","msg":"trace[616860889] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:617; }","duration":"1.111018452s","start":"2026-04-08T06:12:44.749536Z","end":"2026-04-08T06:12:45.860554Z","steps":["trace[616860889] 'read index received' (duration: 1.06062077s)","trace[616860889] 'applied index is now lower than readState.Index' (duration: 50.396642ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:12:45.860623Z","caller":"traceutil/trace.go:171","msg":"trace[1592616069] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"860.469001ms","start":"2026-04-08T06:12:45.000128Z","end":"2026-04-08T06:12:45.860597Z","steps":["trace[1592616069] 'process raft request' (duration: 860.287025ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:45.860694Z","caller":"traceutil/trace.go:171","msg":"trace[1660192853] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"176.161313ms","start":"2026-04-08T06:12:45.684521Z","end":"2026-04-08T06:12:45.860682Z","steps":["trace[1660192853] 'process raft request' (duration: 175.982097ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:45.860561Z","caller":"traceutil/trace.go:171","msg":"trace[892553250] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"975.077456ms","start":"2026-04-08T06:12:44.885432Z","end":"2026-04-08T06:12:45.860509Z","steps":["trace[892553250] 'process raft request' (duration: 974.849938ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:45.860814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:12:45.000112Z","time spent":"860.580585ms","remote":"127.0.0.1:38790","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T06:12:45.860896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:12:44.885403Z","time spent":"975.403628ms","remote":"127.0.0.1:38544","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T06:12:45.86095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.111375285s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-8n4dd\" ","response":"range_response_count:1 size:4884"} {"level":"info","ts":"2026-04-08T06:12:45.861138Z","caller":"traceutil/trace.go:171","msg":"trace[461020330] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-8n4dd; range_end:; response_count:1; response_revision:599; }","duration":"1.111573432s","start":"2026-04-08T06:12:44.749528Z","end":"2026-04-08T06:12:45.861101Z","steps":["trace[461020330] 'agreement among raft nodes before linearized reading' (duration: 1.111176657s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:45.861188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:12:44.749462Z","time spent":"1.111716108s","remote":"127.0.0.1:38696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":4907,"request content":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-8n4dd\" "} {"level":"info","ts":"2026-04-08T06:12:45.860699Z","caller":"traceutil/trace.go:171","msg":"trace[1303119933] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"772.489422ms","start":"2026-04-08T06:12:45.088159Z","end":"2026-04-08T06:12:45.860649Z","steps":["trace[1303119933] 'process raft request' (duration: 772.309116ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:45.861305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:12:45.088152Z","time spent":"773.124696ms","remote":"127.0.0.1:38544","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12244,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T06:12:45.866515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"618.290926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:12:45.8666Z","caller":"traceutil/trace.go:171","msg":"trace[304246174] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:600; }","duration":"618.43689ms","start":"2026-04-08T06:12:45.248143Z","end":"2026-04-08T06:12:45.86658Z","steps":["trace[304246174] 'agreement among raft nodes before linearized reading' (duration: 618.282295ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:45.866712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:12:45.248118Z","time spent":"618.585086ms","remote":"127.0.0.1:38508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-08T06:12:45.866724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.293462ms","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-04-08T06:12:45.866775Z","caller":"traceutil/trace.go:171","msg":"trace[603402858] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:600; }","duration":"563.368205ms","start":"2026-04-08T06:12:45.303393Z","end":"2026-04-08T06:12:45.866761Z","steps":["trace[603402858] 'agreement among raft nodes before linearized reading' (duration: 563.189078ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:45.866817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:12:45.303381Z","time spent":"563.428518ms","remote":"127.0.0.1:38790","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-04-08T06:12:45.867069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.835984ms","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-04-08T06:12:45.867109Z","caller":"traceutil/trace.go:171","msg":"trace[852586721] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:600; }","duration":"391.920647ms","start":"2026-04-08T06:12:45.475178Z","end":"2026-04-08T06:12:45.867099Z","steps":["trace[852586721] 'agreement among raft nodes before linearized reading' (duration: 391.808143ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:45.867138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:12:45.475151Z","time spent":"391.98129ms","remote":"127.0.0.1:38790","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-04-08T06:12:45.867116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.181634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-08T06:12:45.867175Z","caller":"traceutil/trace.go:171","msg":"trace[1665235864] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:600; }","duration":"568.289158ms","start":"2026-04-08T06:12:45.298878Z","end":"2026-04-08T06:12:45.867167Z","steps":["trace[1665235864] 'agreement among raft nodes before linearized reading' (duration: 568.179204ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:45.867204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:12:45.298853Z","time spent":"568.34386ms","remote":"127.0.0.1:38790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-08T06:12:45.867269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.485738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:12:45.867295Z","caller":"traceutil/trace.go:171","msg":"trace[1204802750] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:600; }","duration":"584.551341ms","start":"2026-04-08T06:12:45.282734Z","end":"2026-04-08T06:12:45.867286Z","steps":["trace[1204802750] 'agreement among raft nodes before linearized reading' (duration: 584.51924ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:45.867319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:12:45.282709Z","time spent":"584.606363ms","remote":"127.0.0.1:38544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-04-08T06:12:45.867363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.082456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:12:45.867456Z","caller":"traceutil/trace.go:171","msg":"trace[523209092] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:600; }","duration":"384.274903ms","start":"2026-04-08T06:12:45.483162Z","end":"2026-04-08T06:12:45.867437Z","steps":["trace[523209092] 'agreement among raft nodes before linearized reading' (duration: 383.353089ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:45.867527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:12:45.483142Z","time spent":"384.373687ms","remote":"127.0.0.1:38544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-04-08T06:12:45.867833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.225129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-08T06:12:45.867968Z","caller":"traceutil/trace.go:171","msg":"trace[245303273] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:600; }","duration":"371.370194ms","start":"2026-04-08T06:12:45.496562Z","end":"2026-04-08T06:12:45.867932Z","steps":["trace[245303273] 'agreement among raft nodes before linearized reading' (duration: 371.138495ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:45.868053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:12:45.496543Z","time spent":"371.499129ms","remote":"127.0.0.1:38790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-08T06:12:52.834123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"636.812399ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-08T06:12:52.83427Z","caller":"traceutil/trace.go:171","msg":"trace[1655375182] linearizableReadLoop","detail":"{readStateIndex:693; appliedIndex:692; }","duration":"585.221095ms","start":"2026-04-08T06:12:52.249026Z","end":"2026-04-08T06:12:52.834247Z","steps":["trace[1655375182] 'read index received' (duration: 38.582µs)","trace[1655375182] 'applied index is now lower than readState.Index' (duration: 585.180343ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:12:52.834419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.37881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:12:52.834462Z","caller":"traceutil/trace.go:171","msg":"trace[80701008] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:668; }","duration":"585.429972ms","start":"2026-04-08T06:12:52.249018Z","end":"2026-04-08T06:12:52.834448Z","steps":["trace[80701008] 'agreement among raft nodes before linearized reading' (duration: 585.343149ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:52.834501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:12:52.24896Z","time spent":"585.531395ms","remote":"127.0.0.1:38508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-08T06:12:55.374257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.360190913s","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-04-08T06:12:55.374471Z","caller":"traceutil/trace.go:171","msg":"trace[948407226] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:669; }","duration":"1.360424671s","start":"2026-04-08T06:12:54.013952Z","end":"2026-04-08T06:12:55.374377Z","steps":["trace[948407226] 'range keys from in-memory index tree' (duration: 1.359883623s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:55.37471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.12544006s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:12:55.374846Z","caller":"traceutil/trace.go:171","msg":"trace[1818090809] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:669; }","duration":"1.125645836s","start":"2026-04-08T06:12:54.249179Z","end":"2026-04-08T06:12:55.374825Z","steps":["trace[1818090809] 'range keys from in-memory index tree' (duration: 1.125321106s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:55.374914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:12:54.249142Z","time spent":"1.125763111s","remote":"127.0.0.1:38508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-08T06:12:55.375014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"808.157398ms","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-04-08T06:12:55.375326Z","caller":"traceutil/trace.go:171","msg":"trace[820314253] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:669; }","duration":"808.452218ms","start":"2026-04-08T06:12:54.566835Z","end":"2026-04-08T06:12:55.375287Z","steps":["trace[820314253] 'range keys from in-memory index tree' (duration: 808.132057ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:55.374798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:12:54.013926Z","time spent":"1.360727191s","remote":"127.0.0.1:38790","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-04-08T06:12:55.376864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.425289646s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-08T06:12:55.376992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.429066076s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-08T06:12:55.377738Z","caller":"traceutil/trace.go:171","msg":"trace[1232599908] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:669; }","duration":"1.429852913s","start":"2026-04-08T06:12:53.947868Z","end":"2026-04-08T06:12:55.377721Z","steps":["trace[1232599908] 'range keys from in-memory index tree' (duration: 1.428681644s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:55.377188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.424974236s","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-04-08T06:12:55.378334Z","caller":"traceutil/trace.go:171","msg":"trace[1333728219] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:669; }","duration":"1.426166085s","start":"2026-04-08T06:12:53.952149Z","end":"2026-04-08T06:12:55.378315Z","steps":["trace[1333728219] 'range keys from in-memory index tree' (duration: 1.424804569s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:55.378383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:12:53.952138Z","time spent":"1.426232967s","remote":"127.0.0.1:38790","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-04-08T06:12:55.378063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:12:53.947826Z","time spent":"1.430131833s","remote":"127.0.0.1:38790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-08T06:12:55.377238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.42512281s","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-04-08T06:12:55.377584Z","caller":"traceutil/trace.go:171","msg":"trace[1084263071] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:669; }","duration":"1.42539924s","start":"2026-04-08T06:12:53.951505Z","end":"2026-04-08T06:12:55.376904Z","steps":["trace[1084263071] 'range keys from in-memory index tree' (duration: 1.425013736s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:55.379123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:12:53.951471Z","time spent":"1.427638066s","remote":"127.0.0.1:38790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-08T06:12:55.378866Z","caller":"traceutil/trace.go:171","msg":"trace[11038216] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:669; }","duration":"1.426831449s","start":"2026-04-08T06:12:53.952026Z","end":"2026-04-08T06:12:55.378857Z","steps":["trace[11038216] 'range keys from in-memory index tree' (duration: 1.418040859s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:55.379364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:12:53.952017Z","time spent":"1.427335496s","remote":"127.0.0.1:38790","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-04-08T06:13:11.758546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.01407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T06:13:11.758631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.742251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:13:11.75868Z","caller":"traceutil/trace.go:171","msg":"trace[1446524029] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:785; }","duration":"130.204245ms","start":"2026-04-08T06:13:11.628449Z","end":"2026-04-08T06:13:11.758653Z","steps":["trace[1446524029] 'range keys from in-memory index tree' (duration: 129.863745ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:13:11.758719Z","caller":"traceutil/trace.go:171","msg":"trace[2101923030] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:785; }","duration":"129.875326ms","start":"2026-04-08T06:13:11.628824Z","end":"2026-04-08T06:13:11.758699Z","steps":["trace[2101923030] 'range keys from in-memory index tree' (duration: 129.663699ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:13:11.758894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.48694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:13:11.758946Z","caller":"traceutil/trace.go:171","msg":"trace[1167393955] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:785; }","duration":"105.543532ms","start":"2026-04-08T06:13:11.653391Z","end":"2026-04-08T06:13:11.758935Z","steps":["trace[1167393955] 'count revisions from in-memory index tree' (duration: 105.450359ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:13:11.75898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.771991ms","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-04-08T06:13:11.759042Z","caller":"traceutil/trace.go:171","msg":"trace[1908743044] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:785; }","duration":"268.919455ms","start":"2026-04-08T06:13:11.490109Z","end":"2026-04-08T06:13:11.759029Z","steps":["trace[1908743044] 'range keys from in-memory index tree' (duration: 268.528854ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:13:11.759133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.82861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:13:11.759227Z","caller":"traceutil/trace.go:171","msg":"trace[1122237160] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:785; }","duration":"105.885661ms","start":"2026-04-08T06:13:11.653273Z","end":"2026-04-08T06:13:11.759159Z","steps":["trace[1122237160] 'range keys from in-memory index tree' (duration: 105.677746ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:13:11.759243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.445893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-08T06:13:11.759264Z","caller":"traceutil/trace.go:171","msg":"trace[1348164942] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:785; }","duration":"273.510154ms","start":"2026-04-08T06:13:11.485749Z","end":"2026-04-08T06:13:11.759259Z","steps":["trace[1348164942] 'range keys from in-memory index tree' (duration: 273.283308ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:13:11.759344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.203756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-08T06:13:11.759417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.473807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:13:11.759464Z","caller":"traceutil/trace.go:171","msg":"trace[1277648384] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:785; }","duration":"509.554159ms","start":"2026-04-08T06:13:11.249899Z","end":"2026-04-08T06:13:11.759453Z","steps":["trace[1277648384] 'range keys from in-memory index tree' (duration: 509.342014ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:13:11.759497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"861.438729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7htc6\" ","response":"range_response_count:1 size:3964"} {"level":"warn","ts":"2026-04-08T06:13:11.759501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:13:11.249879Z","time spent":"509.613851ms","remote":"127.0.0.1:38508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-08T06:13:11.759526Z","caller":"traceutil/trace.go:171","msg":"trace[305238591] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7htc6; range_end:; response_count:1; response_revision:785; }","duration":"861.511642ms","start":"2026-04-08T06:13:10.898007Z","end":"2026-04-08T06:13:11.759519Z","steps":["trace[305238591] 'range keys from in-memory index tree' (duration: 861.342657ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:13:11.759546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:13:10.897981Z","time spent":"861.559454ms","remote":"127.0.0.1:38696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7htc6\" "} {"level":"warn","ts":"2026-04-08T06:13:11.759399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.466619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:13:11.759659Z","caller":"traceutil/trace.go:171","msg":"trace[242636631] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:785; }","duration":"105.760948ms","start":"2026-04-08T06:13:11.653889Z","end":"2026-04-08T06:13:11.75965Z","steps":["trace[242636631] 'range keys from in-memory index tree' (duration: 105.359946ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:13:11.75974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.172587ms","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-04-08T06:13:11.759798Z","caller":"traceutil/trace.go:171","msg":"trace[2133397686] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:785; }","duration":"297.27277ms","start":"2026-04-08T06:13:11.462514Z","end":"2026-04-08T06:13:11.759787Z","steps":["trace[2133397686] 'range keys from in-memory index tree' (duration: 297.008833ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:13:11.759131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.811743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:13:11.75998Z","caller":"traceutil/trace.go:171","msg":"trace[275382465] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:785; }","duration":"131.693349ms","start":"2026-04-08T06:13:11.628269Z","end":"2026-04-08T06:13:11.759962Z","steps":["trace[275382465] 'count revisions from in-memory index tree' (duration: 130.69967ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:13:11.760022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.626828ms","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-04-08T06:13:11.760058Z","caller":"traceutil/trace.go:171","msg":"trace[559884462] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:785; }","duration":"278.716451ms","start":"2026-04-08T06:13:11.481331Z","end":"2026-04-08T06:13:11.760048Z","steps":["trace[559884462] 'range keys from in-memory index tree' (duration: 278.34308ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:13:11.759476Z","caller":"traceutil/trace.go:171","msg":"trace[1845002206] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:785; }","duration":"274.362131ms","start":"2026-04-08T06:13:11.48507Z","end":"2026-04-08T06:13:11.759433Z","steps":["trace[1845002206] 'range keys from in-memory index tree' (duration: 273.117803ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:13:34.137476Z","caller":"traceutil/trace.go:171","msg":"trace[1980612166] linearizableReadLoop","detail":"{readStateIndex:1019; appliedIndex:1018; }","duration":"162.90714ms","start":"2026-04-08T06:13:33.974548Z","end":"2026-04-08T06:13:34.137455Z","steps":["trace[1980612166] 'read index received' (duration: 162.709195ms)","trace[1980612166] 'applied index is now lower than readState.Index' (duration: 196.945µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:13:34.137517Z","caller":"traceutil/trace.go:171","msg":"trace[75356492] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"184.77333ms","start":"2026-04-08T06:13:33.952715Z","end":"2026-04-08T06:13:34.137488Z","steps":["trace[75356492] 'process raft request' (duration: 184.604186ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:13:34.137734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.140226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-08T06:13:34.137773Z","caller":"traceutil/trace.go:171","msg":"trace[1754624910] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:983; }","duration":"163.256259ms","start":"2026-04-08T06:13:33.974507Z","end":"2026-04-08T06:13:34.137763Z","steps":["trace[1754624910] 'agreement among raft nodes before linearized reading' (duration: 163.054034ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:13:34.137977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.787726ms","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-04-08T06:13:34.138Z","caller":"traceutil/trace.go:171","msg":"trace[754628823] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:983; }","duration":"162.826808ms","start":"2026-04-08T06:13:33.975167Z","end":"2026-04-08T06:13:34.137994Z","steps":["trace[754628823] 'agreement among raft nodes before linearized reading' (duration: 162.756976ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:13:34.138022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.967671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-08T06:13:34.138035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.462384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-08T06:13:34.138094Z","caller":"traceutil/trace.go:171","msg":"trace[522805220] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:983; }","duration":"163.087774ms","start":"2026-04-08T06:13:33.97499Z","end":"2026-04-08T06:13:34.138077Z","steps":["trace[522805220] 'agreement among raft nodes before linearized reading' (duration: 162.867808ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:13:34.1381Z","caller":"traceutil/trace.go:171","msg":"trace[221571331] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:983; }","duration":"163.580567ms","start":"2026-04-08T06:13:33.974506Z","end":"2026-04-08T06:13:34.138087Z","steps":["trace[221571331] 'agreement among raft nodes before linearized reading' (duration: 163.370492ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:14:02.54767Z","caller":"traceutil/trace.go:171","msg":"trace[702117811] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"149.28582ms","start":"2026-04-08T06:14:02.398358Z","end":"2026-04-08T06:14:02.547644Z","steps":["trace[702117811] 'process raft request' (duration: 143.523911ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:14:02.560115Z","caller":"traceutil/trace.go:171","msg":"trace[1562060026] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"128.761338ms","start":"2026-04-08T06:14:02.43131Z","end":"2026-04-08T06:14:02.560072Z","steps":["trace[1562060026] 'process raft request' (duration: 128.42102ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:14:18.624125Z","caller":"traceutil/trace.go:171","msg":"trace[1066742319] transaction","detail":"{read_only:false; response_revision:1136; number_of_response:1; }","duration":"105.245253ms","start":"2026-04-08T06:14:18.518846Z","end":"2026-04-08T06:14:18.624092Z","steps":["trace[1066742319] 'process raft request' (duration: 103.274342ms)"],"step_count":1}