{"level":"warn","ts":"2026-04-21T15:36:27.37725Z","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-21T15:36:27.377389Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.200: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.19.213.200:2380","--initial-cluster=instance=https://199.19.213.200:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.200:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.200: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-21T15:36:27.377497Z","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-21T15:36:27.377509Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.200:2380"]} {"level":"info","ts":"2026-04-21T15:36:27.377528Z","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-21T15:36:27.378321Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.200:2379"]} {"level":"info","ts":"2026-04-21T15:36:27.37841Z","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":16,"max-cpu-available":16,"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.19.213.200:2380"],"listen-peer-urls":["https://199.19.213.200:2380"],"advertise-client-urls":["https://199.19.213.200:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.200:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.200: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-21T15:36:27.384618Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.119512ms"} {"level":"info","ts":"2026-04-21T15:36:27.397087Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3363378c2227fa42","cluster-id":"7faf957b2e4cf761"} {"level":"info","ts":"2026-04-21T15:36:27.397187Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3363378c2227fa42 switched to configuration voters=()"} {"level":"info","ts":"2026-04-21T15:36:27.397211Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3363378c2227fa42 became follower at term 0"} {"level":"info","ts":"2026-04-21T15:36:27.397224Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3363378c2227fa42 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-21T15:36:27.397248Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3363378c2227fa42 became follower at term 1"} {"level":"info","ts":"2026-04-21T15:36:27.39769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3363378c2227fa42 switched to configuration voters=(3702864393636674114)"} {"level":"warn","ts":"2026-04-21T15:36:27.404274Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-21T15:36:27.406047Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-21T15:36:27.407232Z","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-21T15:36:27.409208Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3363378c2227fa42","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-21T15:36:27.409439Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3363378c2227fa42","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-21T15:36:27.409725Z","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-21T15:36:27.40979Z","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-21T15:36:27.409801Z","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-21T15:36:27.410552Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3363378c2227fa42 switched to configuration voters=(3702864393636674114)"} {"level":"info","ts":"2026-04-21T15:36:27.410679Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"7faf957b2e4cf761","local-member-id":"3363378c2227fa42","added-peer-id":"3363378c2227fa42","added-peer-peer-urls":["https://199.19.213.200:2380"]} {"level":"info","ts":"2026-04-21T15:36:27.414229Z","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-21T15:36:27.414362Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.200:2380"} {"level":"info","ts":"2026-04-21T15:36:27.414431Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.200:2380"} {"level":"info","ts":"2026-04-21T15:36:27.414757Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3363378c2227fa42","initial-advertise-peer-urls":["https://199.19.213.200:2380"],"listen-peer-urls":["https://199.19.213.200:2380"],"advertise-client-urls":["https://199.19.213.200:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.200:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-21T15:36:27.414819Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-21T15:36:28.098491Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3363378c2227fa42 is starting a new election at term 1"} {"level":"info","ts":"2026-04-21T15:36:28.098579Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3363378c2227fa42 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-21T15:36:28.098625Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3363378c2227fa42 received MsgPreVoteResp from 3363378c2227fa42 at term 1"} {"level":"info","ts":"2026-04-21T15:36:28.098645Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3363378c2227fa42 became candidate at term 2"} {"level":"info","ts":"2026-04-21T15:36:28.098656Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3363378c2227fa42 received MsgVoteResp from 3363378c2227fa42 at term 2"} {"level":"info","ts":"2026-04-21T15:36:28.098672Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3363378c2227fa42 became leader at term 2"} {"level":"info","ts":"2026-04-21T15:36:28.098686Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3363378c2227fa42 elected leader 3363378c2227fa42 at term 2"} {"level":"info","ts":"2026-04-21T15:36:28.100005Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3363378c2227fa42","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.200:2379]}","request-path":"/0/members/3363378c2227fa42/attributes","cluster-id":"7faf957b2e4cf761","publish-timeout":"7s"} {"level":"info","ts":"2026-04-21T15:36:28.100015Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T15:36:28.100056Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T15:36:28.100063Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T15:36:28.100393Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-21T15:36:28.100447Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-21T15:36:28.101472Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"7faf957b2e4cf761","local-member-id":"3363378c2227fa42","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T15:36:28.101596Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T15:36:28.101651Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T15:36:28.103392Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.200:2379"} {"level":"info","ts":"2026-04-21T15:36:28.103438Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-21T15:36:49.908388Z","caller":"traceutil/trace.go:171","msg":"trace[1560148860] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"112.629182ms","start":"2026-04-21T15:36:49.795724Z","end":"2026-04-21T15:36:49.908353Z","steps":["trace[1560148860] 'process raft request' (duration: 112.441407ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:37:00.128916Z","caller":"traceutil/trace.go:171","msg":"trace[973569908] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"118.116146ms","start":"2026-04-21T15:37:00.010766Z","end":"2026-04-21T15:37:00.128882Z","steps":["trace[973569908] 'process raft request' (duration: 102.729994ms)","trace[973569908] 'compare' (duration: 15.215247ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T15:37:06.621317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.783283ms","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":"warn","ts":"2026-04-21T15:37:06.621263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.08219ms","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-21T15:37:06.621428Z","caller":"traceutil/trace.go:171","msg":"trace[1295186796] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:578; }","duration":"198.973138ms","start":"2026-04-21T15:37:06.422431Z","end":"2026-04-21T15:37:06.621404Z","steps":["trace[1295186796] 'range keys from in-memory index tree' (duration: 198.68707ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:37:06.621387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.486687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T15:37:06.621456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.502082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T15:37:06.621452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.154908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T15:37:06.621463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.998335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T15:37:06.621303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.262625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T15:37:06.621514Z","caller":"traceutil/trace.go:171","msg":"trace[1443435475] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:578; }","duration":"213.646271ms","start":"2026-04-21T15:37:06.407843Z","end":"2026-04-21T15:37:06.621489Z","steps":["trace[1443435475] 'count revisions from in-memory index tree' (duration: 213.190769ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:37:06.621546Z","caller":"traceutil/trace.go:171","msg":"trace[474157973] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:578; }","duration":"199.598585ms","start":"2026-04-21T15:37:06.421916Z","end":"2026-04-21T15:37:06.621515Z","steps":["trace[474157973] 'count revisions from in-memory index tree' (duration: 199.41177ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:37:06.621472Z","caller":"traceutil/trace.go:171","msg":"trace[108164242] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:578; }","duration":"171.376077ms","start":"2026-04-21T15:37:06.450065Z","end":"2026-04-21T15:37:06.621441Z","steps":["trace[108164242] 'range keys from in-memory index tree' (duration: 171.028088ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:37:06.621581Z","caller":"traceutil/trace.go:171","msg":"trace[1856113993] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:578; }","duration":"213.161749ms","start":"2026-04-21T15:37:06.408391Z","end":"2026-04-21T15:37:06.621553Z","steps":["trace[1856113993] 'range keys from in-memory index tree' (duration: 212.901552ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:37:06.621586Z","caller":"traceutil/trace.go:171","msg":"trace[1672636749] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:578; }","duration":"199.727938ms","start":"2026-04-21T15:37:06.421838Z","end":"2026-04-21T15:37:06.621566Z","steps":["trace[1672636749] 'range keys from in-memory index tree' (duration: 199.117192ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:37:06.621308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.766148ms","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-21T15:37:06.621552Z","caller":"traceutil/trace.go:171","msg":"trace[1168470885] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:578; }","duration":"172.284451ms","start":"2026-04-21T15:37:06.449243Z","end":"2026-04-21T15:37:06.621528Z","steps":["trace[1168470885] 'count revisions from in-memory index tree' (duration: 172.061086ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:37:06.621758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.719863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T15:37:06.621898Z","caller":"traceutil/trace.go:171","msg":"trace[752922070] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:578; }","duration":"213.904608ms","start":"2026-04-21T15:37:06.407978Z","end":"2026-04-21T15:37:06.621883Z","steps":["trace[752922070] 'range keys from in-memory index tree' (duration: 213.541598ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:37:06.621738Z","caller":"traceutil/trace.go:171","msg":"trace[380510470] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:578; }","duration":"172.266571ms","start":"2026-04-21T15:37:06.449391Z","end":"2026-04-21T15:37:06.621658Z","steps":["trace[380510470] 'range keys from in-memory index tree' (duration: 171.615595ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:37:06.636748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.257038ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-21T15:37:06.637126Z","caller":"traceutil/trace.go:171","msg":"trace[927067183] linearizableReadLoop","detail":"{readStateIndex:602; appliedIndex:601; }","duration":"145.85158ms","start":"2026-04-21T15:37:06.491197Z","end":"2026-04-21T15:37:06.637048Z","steps":["trace[927067183] 'read index received' (duration: 59.231µs)","trace[927067183] 'applied index is now lower than readState.Index' (duration: 145.787969ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T15:37:06.63716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.963123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T15:37:06.637191Z","caller":"traceutil/trace.go:171","msg":"trace[480220175] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:578; }","duration":"146.018344ms","start":"2026-04-21T15:37:06.491161Z","end":"2026-04-21T15:37:06.637179Z","steps":["trace[480220175] 'agreement among raft nodes before linearized reading' (duration: 145.962593ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:37:06.637959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.847209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T15:37:06.638032Z","caller":"traceutil/trace.go:171","msg":"trace[311865193] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:579; }","duration":"117.91447ms","start":"2026-04-21T15:37:06.520071Z","end":"2026-04-21T15:37:06.637985Z","steps":["trace[311865193] 'agreement among raft nodes before linearized reading' (duration: 117.837248ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:37:06.6381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.740412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T15:37:06.638133Z","caller":"traceutil/trace.go:171","msg":"trace[1242465086] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:579; }","duration":"118.788733ms","start":"2026-04-21T15:37:06.519333Z","end":"2026-04-21T15:37:06.638122Z","steps":["trace[1242465086] 'agreement among raft nodes before linearized reading' (duration: 118.738202ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:37:06.638162Z","caller":"traceutil/trace.go:171","msg":"trace[1957487231] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"117.971032ms","start":"2026-04-21T15:37:06.52017Z","end":"2026-04-21T15:37:06.638141Z","steps":["trace[1957487231] 'process raft request' (duration: 116.935534ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:37:06.638277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.960308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T15:37:06.638297Z","caller":"traceutil/trace.go:171","msg":"trace[933208251] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:579; }","duration":"118.983649ms","start":"2026-04-21T15:37:06.519307Z","end":"2026-04-21T15:37:06.638291Z","steps":["trace[933208251] 'agreement among raft nodes before linearized reading' (duration: 118.948378ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:37:06.638499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.250377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T15:37:06.638523Z","caller":"traceutil/trace.go:171","msg":"trace[1999545438] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:579; }","duration":"147.320348ms","start":"2026-04-21T15:37:06.491194Z","end":"2026-04-21T15:37:06.638514Z","steps":["trace[1999545438] 'agreement among raft nodes before linearized reading' (duration: 146.672752ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:37:06.814244Z","caller":"traceutil/trace.go:171","msg":"trace[285887414] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"170.271819ms","start":"2026-04-21T15:37:06.643937Z","end":"2026-04-21T15:37:06.814208Z","steps":["trace[285887414] 'process raft request' (duration: 141.821996ms)","trace[285887414] 'compare' (duration: 28.286748ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:37:06.814313Z","caller":"traceutil/trace.go:171","msg":"trace[1452152442] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"116.818242ms","start":"2026-04-21T15:37:06.697464Z","end":"2026-04-21T15:37:06.814282Z","steps":["trace[1452152442] 'process raft request' (duration: 116.749401ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:37:06.814383Z","caller":"traceutil/trace.go:171","msg":"trace[989360030] linearizableReadLoop","detail":"{readStateIndex:604; appliedIndex:603; }","duration":"158.690566ms","start":"2026-04-21T15:37:06.655622Z","end":"2026-04-21T15:37:06.814313Z","steps":["trace[989360030] 'read index received' (duration: 130.088288ms)","trace[989360030] 'applied index is now lower than readState.Index' (duration: 28.598448ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T15:37:06.814592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.930662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T15:37:06.814682Z","caller":"traceutil/trace.go:171","msg":"trace[1434597108] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:581; }","duration":"159.073866ms","start":"2026-04-21T15:37:06.655587Z","end":"2026-04-21T15:37:06.814661Z","steps":["trace[1434597108] 'agreement among raft nodes before linearized reading' (duration: 158.899652ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:37:06.814817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.065845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T15:37:06.814956Z","caller":"traceutil/trace.go:171","msg":"trace[977864081] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:581; }","duration":"159.251911ms","start":"2026-04-21T15:37:06.655663Z","end":"2026-04-21T15:37:06.814915Z","steps":["trace[977864081] 'agreement among raft nodes before linearized reading' (duration: 159.026785ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:37:06.815067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.797364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T15:37:06.815131Z","caller":"traceutil/trace.go:171","msg":"trace[113550563] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:581; }","duration":"110.884187ms","start":"2026-04-21T15:37:06.704229Z","end":"2026-04-21T15:37:06.815113Z","steps":["trace[113550563] 'agreement among raft nodes before linearized reading' (duration: 110.796305ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:37:06.815441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.217355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T15:37:06.815486Z","caller":"traceutil/trace.go:171","msg":"trace[856464268] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:581; }","duration":"111.299028ms","start":"2026-04-21T15:37:06.704175Z","end":"2026-04-21T15:37:06.815474Z","steps":["trace[856464268] 'agreement among raft nodes before linearized reading' (duration: 111.185555ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:37:06.815534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.25894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T15:37:06.815587Z","caller":"traceutil/trace.go:171","msg":"trace[1910712157] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:581; }","duration":"159.315672ms","start":"2026-04-21T15:37:06.656259Z","end":"2026-04-21T15:37:06.815575Z","steps":["trace[1910712157] 'agreement among raft nodes before linearized reading' (duration: 159.2413ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:37:07.262055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.923498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T15:37:07.262096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.53563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T15:37:07.262138Z","caller":"traceutil/trace.go:171","msg":"trace[289384387] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:581; }","duration":"289.051602ms","start":"2026-04-21T15:37:06.973064Z","end":"2026-04-21T15:37:07.262116Z","steps":["trace[289384387] 'count revisions from in-memory index tree' (duration: 288.877678ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:37:07.262174Z","caller":"traceutil/trace.go:171","msg":"trace[35301609] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:581; }","duration":"138.641733ms","start":"2026-04-21T15:37:07.123514Z","end":"2026-04-21T15:37:07.262156Z","steps":["trace[35301609] 'count revisions from in-memory index tree' (duration: 138.491259ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:37:07.262149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.187958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T15:37:07.262149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.633412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T15:37:07.262203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.692563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T15:37:07.262245Z","caller":"traceutil/trace.go:171","msg":"trace[1188770528] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:581; }","duration":"288.317942ms","start":"2026-04-21T15:37:06.973902Z","end":"2026-04-21T15:37:07.26222Z","steps":["trace[1188770528] 'range keys from in-memory index tree' (duration: 288.146418ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:37:07.262268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.36605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T15:37:07.262241Z","caller":"traceutil/trace.go:171","msg":"trace[804199307] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:581; }","duration":"138.785616ms","start":"2026-04-21T15:37:07.12344Z","end":"2026-04-21T15:37:07.262225Z","steps":["trace[804199307] 'range keys from in-memory index tree' (duration: 138.507229ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:37:07.262283Z","caller":"traceutil/trace.go:171","msg":"trace[1198742510] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:581; }","duration":"311.796687ms","start":"2026-04-21T15:37:06.950469Z","end":"2026-04-21T15:37:07.262265Z","steps":["trace[1198742510] 'range keys from in-memory index tree' (duration: 311.57537ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:37:07.262307Z","caller":"traceutil/trace.go:171","msg":"trace[158412372] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:581; }","duration":"289.421041ms","start":"2026-04-21T15:37:06.97287Z","end":"2026-04-21T15:37:07.262291Z","steps":["trace[158412372] 'range keys from in-memory index tree' (duration: 289.322419ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:37:07.262338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T15:37:06.950379Z","time spent":"311.94319ms","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T15:37:07.262333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.858598ms","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-04-21T15:37:07.262478Z","caller":"traceutil/trace.go:171","msg":"trace[498796091] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:581; }","duration":"312.056693ms","start":"2026-04-21T15:37:06.950381Z","end":"2026-04-21T15:37:07.262438Z","steps":["trace[498796091] 'count revisions from in-memory index tree' (duration: 311.757645ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:37:07.262476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.277012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T15:37:07.262546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T15:37:06.950322Z","time spent":"312.195736ms","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"info","ts":"2026-04-21T15:37:07.262591Z","caller":"traceutil/trace.go:171","msg":"trace[48672172] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:581; }","duration":"311.463516ms","start":"2026-04-21T15:37:06.951105Z","end":"2026-04-21T15:37:07.262569Z","steps":["trace[48672172] 'range keys from in-memory index tree' (duration: 311.23267ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:37:07.262635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T15:37:06.9511Z","time spent":"311.523968ms","remote":"127.0.0.1:59630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 "} {"level":"info","ts":"2026-04-21T15:37:29.611436Z","caller":"traceutil/trace.go:171","msg":"trace[93776042] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"139.957696ms","start":"2026-04-21T15:37:29.471448Z","end":"2026-04-21T15:37:29.611406Z","steps":["trace[93776042] 'process raft request' (duration: 139.796421ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:37:29.65025Z","caller":"traceutil/trace.go:171","msg":"trace[570392617] linearizableReadLoop","detail":"{readStateIndex:794; appliedIndex:792; }","duration":"162.607818ms","start":"2026-04-21T15:37:29.48761Z","end":"2026-04-21T15:37:29.650217Z","steps":["trace[570392617] 'read index received' (duration: 123.585399ms)","trace[570392617] 'applied index is now lower than readState.Index' (duration: 39.021399ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T15:37:29.650405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.778162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T15:37:29.650414Z","caller":"traceutil/trace.go:171","msg":"trace[435232068] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"175.767031ms","start":"2026-04-21T15:37:29.474531Z","end":"2026-04-21T15:37:29.650298Z","steps":["trace[435232068] 'process raft request' (duration: 175.514425ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:37:29.650518Z","caller":"traceutil/trace.go:171","msg":"trace[599587279] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:765; }","duration":"162.911205ms","start":"2026-04-21T15:37:29.487546Z","end":"2026-04-21T15:37:29.650457Z","steps":["trace[599587279] 'agreement among raft nodes before linearized reading' (duration: 162.794432ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:38:47.890653Z","caller":"traceutil/trace.go:171","msg":"trace[2006914484] linearizableReadLoop","detail":"{readStateIndex:1921; appliedIndex:1920; }","duration":"403.013849ms","start":"2026-04-21T15:38:47.487615Z","end":"2026-04-21T15:38:47.890629Z","steps":["trace[2006914484] 'read index received' (duration: 402.780912ms)","trace[2006914484] 'applied index is now lower than readState.Index' (duration: 231.917µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:38:47.890718Z","caller":"traceutil/trace.go:171","msg":"trace[1039275194] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"417.709075ms","start":"2026-04-21T15:38:47.472969Z","end":"2026-04-21T15:38:47.890678Z","steps":["trace[1039275194] 'process raft request' (duration: 417.4929ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:38:47.890829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.199534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T15:38:47.890869Z","caller":"traceutil/trace.go:171","msg":"trace[836657245] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1846; }","duration":"403.303567ms","start":"2026-04-21T15:38:47.487554Z","end":"2026-04-21T15:38:47.890858Z","steps":["trace[836657245] 'agreement among raft nodes before linearized reading' (duration: 403.216904ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:38:47.890977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T15:38:47.48753Z","time spent":"403.433749ms","remote":"127.0.0.1:55872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-21T15:38:47.891279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T15:38:47.472946Z","time spent":"417.845569ms","remote":"127.0.0.1:56114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T15:39:36.970537Z","caller":"traceutil/trace.go:171","msg":"trace[1105272007] linearizableReadLoop","detail":"{readStateIndex:2248; appliedIndex:2247; }","duration":"104.327797ms","start":"2026-04-21T15:39:36.866181Z","end":"2026-04-21T15:39:36.970509Z","steps":["trace[1105272007] 'read index received' (duration: 104.174213ms)","trace[1105272007] 'applied index is now lower than readState.Index' (duration: 152.364µs)"],"step_count":2} {"level":"warn","ts":"2026-04-21T15:39:36.970745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.536653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-21T15:39:36.970786Z","caller":"traceutil/trace.go:171","msg":"trace[380407754] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2161; }","duration":"104.619984ms","start":"2026-04-21T15:39:36.866155Z","end":"2026-04-21T15:39:36.970775Z","steps":["trace[380407754] 'agreement among raft nodes before linearized reading' (duration: 104.46146ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:39:36.970798Z","caller":"traceutil/trace.go:171","msg":"trace[1582884854] transaction","detail":"{read_only:false; response_revision:2161; number_of_response:1; }","duration":"108.604803ms","start":"2026-04-21T15:39:36.862168Z","end":"2026-04-21T15:39:36.970773Z","steps":["trace[1582884854] 'process raft request' (duration: 108.164151ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:39:37.070242Z","caller":"traceutil/trace.go:171","msg":"trace[1223256414] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"158.804093ms","start":"2026-04-21T15:39:36.911412Z","end":"2026-04-21T15:39:37.070216Z","steps":["trace[1223256414] 'process raft request' (duration: 158.601238ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:39:37.070427Z","caller":"traceutil/trace.go:171","msg":"trace[599334610] transaction","detail":"{read_only:false; response_revision:2163; number_of_response:1; }","duration":"111.038834ms","start":"2026-04-21T15:39:36.959355Z","end":"2026-04-21T15:39:37.070394Z","steps":["trace[599334610] 'process raft request' (duration: 110.803218ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:39:37.07586Z","caller":"traceutil/trace.go:171","msg":"trace[520806415] transaction","detail":"{read_only:false; response_revision:2164; number_of_response:1; }","duration":"101.390374ms","start":"2026-04-21T15:39:36.974451Z","end":"2026-04-21T15:39:37.075842Z","steps":["trace[520806415] 'process raft request' (duration: 101.24951ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:39:37.297102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.805742ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T15:39:37.29761Z","caller":"traceutil/trace.go:171","msg":"trace[1737872669] transaction","detail":"{read_only:false; response_revision:2168; number_of_response:1; }","duration":"130.497148ms","start":"2026-04-21T15:39:37.167064Z","end":"2026-04-21T15:39:37.297561Z","steps":["trace[1737872669] 'process raft request' (duration: 12.0594ms)","trace[1737872669] 'compare' (duration: 117.6927ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:39:42.515352Z","caller":"traceutil/trace.go:171","msg":"trace[996440848] transaction","detail":"{read_only:false; response_revision:2193; number_of_response:1; }","duration":"108.088881ms","start":"2026-04-21T15:39:42.407231Z","end":"2026-04-21T15:39:42.515319Z","steps":["trace[996440848] 'process raft request' (duration: 107.866145ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:39:43.322427Z","caller":"traceutil/trace.go:171","msg":"trace[617871232] transaction","detail":"{read_only:false; response_revision:2195; number_of_response:1; }","duration":"234.259591ms","start":"2026-04-21T15:39:43.088134Z","end":"2026-04-21T15:39:43.322394Z","steps":["trace[617871232] 'process raft request' (duration: 233.999285ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:39:43.323089Z","caller":"traceutil/trace.go:171","msg":"trace[227832965] linearizableReadLoop","detail":"{readStateIndex:2284; appliedIndex:2282; }","duration":"226.819746ms","start":"2026-04-21T15:39:43.096245Z","end":"2026-04-21T15:39:43.323065Z","steps":["trace[227832965] 'read index received' (duration: 225.845932ms)","trace[227832965] 'applied index is now lower than readState.Index' (duration: 972.924µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:39:43.323222Z","caller":"traceutil/trace.go:171","msg":"trace[477847022] transaction","detail":"{read_only:false; response_revision:2196; number_of_response:1; }","duration":"230.22003ms","start":"2026-04-21T15:39:43.092991Z","end":"2026-04-21T15:39:43.323212Z","steps":["trace[477847022] 'process raft request' (duration: 229.835921ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:39:43.323384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.114653ms","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-21T15:39:43.323481Z","caller":"traceutil/trace.go:171","msg":"trace[37237941] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2197; }","duration":"227.259607ms","start":"2026-04-21T15:39:43.096205Z","end":"2026-04-21T15:39:43.323464Z","steps":["trace[37237941] 'agreement among raft nodes before linearized reading' (duration: 227.054212ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:39:43.323724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.804127ms","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-21T15:39:43.323756Z","caller":"traceutil/trace.go:171","msg":"trace[994929257] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2197; }","duration":"208.90069ms","start":"2026-04-21T15:39:43.114847Z","end":"2026-04-21T15:39:43.323748Z","steps":["trace[994929257] 'agreement among raft nodes before linearized reading' (duration: 208.714615ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:40:51.798084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.558619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-21T15:40:51.798265Z","caller":"traceutil/trace.go:171","msg":"trace[205754388] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2764; }","duration":"176.755274ms","start":"2026-04-21T15:40:51.621482Z","end":"2026-04-21T15:40:51.798238Z","steps":["trace[205754388] 'range keys from in-memory index tree' (duration: 176.424155ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:43:21.953929Z","caller":"traceutil/trace.go:171","msg":"trace[1860811677] transaction","detail":"{read_only:false; response_revision:3754; number_of_response:1; }","duration":"146.668544ms","start":"2026-04-21T15:43:21.807236Z","end":"2026-04-21T15:43:21.953904Z","steps":["trace[1860811677] 'process raft request' (duration: 146.52119ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:44:35.721268Z","caller":"traceutil/trace.go:171","msg":"trace[628515161] transaction","detail":"{read_only:false; response_revision:4618; number_of_response:1; }","duration":"158.873675ms","start":"2026-04-21T15:44:35.562378Z","end":"2026-04-21T15:44:35.721252Z","steps":["trace[628515161] 'process raft request' (duration: 158.764902ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:44:35.739921Z","caller":"traceutil/trace.go:171","msg":"trace[1209227637] linearizableReadLoop","detail":"{readStateIndex:4805; appliedIndex:4804; }","duration":"172.502905ms","start":"2026-04-21T15:44:35.56739Z","end":"2026-04-21T15:44:35.739893Z","steps":["trace[1209227637] 'read index received' (duration: 153.952405ms)","trace[1209227637] 'applied index is now lower than readState.Index' (duration: 18.54945ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:44:35.739999Z","caller":"traceutil/trace.go:171","msg":"trace[1650199404] transaction","detail":"{read_only:false; response_revision:4620; number_of_response:1; }","duration":"171.88859ms","start":"2026-04-21T15:44:35.568068Z","end":"2026-04-21T15:44:35.739957Z","steps":["trace[1650199404] 'process raft request' (duration: 171.774368ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:44:35.740307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.879934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:2643"} {"level":"info","ts":"2026-04-21T15:44:35.740424Z","caller":"traceutil/trace.go:171","msg":"trace[1537430423] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4620; }","duration":"173.026859ms","start":"2026-04-21T15:44:35.567366Z","end":"2026-04-21T15:44:35.740393Z","steps":["trace[1537430423] 'agreement among raft nodes before linearized reading' (duration: 172.70467ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:44:35.740743Z","caller":"traceutil/trace.go:171","msg":"trace[1786180108] transaction","detail":"{read_only:false; response_revision:4619; number_of_response:1; }","duration":"177.116027ms","start":"2026-04-21T15:44:35.562791Z","end":"2026-04-21T15:44:35.739907Z","steps":["trace[1786180108] 'process raft request' (duration: 176.887862ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:44:41.173981Z","caller":"traceutil/trace.go:171","msg":"trace[541615700] linearizableReadLoop","detail":"{readStateIndex:4969; appliedIndex:4968; }","duration":"218.524783ms","start":"2026-04-21T15:44:40.955433Z","end":"2026-04-21T15:44:41.173958Z","steps":["trace[541615700] 'read index received' (duration: 218.41609ms)","trace[541615700] 'applied index is now lower than readState.Index' (duration: 107.583µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:44:41.174088Z","caller":"traceutil/trace.go:171","msg":"trace[1303390190] transaction","detail":"{read_only:false; response_revision:4777; number_of_response:1; }","duration":"226.63204ms","start":"2026-04-21T15:44:40.947444Z","end":"2026-04-21T15:44:41.174076Z","steps":["trace[1303390190] 'process raft request' (duration: 226.355773ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:44:41.174336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.887151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-21T15:44:41.174403Z","caller":"traceutil/trace.go:171","msg":"trace[1267376943] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4777; }","duration":"219.000834ms","start":"2026-04-21T15:44:40.955378Z","end":"2026-04-21T15:44:41.174379Z","steps":["trace[1267376943] 'agreement among raft nodes before linearized reading' (duration: 218.83441ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:44:41.296357Z","caller":"traceutil/trace.go:171","msg":"trace[123902137] linearizableReadLoop","detail":"{readStateIndex:4970; appliedIndex:4969; }","duration":"122.278508ms","start":"2026-04-21T15:44:41.174052Z","end":"2026-04-21T15:44:41.29633Z","steps":["trace[123902137] 'read index received' (duration: 98.326306ms)","trace[123902137] 'applied index is now lower than readState.Index' (duration: 23.951341ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:44:41.296434Z","caller":"traceutil/trace.go:171","msg":"trace[1196907478] transaction","detail":"{read_only:false; response_revision:4778; number_of_response:1; }","duration":"136.088213ms","start":"2026-04-21T15:44:41.160286Z","end":"2026-04-21T15:44:41.296375Z","steps":["trace[1196907478] 'process raft request' (duration: 112.044649ms)","trace[1196907478] 'compare' (duration: 23.804338ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:44:41.296546Z","caller":"traceutil/trace.go:171","msg":"trace[635024063] transaction","detail":"{read_only:false; response_revision:4779; number_of_response:1; }","duration":"118.650538ms","start":"2026-04-21T15:44:41.177883Z","end":"2026-04-21T15:44:41.296533Z","steps":["trace[635024063] 'process raft request' (duration: 118.379092ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:44:41.296679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.562018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-21T15:44:41.296772Z","caller":"traceutil/trace.go:171","msg":"trace[1688058939] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4779; }","duration":"334.685611ms","start":"2026-04-21T15:44:40.962067Z","end":"2026-04-21T15:44:41.296752Z","steps":["trace[1688058939] 'agreement among raft nodes before linearized reading' (duration: 334.312502ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:44:41.296837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T15:44:40.962059Z","time spent":"334.764762ms","remote":"127.0.0.1:56114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-21T15:44:41.29685Z","caller":"traceutil/trace.go:171","msg":"trace[14562993] transaction","detail":"{read_only:false; response_revision:4780; number_of_response:1; }","duration":"118.825273ms","start":"2026-04-21T15:44:41.178001Z","end":"2026-04-21T15:44:41.296826Z","steps":["trace[14562993] 'process raft request' (duration: 118.499246ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:44:41.29695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.883093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:1229"} {"level":"info","ts":"2026-04-21T15:44:41.297059Z","caller":"traceutil/trace.go:171","msg":"trace[305699507] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4779; }","duration":"318.022886ms","start":"2026-04-21T15:44:40.979001Z","end":"2026-04-21T15:44:41.297024Z","steps":["trace[305699507] 'agreement among raft nodes before linearized reading' (duration: 317.3455ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:44:41.297108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T15:44:40.97899Z","time spent":"318.107578ms","remote":"127.0.0.1:56058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":1251,"request content":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-alertmanager\" "} {"level":"warn","ts":"2026-04-21T15:44:41.297811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.023013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-21T15:44:41.297888Z","caller":"traceutil/trace.go:171","msg":"trace[2063041846] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4779; }","duration":"336.134616ms","start":"2026-04-21T15:44:40.961736Z","end":"2026-04-21T15:44:41.297871Z","steps":["trace[2063041846] 'agreement among raft nodes before linearized reading' (duration: 334.724213ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:44:41.297935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T15:44:40.961727Z","time spent":"336.195828ms","remote":"127.0.0.1:56114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-21T15:44:45.303951Z","caller":"traceutil/trace.go:171","msg":"trace[503749059] linearizableReadLoop","detail":"{readStateIndex:5132; appliedIndex:5131; }","duration":"119.415847ms","start":"2026-04-21T15:44:45.184506Z","end":"2026-04-21T15:44:45.303922Z","steps":["trace[503749059] 'read index received' (duration: 35.864141ms)","trace[503749059] 'applied index is now lower than readState.Index' (duration: 83.550416ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:44:45.304028Z","caller":"traceutil/trace.go:171","msg":"trace[1307819183] transaction","detail":"{read_only:false; response_revision:4936; number_of_response:1; }","duration":"270.087073ms","start":"2026-04-21T15:44:45.033892Z","end":"2026-04-21T15:44:45.303979Z","steps":["trace[1307819183] 'process raft request' (duration: 186.454644ms)","trace[1307819183] 'compare' (duration: 83.243659ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T15:44:45.304205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.675594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6ecddadc-7a8a-49cb-854f-755cfc16e1e9\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-04-21T15:44:45.304255Z","caller":"traceutil/trace.go:171","msg":"trace[1320277793] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6ecddadc-7a8a-49cb-854f-755cfc16e1e9; range_end:; response_count:1; response_revision:4936; }","duration":"119.775697ms","start":"2026-04-21T15:44:45.184466Z","end":"2026-04-21T15:44:45.304241Z","steps":["trace[1320277793] 'agreement among raft nodes before linearized reading' (duration: 119.556511ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:44:55.5091Z","caller":"traceutil/trace.go:171","msg":"trace[868914549] transaction","detail":"{read_only:false; response_revision:5141; number_of_response:1; }","duration":"127.320789ms","start":"2026-04-21T15:44:55.381744Z","end":"2026-04-21T15:44:55.509064Z","steps":["trace[868914549] 'process raft request' (duration: 127.148475ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:44:55.509258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.69933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-21T15:44:55.509052Z","caller":"traceutil/trace.go:171","msg":"trace[1995999192] linearizableReadLoop","detail":"{readStateIndex:5344; appliedIndex:5343; }","duration":"118.494695ms","start":"2026-04-21T15:44:55.390537Z","end":"2026-04-21T15:44:55.509031Z","steps":["trace[1995999192] 'read index received' (duration: 118.28551ms)","trace[1995999192] 'applied index is now lower than readState.Index' (duration: 208.305µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:44:55.509324Z","caller":"traceutil/trace.go:171","msg":"trace[153879438] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5141; }","duration":"118.793662ms","start":"2026-04-21T15:44:55.39052Z","end":"2026-04-21T15:44:55.509314Z","steps":["trace[153879438] 'agreement among raft nodes before linearized reading' (duration: 118.609857ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:44:55.509403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.945012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-21T15:44:55.509424Z","caller":"traceutil/trace.go:171","msg":"trace[1897053840] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5141; }","duration":"117.978513ms","start":"2026-04-21T15:44:55.39144Z","end":"2026-04-21T15:44:55.509418Z","steps":["trace[1897053840] 'agreement among raft nodes before linearized reading' (duration: 117.925362ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:45:03.679907Z","caller":"traceutil/trace.go:171","msg":"trace[861185110] transaction","detail":"{read_only:false; response_revision:5314; number_of_response:1; }","duration":"122.333928ms","start":"2026-04-21T15:45:03.557538Z","end":"2026-04-21T15:45:03.679872Z","steps":["trace[861185110] 'process raft request' (duration: 122.074382ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:46:28.133057Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2966} {"level":"info","ts":"2026-04-21T15:46:28.207504Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2966,"took":"72.963967ms","hash":931186395,"current-db-size-bytes":58732544,"current-db-size":"59 MB","current-db-size-in-use-bytes":33865728,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-21T15:46:28.207566Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":931186395,"revision":2966,"compact-revision":-1} {"level":"info","ts":"2026-04-21T15:51:15.739663Z","caller":"traceutil/trace.go:171","msg":"trace[1321157985] linearizableReadLoop","detail":"{readStateIndex:8470; appliedIndex:8468; }","duration":"101.591267ms","start":"2026-04-21T15:51:15.638051Z","end":"2026-04-21T15:51:15.739642Z","steps":["trace[1321157985] 'read index received' (duration: 85.359318ms)","trace[1321157985] 'applied index is now lower than readState.Index' (duration: 16.230729ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:51:15.739743Z","caller":"traceutil/trace.go:171","msg":"trace[1503093236] transaction","detail":"{read_only:false; response_revision:8175; number_of_response:1; }","duration":"102.352146ms","start":"2026-04-21T15:51:15.637342Z","end":"2026-04-21T15:51:15.739694Z","steps":["trace[1503093236] 'process raft request' (duration: 102.082539ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:51:15.739862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.783362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-21T15:51:15.739896Z","caller":"traceutil/trace.go:171","msg":"trace[1204886826] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8176; }","duration":"101.869654ms","start":"2026-04-21T15:51:15.638018Z","end":"2026-04-21T15:51:15.739887Z","steps":["trace[1204886826] 'agreement among raft nodes before linearized reading' (duration: 101.716481ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:51:28.138864Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6077} {"level":"info","ts":"2026-04-21T15:51:28.236336Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6077,"took":"95.527752ms","hash":2079927274,"current-db-size-bytes":58732544,"current-db-size":"59 MB","current-db-size-in-use-bytes":23052288,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-21T15:51:28.236413Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2079927274,"revision":6077,"compact-revision":2966} {"level":"warn","ts":"2026-04-21T15:51:57.49139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.515951ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T15:51:57.491549Z","caller":"traceutil/trace.go:171","msg":"trace[1187890114] transaction","detail":"{read_only:false; response_revision:8500; number_of_response:1; }","duration":"254.308818ms","start":"2026-04-21T15:51:57.237196Z","end":"2026-04-21T15:51:57.491505Z","steps":["trace[1187890114] 'process raft request' (duration: 84.50939ms)","trace[1187890114] 'compare' (duration: 169.398038ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:52:48.558627Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002460.wal"} {"level":"info","ts":"2026-04-21T15:53:13.192621Z","caller":"traceutil/trace.go:171","msg":"trace[1948552904] transaction","detail":"{read_only:false; response_revision:9247; number_of_response:1; }","duration":"107.12169ms","start":"2026-04-21T15:53:13.085474Z","end":"2026-04-21T15:53:13.192596Z","steps":["trace[1948552904] 'process raft request' (duration: 106.966056ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:54:09.006209Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"3363378c2227fa42","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-21T15:54:09.011772Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-21T15:54:09.011872Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-21T15:56:28.146404Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8254} {"level":"info","ts":"2026-04-21T15:56:28.224964Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8254,"took":"76.33557ms","hash":3542467520,"current-db-size-bytes":58732544,"current-db-size":"59 MB","current-db-size-in-use-bytes":24760320,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-21T15:56:28.225038Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3542467520,"revision":8254,"compact-revision":6077} {"level":"info","ts":"2026-04-21T16:01:28.151761Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10643} {"level":"info","ts":"2026-04-21T16:01:28.229374Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10643,"took":"75.389891ms","hash":4009172546,"current-db-size-bytes":58732544,"current-db-size":"59 MB","current-db-size-in-use-bytes":20422656,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-21T16:01:28.229434Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4009172546,"revision":10643,"compact-revision":8254}