{"level":"warn","ts":"2026-04-12T18:30:51.709302Z","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-12T18:30:51.709438Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.65: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.65:2380","--initial-cluster=instance=https://199.204.45.65:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.65:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.65: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-12T18:30:51.709514Z","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-12T18:30:51.709522Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.65:2380"]} {"level":"info","ts":"2026-04-12T18:30:51.709541Z","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-12T18:30:51.710166Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"]} {"level":"info","ts":"2026-04-12T18:30:51.710242Z","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.204.45.65:2380"],"listen-peer-urls":["https://199.204.45.65:2380"],"advertise-client-urls":["https://199.204.45.65:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.65: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-12T18:30:51.71507Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.61897ms"} {"level":"info","ts":"2026-04-12T18:30:51.722916Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cf8c3a138c9a77a2","cluster-id":"c278183e1f634dff"} {"level":"info","ts":"2026-04-12T18:30:51.723004Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=()"} {"level":"info","ts":"2026-04-12T18:30:51.723023Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became follower at term 0"} {"level":"info","ts":"2026-04-12T18:30:51.723035Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cf8c3a138c9a77a2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-12T18:30:51.723042Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became follower at term 1"} {"level":"info","ts":"2026-04-12T18:30:51.723073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=(14955392318228297634)"} {"level":"warn","ts":"2026-04-12T18:30:51.731827Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-12T18:30:51.733318Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-12T18:30:51.734823Z","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-12T18:30:51.738539Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cf8c3a138c9a77a2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-12T18:30:51.739044Z","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-12T18:30:51.7392Z","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-12T18:30:51.739113Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cf8c3a138c9a77a2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-12T18:30:51.739219Z","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-12T18:30:51.740047Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=(14955392318228297634)"} {"level":"info","ts":"2026-04-12T18:30:51.740824Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c278183e1f634dff","local-member-id":"cf8c3a138c9a77a2","added-peer-id":"cf8c3a138c9a77a2","added-peer-peer-urls":["https://199.204.45.65:2380"]} {"level":"info","ts":"2026-04-12T18:30:51.743311Z","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-12T18:30:51.743403Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.65:2380"} {"level":"info","ts":"2026-04-12T18:30:51.743447Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.65:2380"} {"level":"info","ts":"2026-04-12T18:30:51.743703Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cf8c3a138c9a77a2","initial-advertise-peer-urls":["https://199.204.45.65:2380"],"listen-peer-urls":["https://199.204.45.65:2380"],"advertise-client-urls":["https://199.204.45.65:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-12T18:30:51.743765Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-12T18:30:52.524249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 is starting a new election at term 1"} {"level":"info","ts":"2026-04-12T18:30:52.524306Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-12T18:30:52.524341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 received MsgPreVoteResp from cf8c3a138c9a77a2 at term 1"} {"level":"info","ts":"2026-04-12T18:30:52.52436Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became candidate at term 2"} {"level":"info","ts":"2026-04-12T18:30:52.524371Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 received MsgVoteResp from cf8c3a138c9a77a2 at term 2"} {"level":"info","ts":"2026-04-12T18:30:52.524395Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became leader at term 2"} {"level":"info","ts":"2026-04-12T18:30:52.524407Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cf8c3a138c9a77a2 elected leader cf8c3a138c9a77a2 at term 2"} {"level":"info","ts":"2026-04-12T18:30:52.526093Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-12T18:30:52.527486Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cf8c3a138c9a77a2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.65:2379]}","request-path":"/0/members/cf8c3a138c9a77a2/attributes","cluster-id":"c278183e1f634dff","publish-timeout":"7s"} {"level":"info","ts":"2026-04-12T18:30:52.527489Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-12T18:30:52.527632Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-12T18:30:52.528005Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-12T18:30:52.528065Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-12T18:30:52.528816Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c278183e1f634dff","local-member-id":"cf8c3a138c9a77a2","cluster-version":"3.5"} {"level":"info","ts":"2026-04-12T18:30:52.528943Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-12T18:30:52.528983Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-12T18:30:52.530759Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.65:2379"} {"level":"info","ts":"2026-04-12T18:30:52.532084Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-12T18:31:23.627976Z","caller":"traceutil/trace.go:171","msg":"trace[1592320757] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"153.225145ms","start":"2026-04-12T18:31:23.474725Z","end":"2026-04-12T18:31:23.62795Z","steps":["trace[1592320757] 'process raft request' (duration: 153.08543ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:31:23.642556Z","caller":"traceutil/trace.go:171","msg":"trace[1592477974] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"166.17565ms","start":"2026-04-12T18:31:23.476357Z","end":"2026-04-12T18:31:23.642533Z","steps":["trace[1592477974] 'process raft request' (duration: 165.980593ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:31:23.642593Z","caller":"traceutil/trace.go:171","msg":"trace[2036314188] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"164.936967ms","start":"2026-04-12T18:31:23.477628Z","end":"2026-04-12T18:31:23.642565Z","steps":["trace[2036314188] 'process raft request' (duration: 164.808873ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:31:23.642669Z","caller":"traceutil/trace.go:171","msg":"trace[1812481527] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"159.727014ms","start":"2026-04-12T18:31:23.482906Z","end":"2026-04-12T18:31:23.642633Z","steps":["trace[1812481527] 'process raft request' (duration: 159.572568ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:31:23.642772Z","caller":"traceutil/trace.go:171","msg":"trace[1859647290] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"156.324694ms","start":"2026-04-12T18:31:23.48643Z","end":"2026-04-12T18:31:23.642755Z","steps":["trace[1859647290] 'process raft request' (duration: 156.126587ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:31:23.642796Z","caller":"traceutil/trace.go:171","msg":"trace[1040478627] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"155.628789ms","start":"2026-04-12T18:31:23.487157Z","end":"2026-04-12T18:31:23.642785Z","steps":["trace[1040478627] 'process raft request' (duration: 155.446312ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:31:23.642872Z","caller":"traceutil/trace.go:171","msg":"trace[228503229] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"159.804576ms","start":"2026-04-12T18:31:23.483056Z","end":"2026-04-12T18:31:23.642861Z","steps":["trace[228503229] 'process raft request' (duration: 159.457564ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:31:23.64295Z","caller":"traceutil/trace.go:171","msg":"trace[657437181] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"155.515904ms","start":"2026-04-12T18:31:23.487424Z","end":"2026-04-12T18:31:23.64294Z","steps":["trace[657437181] 'process raft request' (duration: 155.249825ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:31:23.642956Z","caller":"traceutil/trace.go:171","msg":"trace[691122799] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"143.893055ms","start":"2026-04-12T18:31:23.499054Z","end":"2026-04-12T18:31:23.642947Z","steps":["trace[691122799] 'process raft request' (duration: 143.717699ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:31:23.643004Z","caller":"traceutil/trace.go:171","msg":"trace[1430308369] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"114.372507ms","start":"2026-04-12T18:31:23.528618Z","end":"2026-04-12T18:31:23.64299Z","steps":["trace[1430308369] 'process raft request' (duration: 114.214221ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:31:23.642991Z","caller":"traceutil/trace.go:171","msg":"trace[2117429270] linearizableReadLoop","detail":"{readStateIndex:538; appliedIndex:529; }","duration":"118.210911ms","start":"2026-04-12T18:31:23.524756Z","end":"2026-04-12T18:31:23.642967Z","steps":["trace[2117429270] 'read index received' (duration: 103.127161ms)","trace[2117429270] 'applied index is now lower than readState.Index' (duration: 15.08286ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T18:31:23.643071Z","caller":"traceutil/trace.go:171","msg":"trace[644934377] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"101.41159ms","start":"2026-04-12T18:31:23.541646Z","end":"2026-04-12T18:31:23.643058Z","steps":["trace[644934377] 'process raft request' (duration: 101.261575ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:31:23.643178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.352467ms","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-12T18:31:23.64324Z","caller":"traceutil/trace.go:171","msg":"trace[796761730] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:523; }","duration":"118.511452ms","start":"2026-04-12T18:31:23.524718Z","end":"2026-04-12T18:31:23.643229Z","steps":["trace[796761730] 'agreement among raft nodes before linearized reading' (duration: 118.334496ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:31:29.860311Z","caller":"traceutil/trace.go:171","msg":"trace[649887810] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"157.556037ms","start":"2026-04-12T18:31:29.702722Z","end":"2026-04-12T18:31:29.860278Z","steps":["trace[649887810] 'process raft request' (duration: 157.300908ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:31:29.997078Z","caller":"traceutil/trace.go:171","msg":"trace[2014590623] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"256.639905ms","start":"2026-04-12T18:31:29.740376Z","end":"2026-04-12T18:31:29.997016Z","steps":["trace[2014590623] 'process raft request' (duration: 255.886308ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:31:30.173904Z","caller":"traceutil/trace.go:171","msg":"trace[927869045] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"172.477962ms","start":"2026-04-12T18:31:30.001396Z","end":"2026-04-12T18:31:30.173874Z","steps":["trace[927869045] 'process raft request' (duration: 107.527265ms)","trace[927869045] 'compare' (duration: 64.818652ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T18:31:30.211885Z","caller":"traceutil/trace.go:171","msg":"trace[893657587] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"149.502063ms","start":"2026-04-12T18:31:30.062307Z","end":"2026-04-12T18:31:30.211809Z","steps":["trace[893657587] 'process raft request' (duration: 149.311017ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:31:30.769457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.36315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-h45cl\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-12T18:31:30.769524Z","caller":"traceutil/trace.go:171","msg":"trace[151022428] range","detail":"{range_begin:/registry/pods/kube-system/cilium-h45cl; range_end:; response_count:1; response_revision:625; }","duration":"468.474564ms","start":"2026-04-12T18:31:30.301033Z","end":"2026-04-12T18:31:30.769507Z","steps":["trace[151022428] 'range keys from in-memory index tree' (duration: 468.179984ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:31:30.769583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T18:31:30.301014Z","time spent":"468.560417ms","remote":"127.0.0.1:35762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16985,"request content":"key:\"/registry/pods/kube-system/cilium-h45cl\" "} {"level":"info","ts":"2026-04-12T18:31:30.771494Z","caller":"traceutil/trace.go:171","msg":"trace[413457789] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:646; }","duration":"107.408641ms","start":"2026-04-12T18:31:30.664071Z","end":"2026-04-12T18:31:30.771479Z","steps":["trace[413457789] 'read index received' (duration: 106.579292ms)","trace[413457789] 'applied index is now lower than readState.Index' (duration: 828.549µs)"],"step_count":2} {"level":"warn","ts":"2026-04-12T18:31:30.771568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.508955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-12T18:31:30.771591Z","caller":"traceutil/trace.go:171","msg":"trace[31823160] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:626; }","duration":"107.584669ms","start":"2026-04-12T18:31:30.663998Z","end":"2026-04-12T18:31:30.771583Z","steps":["trace[31823160] 'agreement among raft nodes before linearized reading' (duration: 107.534847ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:31:30.771568Z","caller":"traceutil/trace.go:171","msg":"trace[371732820] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"123.500249ms","start":"2026-04-12T18:31:30.648047Z","end":"2026-04-12T18:31:30.771548Z","steps":["trace[371732820] 'process raft request' (duration: 122.793064ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:31:32.547093Z","caller":"traceutil/trace.go:171","msg":"trace[420694310] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"114.265203ms","start":"2026-04-12T18:31:32.432799Z","end":"2026-04-12T18:31:32.547064Z","steps":["trace[420694310] 'process raft request' (duration: 85.391826ms)","trace[420694310] 'compare' (duration: 28.691041ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T18:31:32.553108Z","caller":"traceutil/trace.go:171","msg":"trace[1264093925] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"101.319597ms","start":"2026-04-12T18:31:32.45177Z","end":"2026-04-12T18:31:32.55309Z","steps":["trace[1264093925] 'process raft request' (duration: 101.187563ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:31:32.782161Z","caller":"traceutil/trace.go:171","msg":"trace[1730210580] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"222.766064ms","start":"2026-04-12T18:31:32.559374Z","end":"2026-04-12T18:31:32.78214Z","steps":["trace[1730210580] 'process raft request' (duration: 222.699861ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:31:32.782586Z","caller":"traceutil/trace.go:171","msg":"trace[1945569891] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"223.116325ms","start":"2026-04-12T18:31:32.55938Z","end":"2026-04-12T18:31:32.782497Z","steps":["trace[1945569891] 'process raft request' (duration: 194.325261ms)","trace[1945569891] 'compare' (duration: 28.226854ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T18:31:32.79833Z","caller":"traceutil/trace.go:171","msg":"trace[828374210] linearizableReadLoop","detail":"{readStateIndex:685; appliedIndex:682; }","duration":"233.993057ms","start":"2026-04-12T18:31:32.564321Z","end":"2026-04-12T18:31:32.798314Z","steps":["trace[828374210] 'read index received' (duration: 189.397567ms)","trace[828374210] 'applied index is now lower than readState.Index' (duration: 44.59479ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T18:31:32.798414Z","caller":"traceutil/trace.go:171","msg":"trace[895436061] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"120.443981ms","start":"2026-04-12T18:31:32.677963Z","end":"2026-04-12T18:31:32.798407Z","steps":["trace[895436061] 'process raft request' (duration: 120.307196ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:31:32.798554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.203005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-12T18:31:32.798593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.257007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-12T18:31:32.798478Z","caller":"traceutil/trace.go:171","msg":"trace[777713775] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"239.021234ms","start":"2026-04-12T18:31:32.559408Z","end":"2026-04-12T18:31:32.798429Z","steps":["trace[777713775] 'process raft request' (duration: 238.575829ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:31:32.798637Z","caller":"traceutil/trace.go:171","msg":"trace[1285224203] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:664; }","duration":"234.316849ms","start":"2026-04-12T18:31:32.564311Z","end":"2026-04-12T18:31:32.798628Z","steps":["trace[1285224203] 'agreement among raft nodes before linearized reading' (duration: 234.228666ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:31:32.798645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.917985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-12T18:31:32.7987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.830697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-12T18:31:32.798726Z","caller":"traceutil/trace.go:171","msg":"trace[566324357] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:664; }","duration":"134.886999ms","start":"2026-04-12T18:31:32.663831Z","end":"2026-04-12T18:31:32.798718Z","steps":["trace[566324357] 'agreement among raft nodes before linearized reading' (duration: 134.845507ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:31:32.79871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.950093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-12T18:31:32.79879Z","caller":"traceutil/trace.go:171","msg":"trace[1861331487] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:664; }","duration":"141.064488ms","start":"2026-04-12T18:31:32.657715Z","end":"2026-04-12T18:31:32.79878Z","steps":["trace[1861331487] 'agreement among raft nodes before linearized reading' (duration: 140.919532ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:31:32.798807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.474877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-12T18:31:32.798772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.773561ms","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":"info","ts":"2026-04-12T18:31:32.798893Z","caller":"traceutil/trace.go:171","msg":"trace[822886378] 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:664; }","duration":"114.917746ms","start":"2026-04-12T18:31:32.683966Z","end":"2026-04-12T18:31:32.798883Z","steps":["trace[822886378] 'agreement among raft nodes before linearized reading' (duration: 114.73619ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:31:32.798896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.318676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-12T18:31:32.798921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.141096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-12T18:31:32.798949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.964653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-12T18:31:32.798958Z","caller":"traceutil/trace.go:171","msg":"trace[924186257] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:664; }","duration":"166.409439ms","start":"2026-04-12T18:31:32.632532Z","end":"2026-04-12T18:31:32.798941Z","steps":["trace[924186257] 'agreement among raft nodes before linearized reading' (duration: 166.323026ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:31:32.798971Z","caller":"traceutil/trace.go:171","msg":"trace[1556411579] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:664; }","duration":"140.995575ms","start":"2026-04-12T18:31:32.657969Z","end":"2026-04-12T18:31:32.798965Z","steps":["trace[1556411579] 'agreement among raft nodes before linearized reading' (duration: 140.963744ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:31:32.798969Z","caller":"traceutil/trace.go:171","msg":"trace[1949046128] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:664; }","duration":"194.228619ms","start":"2026-04-12T18:31:32.604729Z","end":"2026-04-12T18:31:32.798957Z","steps":["trace[1949046128] 'agreement among raft nodes before linearized reading' (duration: 194.149186ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:31:32.798715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.515631ms","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-12T18:31:32.799028Z","caller":"traceutil/trace.go:171","msg":"trace[1360163978] 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:664; }","duration":"114.889785ms","start":"2026-04-12T18:31:32.684127Z","end":"2026-04-12T18:31:32.799017Z","steps":["trace[1360163978] 'agreement among raft nodes before linearized reading' (duration: 114.473619ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:31:32.798736Z","caller":"traceutil/trace.go:171","msg":"trace[485006670] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:664; }","duration":"234.04184ms","start":"2026-04-12T18:31:32.564673Z","end":"2026-04-12T18:31:32.798715Z","steps":["trace[485006670] 'agreement among raft nodes before linearized reading' (duration: 233.891154ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:31:32.799085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.397988ms","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":"info","ts":"2026-04-12T18:31:32.799132Z","caller":"traceutil/trace.go:171","msg":"trace[291696607] 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:664; }","duration":"114.46761ms","start":"2026-04-12T18:31:32.684643Z","end":"2026-04-12T18:31:32.799111Z","steps":["trace[291696607] 'agreement among raft nodes before linearized reading' (duration: 114.422789ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:31:32.799139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.516734ms","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-12T18:31:32.799186Z","caller":"traceutil/trace.go:171","msg":"trace[1015074567] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:664; }","duration":"166.582666ms","start":"2026-04-12T18:31:32.63258Z","end":"2026-04-12T18:31:32.799163Z","steps":["trace[1015074567] 'agreement among raft nodes before linearized reading' (duration: 166.523064ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:31:32.799243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.54104ms","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-12T18:31:32.798853Z","caller":"traceutil/trace.go:171","msg":"trace[357610365] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:664; }","duration":"165.55232ms","start":"2026-04-12T18:31:32.633289Z","end":"2026-04-12T18:31:32.798842Z","steps":["trace[357610365] 'agreement among raft nodes before linearized reading' (duration: 165.481667ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:31:32.799304Z","caller":"traceutil/trace.go:171","msg":"trace[1812118084] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:664; }","duration":"194.628712ms","start":"2026-04-12T18:31:32.60466Z","end":"2026-04-12T18:31:32.799289Z","steps":["trace[1812118084] 'agreement among raft nodes before linearized reading' (duration: 194.541539ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:31:32.798674Z","caller":"traceutil/trace.go:171","msg":"trace[976666306] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:664; }","duration":"234.323259ms","start":"2026-04-12T18:31:32.564293Z","end":"2026-04-12T18:31:32.798616Z","steps":["trace[976666306] 'agreement among raft nodes before linearized reading' (duration: 234.192594ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:31:32.798918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.15409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-12T18:31:32.799416Z","caller":"traceutil/trace.go:171","msg":"trace[1161331512] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:664; }","duration":"141.678018ms","start":"2026-04-12T18:31:32.65773Z","end":"2026-04-12T18:31:32.799408Z","steps":["trace[1161331512] 'agreement among raft nodes before linearized reading' (duration: 141.164131ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:32:29.805601Z","caller":"traceutil/trace.go:171","msg":"trace[704946180] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"122.565767ms","start":"2026-04-12T18:32:29.683018Z","end":"2026-04-12T18:32:29.805584Z","steps":["trace[704946180] 'process raft request' (duration: 122.459584ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:33:01.767849Z","caller":"traceutil/trace.go:171","msg":"trace[1892692154] linearizableReadLoop","detail":"{readStateIndex:1934; appliedIndex:1933; }","duration":"104.606486ms","start":"2026-04-12T18:33:01.663221Z","end":"2026-04-12T18:33:01.767827Z","steps":["trace[1892692154] 'read index received' (duration: 104.344529ms)","trace[1892692154] 'applied index is now lower than readState.Index' (duration: 261.017µs)"],"step_count":2} {"level":"info","ts":"2026-04-12T18:33:01.767976Z","caller":"traceutil/trace.go:171","msg":"trace[1387806207] transaction","detail":"{read_only:false; response_revision:1866; number_of_response:1; }","duration":"131.352708ms","start":"2026-04-12T18:33:01.636572Z","end":"2026-04-12T18:33:01.767925Z","steps":["trace[1387806207] 'process raft request' (duration: 131.097061ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:33:01.76802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.775091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-12T18:33:01.768214Z","caller":"traceutil/trace.go:171","msg":"trace[346871101] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1866; }","duration":"105.010597ms","start":"2026-04-12T18:33:01.66318Z","end":"2026-04-12T18:33:01.768191Z","steps":["trace[346871101] 'agreement among raft nodes before linearized reading' (duration: 104.77209ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:33:02.046069Z","caller":"traceutil/trace.go:171","msg":"trace[2088024804] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"191.476309ms","start":"2026-04-12T18:33:01.854558Z","end":"2026-04-12T18:33:02.046034Z","steps":["trace[2088024804] 'process raft request' (duration: 136.890435ms)","trace[2088024804] 'compare' (duration: 54.280405ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T18:33:02.251173Z","caller":"traceutil/trace.go:171","msg":"trace[156418305] linearizableReadLoop","detail":"{readStateIndex:1936; appliedIndex:1935; }","duration":"216.578262ms","start":"2026-04-12T18:33:02.03457Z","end":"2026-04-12T18:33:02.251148Z","steps":["trace[156418305] 'read index received' (duration: 174.516035ms)","trace[156418305] 'applied index is now lower than readState.Index' (duration: 42.061197ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T18:33:02.251265Z","caller":"traceutil/trace.go:171","msg":"trace[1060120666] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"320.337364ms","start":"2026-04-12T18:33:01.930884Z","end":"2026-04-12T18:33:02.251221Z","steps":["trace[1060120666] 'process raft request' (duration: 278.175844ms)","trace[1060120666] 'compare' (duration: 41.973984ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T18:33:02.251302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.702635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-12T18:33:02.251608Z","caller":"traceutil/trace.go:171","msg":"trace[1895788220] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1868; }","duration":"217.066055ms","start":"2026-04-12T18:33:02.034527Z","end":"2026-04-12T18:33:02.251594Z","steps":["trace[1895788220] 'agreement among raft nodes before linearized reading' (duration: 216.715885ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:33:02.251979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T18:33:01.930858Z","time spent":"320.490708ms","remote":"127.0.0.1:35822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-12T18:33:14.828753Z","caller":"traceutil/trace.go:171","msg":"trace[1475932150] transaction","detail":"{read_only:false; response_revision:1972; number_of_response:1; }","duration":"122.767183ms","start":"2026-04-12T18:33:14.705899Z","end":"2026-04-12T18:33:14.828667Z","steps":["trace[1475932150] 'process raft request' (duration: 110.689989ms)","trace[1475932150] 'compare' (duration: 11.962701ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T18:33:51.21857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.708623ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-12T18:33:51.218674Z","caller":"traceutil/trace.go:171","msg":"trace[702909530] linearizableReadLoop","detail":"{readStateIndex:2262; appliedIndex:2261; }","duration":"179.576642ms","start":"2026-04-12T18:33:51.039082Z","end":"2026-04-12T18:33:51.218658Z","steps":["trace[702909530] 'read index received' (duration: 73.527708ms)","trace[702909530] 'applied index is now lower than readState.Index' (duration: 106.047784ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T18:33:51.218735Z","caller":"traceutil/trace.go:171","msg":"trace[1322162887] transaction","detail":"{read_only:false; response_revision:2184; number_of_response:1; }","duration":"189.80386ms","start":"2026-04-12T18:33:51.028902Z","end":"2026-04-12T18:33:51.218706Z","steps":["trace[1322162887] 'process raft request' (duration: 83.682354ms)","trace[1322162887] 'compare' (duration: 105.452336ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T18:33:51.218853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.558877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-12T18:33:51.218887Z","caller":"traceutil/trace.go:171","msg":"trace[158736203] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2184; }","duration":"171.624289ms","start":"2026-04-12T18:33:51.047255Z","end":"2026-04-12T18:33:51.218879Z","steps":["trace[158736203] 'agreement among raft nodes before linearized reading' (duration: 171.493555ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:33:51.218893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.782267ms","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-12T18:33:51.218982Z","caller":"traceutil/trace.go:171","msg":"trace[1970318120] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2184; }","duration":"179.909122ms","start":"2026-04-12T18:33:51.039051Z","end":"2026-04-12T18:33:51.21896Z","steps":["trace[1970318120] 'agreement among raft nodes before linearized reading' (duration: 179.671985ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:33:51.219021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.551958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-12T18:33:51.219053Z","caller":"traceutil/trace.go:171","msg":"trace[699839447] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2184; }","duration":"160.605089ms","start":"2026-04-12T18:33:51.058437Z","end":"2026-04-12T18:33:51.219042Z","steps":["trace[699839447] 'agreement among raft nodes before linearized reading' (duration: 160.526407ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:33:51.392941Z","caller":"traceutil/trace.go:171","msg":"trace[346409756] transaction","detail":"{read_only:false; response_revision:2185; number_of_response:1; }","duration":"169.611322ms","start":"2026-04-12T18:33:51.223304Z","end":"2026-04-12T18:33:51.392916Z","steps":["trace[346409756] 'process raft request' (duration: 126.474318ms)","trace[346409756] 'compare' (duration: 42.969119ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T18:33:51.393201Z","caller":"traceutil/trace.go:171","msg":"trace[1588170759] transaction","detail":"{read_only:false; response_revision:2187; number_of_response:1; }","duration":"168.482899ms","start":"2026-04-12T18:33:51.224693Z","end":"2026-04-12T18:33:51.393176Z","steps":["trace[1588170759] 'process raft request' (duration: 168.400107ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:33:51.3933Z","caller":"traceutil/trace.go:171","msg":"trace[442809038] transaction","detail":"{read_only:false; response_revision:2186; number_of_response:1; }","duration":"169.756086ms","start":"2026-04-12T18:33:51.223499Z","end":"2026-04-12T18:33:51.393255Z","steps":["trace[442809038] 'process raft request' (duration: 169.373316ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:33:57.451379Z","caller":"traceutil/trace.go:171","msg":"trace[812874362] transaction","detail":"{read_only:false; response_revision:2216; number_of_response:1; }","duration":"213.061744ms","start":"2026-04-12T18:33:57.238284Z","end":"2026-04-12T18:33:57.451346Z","steps":["trace[812874362] 'process raft request' (duration: 212.842368ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:33:57.62988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.296774ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-12T18:33:57.630046Z","caller":"traceutil/trace.go:171","msg":"trace[174549107] transaction","detail":"{read_only:false; response_revision:2219; number_of_response:1; }","duration":"173.984835ms","start":"2026-04-12T18:33:57.456047Z","end":"2026-04-12T18:33:57.630032Z","steps":["trace[174549107] 'process raft request' (duration: 173.954145ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:33:57.630043Z","caller":"traceutil/trace.go:171","msg":"trace[210473571] transaction","detail":"{read_only:false; response_revision:2217; number_of_response:1; }","duration":"174.032846ms","start":"2026-04-12T18:33:57.455982Z","end":"2026-04-12T18:33:57.630015Z","steps":["trace[210473571] 'process raft request' (duration: 42.527176ms)","trace[210473571] 'compare' (duration: 131.194991ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T18:33:57.630184Z","caller":"traceutil/trace.go:171","msg":"trace[1190699867] transaction","detail":"{read_only:false; response_revision:2218; number_of_response:1; }","duration":"174.122819ms","start":"2026-04-12T18:33:57.456034Z","end":"2026-04-12T18:33:57.630156Z","steps":["trace[1190699867] 'process raft request' (duration: 173.925713ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:38:59.437568Z","caller":"traceutil/trace.go:171","msg":"trace[948728316] transaction","detail":"{read_only:false; response_revision:4677; number_of_response:1; }","duration":"117.284737ms","start":"2026-04-12T18:38:59.320262Z","end":"2026-04-12T18:38:59.437547Z","steps":["trace[948728316] 'process raft request' (duration: 117.141333ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:39:10.142877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.920516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-12T18:39:10.142852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.173898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-33e07d19-23f8-46ce-90e3-692386aa4210\" ","response":"range_response_count:1 size:3600"} {"level":"info","ts":"2026-04-12T18:39:10.142936Z","caller":"traceutil/trace.go:171","msg":"trace[1853052907] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:0; response_revision:5017; }","duration":"204.014448ms","start":"2026-04-12T18:39:09.938909Z","end":"2026-04-12T18:39:10.142924Z","steps":["trace[1853052907] 'range keys from in-memory index tree' (duration: 203.844624ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:39:10.142966Z","caller":"traceutil/trace.go:171","msg":"trace[719206195] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-33e07d19-23f8-46ce-90e3-692386aa4210; range_end:; response_count:1; response_revision:5017; }","duration":"120.343163ms","start":"2026-04-12T18:39:10.022598Z","end":"2026-04-12T18:39:10.142941Z","steps":["trace[719206195] 'range keys from in-memory index tree' (duration: 119.985303ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:39:10.143061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.997433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-lmlg6-tls\" ","response":"range_response_count:1 size:1966"} {"level":"info","ts":"2026-04-12T18:39:10.143151Z","caller":"traceutil/trace.go:171","msg":"trace[694240366] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-lmlg6-tls; range_end:; response_count:1; response_revision:5017; }","duration":"171.145957ms","start":"2026-04-12T18:39:09.971983Z","end":"2026-04-12T18:39:10.143129Z","steps":["trace[694240366] 'range keys from in-memory index tree' (duration: 170.779657ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:39:10.518449Z","caller":"traceutil/trace.go:171","msg":"trace[1843402534] linearizableReadLoop","detail":"{readStateIndex:5208; appliedIndex:5207; }","duration":"112.633837ms","start":"2026-04-12T18:39:10.405786Z","end":"2026-04-12T18:39:10.518419Z","steps":["trace[1843402534] 'read index received' (duration: 92.7627ms)","trace[1843402534] 'applied index is now lower than readState.Index' (duration: 19.869987ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T18:39:10.518735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.931316ms","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-12T18:39:10.518806Z","caller":"traceutil/trace.go:171","msg":"trace[1057310890] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5027; }","duration":"113.058639ms","start":"2026-04-12T18:39:10.405731Z","end":"2026-04-12T18:39:10.518789Z","steps":["trace[1057310890] 'agreement among raft nodes before linearized reading' (duration: 112.802082ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:39:10.519292Z","caller":"traceutil/trace.go:171","msg":"trace[936573775] transaction","detail":"{read_only:false; response_revision:5027; number_of_response:1; }","duration":"114.993474ms","start":"2026-04-12T18:39:10.404281Z","end":"2026-04-12T18:39:10.519275Z","steps":["trace[936573775] 'process raft request' (duration: 94.323454ms)","trace[936573775] 'compare' (duration: 19.663072ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T18:39:21.469122Z","caller":"traceutil/trace.go:171","msg":"trace[879824381] transaction","detail":"{read_only:false; response_revision:5232; number_of_response:1; }","duration":"147.129464ms","start":"2026-04-12T18:39:21.321971Z","end":"2026-04-12T18:39:21.4691Z","steps":["trace[879824381] 'process raft request' (duration: 146.820956ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:39:21.469109Z","caller":"traceutil/trace.go:171","msg":"trace[736491254] linearizableReadLoop","detail":"{readStateIndex:5420; appliedIndex:5418; }","duration":"141.360162ms","start":"2026-04-12T18:39:21.327717Z","end":"2026-04-12T18:39:21.469077Z","steps":["trace[736491254] 'read index received' (duration: 69.530839ms)","trace[736491254] 'applied index is now lower than readState.Index' (duration: 71.827863ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T18:39:21.469306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.583179ms","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-12T18:39:21.469385Z","caller":"traceutil/trace.go:171","msg":"trace[983274446] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5232; }","duration":"141.679772ms","start":"2026-04-12T18:39:21.327664Z","end":"2026-04-12T18:39:21.469344Z","steps":["trace[983274446] 'agreement among raft nodes before linearized reading' (duration: 141.503467ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:39:21.469522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.308117ms","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-12T18:39:21.469581Z","caller":"traceutil/trace.go:171","msg":"trace[1008608385] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5232; }","duration":"133.41609ms","start":"2026-04-12T18:39:21.336151Z","end":"2026-04-12T18:39:21.469567Z","steps":["trace[1008608385] 'agreement among raft nodes before linearized reading' (duration: 133.220805ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:39:21.990025Z","caller":"traceutil/trace.go:171","msg":"trace[1129867359] transaction","detail":"{read_only:false; response_revision:5238; number_of_response:1; }","duration":"147.28071ms","start":"2026-04-12T18:39:21.84272Z","end":"2026-04-12T18:39:21.990001Z","steps":["trace[1129867359] 'process raft request' (duration: 147.138716ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:39:30.089477Z","caller":"traceutil/trace.go:171","msg":"trace[1150800868] transaction","detail":"{read_only:false; response_revision:5418; number_of_response:1; }","duration":"170.329615ms","start":"2026-04-12T18:39:29.919119Z","end":"2026-04-12T18:39:30.089449Z","steps":["trace[1150800868] 'process raft request' (duration: 170.15375ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:39:30.252364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.998447ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-12T18:39:30.252573Z","caller":"traceutil/trace.go:171","msg":"trace[1243275985] transaction","detail":"{read_only:false; response_revision:5419; number_of_response:1; }","duration":"225.181002ms","start":"2026-04-12T18:39:30.027308Z","end":"2026-04-12T18:39:30.252489Z","steps":["trace[1243275985] 'process raft request' (duration: 111.980769ms)","trace[1243275985] 'compare' (duration: 112.871154ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T18:39:30.442465Z","caller":"traceutil/trace.go:171","msg":"trace[1753293791] transaction","detail":"{read_only:false; response_revision:5422; number_of_response:1; }","duration":"109.758596ms","start":"2026-04-12T18:39:30.332669Z","end":"2026-04-12T18:39:30.442428Z","steps":["trace[1753293791] 'process raft request' (duration: 51.231536ms)","trace[1753293791] 'compare' (duration: 58.345955ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T18:39:42.521976Z","caller":"traceutil/trace.go:171","msg":"trace[80872559] transaction","detail":"{read_only:false; response_revision:5584; number_of_response:1; }","duration":"148.737419ms","start":"2026-04-12T18:39:42.373197Z","end":"2026-04-12T18:39:42.521934Z","steps":["trace[80872559] 'process raft request' (duration: 83.044417ms)","trace[80872559] 'compare' (duration: 65.520078ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T18:40:52.567754Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3041} {"level":"info","ts":"2026-04-12T18:40:52.650529Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3041,"took":"81.217259ms","hash":2132922446,"current-db-size-bytes":57737216,"current-db-size":"58 MB","current-db-size-in-use-bytes":31977472,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-12T18:40:52.6506Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2132922446,"revision":3041,"compact-revision":-1} {"level":"info","ts":"2026-04-12T18:45:51.01644Z","caller":"traceutil/trace.go:171","msg":"trace[701386854] linearizableReadLoop","detail":"{readStateIndex:8617; appliedIndex:8616; }","duration":"288.176006ms","start":"2026-04-12T18:45:50.728232Z","end":"2026-04-12T18:45:51.016408Z","steps":["trace[701386854] 'read index received' (duration: 287.765865ms)","trace[701386854] 'applied index is now lower than readState.Index' (duration: 408.601µs)"],"step_count":2} {"level":"info","ts":"2026-04-12T18:45:51.016526Z","caller":"traceutil/trace.go:171","msg":"trace[1303109192] transaction","detail":"{read_only:false; response_revision:8334; number_of_response:1; }","duration":"330.736168ms","start":"2026-04-12T18:45:50.685732Z","end":"2026-04-12T18:45:51.016468Z","steps":["trace[1303109192] 'process raft request' (duration: 330.45354ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:45:51.01674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.483124ms","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-12T18:45:51.016742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T18:45:50.685701Z","time spent":"330.924153ms","remote":"127.0.0.1:35614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1119,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-12T18:45:51.016787Z","caller":"traceutil/trace.go:171","msg":"trace[195947688] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8334; }","duration":"288.604367ms","start":"2026-04-12T18:45:50.728172Z","end":"2026-04-12T18:45:51.016776Z","steps":["trace[195947688] 'agreement among raft nodes before linearized reading' (duration: 288.402872ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:45:51.075241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.693937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-12T18:45:51.07533Z","caller":"traceutil/trace.go:171","msg":"trace[1123364834] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:8334; }","duration":"239.808221ms","start":"2026-04-12T18:45:50.835503Z","end":"2026-04-12T18:45:51.075311Z","steps":["trace[1123364834] 'agreement among raft nodes before linearized reading' (duration: 239.663687ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:45:51.977538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.983012ms","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-12T18:45:51.977664Z","caller":"traceutil/trace.go:171","msg":"trace[1315026082] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8336; }","duration":"297.181267ms","start":"2026-04-12T18:45:51.68046Z","end":"2026-04-12T18:45:51.977641Z","steps":["trace[1315026082] 'range keys from in-memory index tree' (duration: 296.717985ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:45:51.977926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.988754ms","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-12T18:45:51.978Z","caller":"traceutil/trace.go:171","msg":"trace[1804792944] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8336; }","duration":"291.126639ms","start":"2026-04-12T18:45:51.686854Z","end":"2026-04-12T18:45:51.97798Z","steps":["trace[1804792944] 'range keys from in-memory index tree' (duration: 290.774469ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:45:51.978177Z","caller":"traceutil/trace.go:171","msg":"trace[1862700576] transaction","detail":"{read_only:false; response_revision:8337; number_of_response:1; }","duration":"116.954307ms","start":"2026-04-12T18:45:51.86119Z","end":"2026-04-12T18:45:51.978145Z","steps":["trace[1862700576] 'process raft request' (duration: 46.578375ms)","trace[1862700576] 'compare' (duration: 70.085354ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T18:45:52.186194Z","caller":"traceutil/trace.go:171","msg":"trace[1974831262] linearizableReadLoop","detail":"{readStateIndex:8625; appliedIndex:8624; }","duration":"105.977499ms","start":"2026-04-12T18:45:52.08018Z","end":"2026-04-12T18:45:52.186158Z","steps":["trace[1974831262] 'read index received' (duration: 6.289676ms)","trace[1974831262] 'applied index is now lower than readState.Index' (duration: 99.686733ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T18:45:52.186242Z","caller":"traceutil/trace.go:171","msg":"trace[1862784197] transaction","detail":"{read_only:false; response_revision:8341; number_of_response:1; }","duration":"118.384107ms","start":"2026-04-12T18:45:52.067794Z","end":"2026-04-12T18:45:52.186178Z","steps":["trace[1862784197] 'process raft request' (duration: 18.810198ms)","trace[1862784197] 'compare' (duration: 99.340373ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T18:45:52.186644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.438953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-pdcs4\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-04-12T18:45:52.187007Z","caller":"traceutil/trace.go:171","msg":"trace[2100844071] range","detail":"{range_begin:/registry/pods/openstack/keepalived-pdcs4; range_end:; response_count:1; response_revision:8341; }","duration":"106.876355ms","start":"2026-04-12T18:45:52.080104Z","end":"2026-04-12T18:45:52.186981Z","steps":["trace[2100844071] 'agreement among raft nodes before linearized reading' (duration: 106.154775ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:45:52.72549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.454878ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-12T18:45:52.725646Z","caller":"traceutil/trace.go:171","msg":"trace[103142537] transaction","detail":"{read_only:false; response_revision:8343; number_of_response:1; }","duration":"212.924807ms","start":"2026-04-12T18:45:52.512696Z","end":"2026-04-12T18:45:52.725621Z","steps":["trace[103142537] 'process raft request' (duration: 48.17244ms)","trace[103142537] 'compare' (duration: 164.292714ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T18:45:52.909777Z","caller":"traceutil/trace.go:171","msg":"trace[2076675436] linearizableReadLoop","detail":"{readStateIndex:8629; appliedIndex:8627; }","duration":"245.359445ms","start":"2026-04-12T18:45:52.664371Z","end":"2026-04-12T18:45:52.909731Z","steps":["trace[2076675436] 'read index received' (duration: 173.392928ms)","trace[2076675436] 'applied index is now lower than readState.Index' (duration: 71.964487ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T18:45:52.909808Z","caller":"traceutil/trace.go:171","msg":"trace[1454920262] transaction","detail":"{read_only:false; response_revision:8345; number_of_response:1; }","duration":"339.814142ms","start":"2026-04-12T18:45:52.569962Z","end":"2026-04-12T18:45:52.909776Z","steps":["trace[1454920262] 'process raft request' (duration: 339.681449ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:45:52.909836Z","caller":"traceutil/trace.go:171","msg":"trace[297570307] transaction","detail":"{read_only:false; response_revision:8344; number_of_response:1; }","duration":"387.22988ms","start":"2026-04-12T18:45:52.522539Z","end":"2026-04-12T18:45:52.909769Z","steps":["trace[297570307] 'process raft request' (duration: 315.256853ms)","trace[297570307] 'compare' (duration: 71.514944ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T18:45:52.91032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.88016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-12T18:45:52.91035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T18:45:52.569921Z","time spent":"340.283706ms","remote":"127.0.0.1:35542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":25,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-12T18:45:52.910476Z","caller":"traceutil/trace.go:171","msg":"trace[1471706103] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8345; }","duration":"246.118877ms","start":"2026-04-12T18:45:52.664294Z","end":"2026-04-12T18:45:52.910413Z","steps":["trace[1471706103] 'agreement among raft nodes before linearized reading' (duration: 245.584022ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:45:52.910647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T18:45:52.522503Z","time spent":"387.919149ms","remote":"127.0.0.1:35822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-12T18:45:53.147852Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6174} {"level":"warn","ts":"2026-04-12T18:45:53.149091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.220681ms","expected-duration":"100ms","prefix":"","request":"header: compaction: ","response":"size:5"} {"level":"info","ts":"2026-04-12T18:45:53.149247Z","caller":"traceutil/trace.go:171","msg":"trace[15614787] linearizableReadLoop","detail":"{readStateIndex:8630; appliedIndex:8629; }","duration":"236.760344ms","start":"2026-04-12T18:45:52.912461Z","end":"2026-04-12T18:45:53.149221Z","steps":["trace[15614787] 'read index received' (duration: 101.124553ms)","trace[15614787] 'applied index is now lower than readState.Index' (duration: 135.633931ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T18:45:53.149446Z","caller":"traceutil/trace.go:171","msg":"trace[1763053574] compact","detail":"{revision:6174; response_revision:8345; }","duration":"237.182556ms","start":"2026-04-12T18:45:52.912149Z","end":"2026-04-12T18:45:53.149331Z","steps":["trace[1763053574] 'process raft request' (duration: 101.434772ms)","trace[1763053574] 'check and update compact revision' (duration: 134.056637ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T18:45:53.149573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.085874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-12T18:45:53.14971Z","caller":"traceutil/trace.go:171","msg":"trace[2092773441] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8345; }","duration":"237.315739ms","start":"2026-04-12T18:45:52.912367Z","end":"2026-04-12T18:45:53.149682Z","steps":["trace[2092773441] 'agreement among raft nodes before linearized reading' (duration: 237.020741ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:45:53.309776Z","caller":"traceutil/trace.go:171","msg":"trace[916774934] transaction","detail":"{read_only:false; response_revision:8346; number_of_response:1; }","duration":"154.065507ms","start":"2026-04-12T18:45:53.155593Z","end":"2026-04-12T18:45:53.309658Z","steps":["trace[916774934] 'process raft request' (duration: 97.859591ms)","trace[916774934] 'compare' (duration: 14.090655ms)","trace[916774934] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/kube-system/cilium-operator-resource-lock; req_size:472; } (duration: 41.620937ms)"],"step_count":3} {"level":"info","ts":"2026-04-12T18:45:53.608558Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6174,"took":"457.621194ms","hash":3219797084,"current-db-size-bytes":57737216,"current-db-size":"58 MB","current-db-size-in-use-bytes":23764992,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-04-12T18:45:53.608668Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3219797084,"revision":6174,"compact-revision":3041} {"level":"warn","ts":"2026-04-12T18:45:53.811983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.012913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-12T18:45:53.812089Z","caller":"traceutil/trace.go:171","msg":"trace[2073248738] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8347; }","duration":"145.199569ms","start":"2026-04-12T18:45:53.666867Z","end":"2026-04-12T18:45:53.812066Z","steps":["trace[2073248738] 'range keys from in-memory index tree' (duration: 144.87041ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:45:53.812327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.61924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-04-12T18:45:53.812437Z","caller":"traceutil/trace.go:171","msg":"trace[601553534] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:8347; }","duration":"125.842017ms","start":"2026-04-12T18:45:53.68657Z","end":"2026-04-12T18:45:53.812412Z","steps":["trace[601553534] 'range keys from in-memory index tree' (duration: 125.215859ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:46:22.906467Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620625822538701486,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-12T18:46:23.097918Z","caller":"traceutil/trace.go:171","msg":"trace[966519306] transaction","detail":"{read_only:false; response_revision:8556; number_of_response:1; }","duration":"803.590128ms","start":"2026-04-12T18:46:22.29429Z","end":"2026-04-12T18:46:23.09788Z","steps":["trace[966519306] 'process raft request' (duration: 803.345631ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:46:23.098137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T18:46:22.294262Z","time spent":"803.759933ms","remote":"127.0.0.1:35822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-12T18:46:23.107012Z","caller":"traceutil/trace.go:171","msg":"trace[2129882521] linearizableReadLoop","detail":"{readStateIndex:8851; appliedIndex:8848; }","duration":"701.220969ms","start":"2026-04-12T18:46:22.405756Z","end":"2026-04-12T18:46:23.106977Z","steps":["trace[2129882521] 'read index received' (duration: 691.887478ms)","trace[2129882521] 'applied index is now lower than readState.Index' (duration: 9.332231ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T18:46:23.107164Z","caller":"traceutil/trace.go:171","msg":"trace[1317365087] transaction","detail":"{read_only:false; response_revision:8558; number_of_response:1; }","duration":"798.705762ms","start":"2026-04-12T18:46:22.308418Z","end":"2026-04-12T18:46:23.107124Z","steps":["trace[1317365087] 'process raft request' (duration: 798.459365ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:46:23.107048Z","caller":"traceutil/trace.go:171","msg":"trace[187175441] transaction","detail":"{read_only:false; response_revision:8557; number_of_response:1; }","duration":"809.863414ms","start":"2026-04-12T18:46:22.297159Z","end":"2026-04-12T18:46:23.107022Z","steps":["trace[187175441] 'process raft request' (duration: 809.515404ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:46:23.10735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T18:46:22.308402Z","time spent":"798.847485ms","remote":"127.0.0.1:35822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-12T18:46:23.107408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T18:46:22.29714Z","time spent":"810.191203ms","remote":"127.0.0.1:35822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-12T18:46:23.107586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.970218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-12T18:46:23.107618Z","caller":"traceutil/trace.go:171","msg":"trace[339315187] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:8559; }","duration":"617.05145ms","start":"2026-04-12T18:46:22.49056Z","end":"2026-04-12T18:46:23.107612Z","steps":["trace[339315187] 'agreement among raft nodes before linearized reading' (duration: 616.958848ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:46:23.107647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T18:46:22.490536Z","time spent":"617.106432ms","remote":"127.0.0.1:36060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":24,"response size":31,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"warn","ts":"2026-04-12T18:46:23.107641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"701.879358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-pdcs4\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-04-12T18:46:23.107676Z","caller":"traceutil/trace.go:171","msg":"trace[252222819] range","detail":"{range_begin:/registry/pods/openstack/keepalived-pdcs4; range_end:; response_count:1; response_revision:8559; }","duration":"701.95509ms","start":"2026-04-12T18:46:22.405711Z","end":"2026-04-12T18:46:23.107667Z","steps":["trace[252222819] 'agreement among raft nodes before linearized reading' (duration: 701.799225ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:46:23.107698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T18:46:22.405689Z","time spent":"702.004081ms","remote":"127.0.0.1:35762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6544,"request content":"key:\"/registry/pods/openstack/keepalived-pdcs4\" "} {"level":"warn","ts":"2026-04-12T18:46:23.107927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.472102ms","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-12T18:46:23.107955Z","caller":"traceutil/trace.go:171","msg":"trace[1649864692] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8559; }","duration":"218.605777ms","start":"2026-04-12T18:46:22.889342Z","end":"2026-04-12T18:46:23.107948Z","steps":["trace[1649864692] 'agreement among raft nodes before linearized reading' (duration: 218.454562ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:46:23.108173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.942562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-04-12T18:46:23.108249Z","caller":"traceutil/trace.go:171","msg":"trace[939220492] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8559; }","duration":"241.094096ms","start":"2026-04-12T18:46:22.867138Z","end":"2026-04-12T18:46:23.108232Z","steps":["trace[939220492] 'agreement among raft nodes before linearized reading' (duration: 240.847759ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:46:26.231715Z","caller":"traceutil/trace.go:171","msg":"trace[303473110] transaction","detail":"{read_only:false; response_revision:8578; number_of_response:1; }","duration":"103.623421ms","start":"2026-04-12T18:46:26.128063Z","end":"2026-04-12T18:46:26.231686Z","steps":["trace[303473110] 'process raft request' (duration: 103.447886ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:46:26.486812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.704155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-12T18:46:26.486876Z","caller":"traceutil/trace.go:171","msg":"trace[80213949] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:8578; }","duration":"117.801618ms","start":"2026-04-12T18:46:26.369056Z","end":"2026-04-12T18:46:26.486858Z","steps":["trace[80213949] 'count revisions from in-memory index tree' (duration: 117.638784ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:46:26.48698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.504298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-12T18:46:26.487113Z","caller":"traceutil/trace.go:171","msg":"trace[1464482733] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:8578; }","duration":"213.711014ms","start":"2026-04-12T18:46:26.273374Z","end":"2026-04-12T18:46:26.487085Z","steps":["trace[1464482733] 'count revisions from in-memory index tree' (duration: 213.381755ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:46:35.697467Z","caller":"traceutil/trace.go:171","msg":"trace[742033281] transaction","detail":"{read_only:false; response_revision:8665; number_of_response:1; }","duration":"104.045583ms","start":"2026-04-12T18:46:35.593385Z","end":"2026-04-12T18:46:35.697431Z","steps":["trace[742033281] 'process raft request' (duration: 103.885028ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:46:36.534164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.702913ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-12T18:46:36.534317Z","caller":"traceutil/trace.go:171","msg":"trace[1456147334] transaction","detail":"{read_only:false; response_revision:8671; number_of_response:1; }","duration":"269.750461ms","start":"2026-04-12T18:46:36.264545Z","end":"2026-04-12T18:46:36.534296Z","steps":["trace[1456147334] 'process raft request' (duration: 70.807432ms)","trace[1456147334] 'compare' (duration: 198.22686ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T18:46:36.821431Z","caller":"traceutil/trace.go:171","msg":"trace[821135082] transaction","detail":"{read_only:false; response_revision:8672; number_of_response:1; }","duration":"247.828638ms","start":"2026-04-12T18:46:36.573574Z","end":"2026-04-12T18:46:36.821403Z","steps":["trace[821135082] 'process raft request' (duration: 247.604392ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:46:36.909135Z","caller":"traceutil/trace.go:171","msg":"trace[1437428036] transaction","detail":"{read_only:false; response_revision:8673; number_of_response:1; }","duration":"327.959901ms","start":"2026-04-12T18:46:36.581054Z","end":"2026-04-12T18:46:36.909014Z","steps":["trace[1437428036] 'process raft request' (duration: 303.128076ms)","trace[1437428036] 'compare' (duration: 24.633939ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T18:46:36.909218Z","caller":"traceutil/trace.go:171","msg":"trace[1673060829] linearizableReadLoop","detail":"{readStateIndex:8972; appliedIndex:8970; }","duration":"250.258246ms","start":"2026-04-12T18:46:36.658939Z","end":"2026-04-12T18:46:36.909197Z","steps":["trace[1673060829] 'read index received' (duration: 162.395546ms)","trace[1673060829] 'applied index is now lower than readState.Index' (duration: 87.86115ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T18:46:36.909312Z","caller":"traceutil/trace.go:171","msg":"trace[436173144] transaction","detail":"{read_only:false; response_revision:8674; number_of_response:1; }","duration":"249.70917ms","start":"2026-04-12T18:46:36.659574Z","end":"2026-04-12T18:46:36.909283Z","steps":["trace[436173144] 'process raft request' (duration: 249.367681ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:46:36.909419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T18:46:36.581027Z","time spent":"328.214108ms","remote":"127.0.0.1:53504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5857,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-12T18:46:36.909702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.751349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-m8nrd\" ","response":"range_response_count:1 size:4646"} {"level":"info","ts":"2026-04-12T18:46:36.90975Z","caller":"traceutil/trace.go:171","msg":"trace[236592043] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-m8nrd; range_end:; response_count:1; response_revision:8674; }","duration":"250.854943ms","start":"2026-04-12T18:46:36.658882Z","end":"2026-04-12T18:46:36.909737Z","steps":["trace[236592043] 'agreement among raft nodes before linearized reading' (duration: 250.445441ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:46:38.03412Z","caller":"traceutil/trace.go:171","msg":"trace[1458608158] linearizableReadLoop","detail":"{readStateIndex:8983; appliedIndex:8982; }","duration":"130.851204ms","start":"2026-04-12T18:46:37.903227Z","end":"2026-04-12T18:46:38.034078Z","steps":["trace[1458608158] 'read index received' (duration: 130.165414ms)","trace[1458608158] 'applied index is now lower than readState.Index' (duration: 683.71µs)"],"step_count":2} {"level":"info","ts":"2026-04-12T18:46:38.034256Z","caller":"traceutil/trace.go:171","msg":"trace[2008933286] transaction","detail":"{read_only:false; response_revision:8684; number_of_response:1; }","duration":"290.585085ms","start":"2026-04-12T18:46:37.743628Z","end":"2026-04-12T18:46:38.034213Z","steps":["trace[2008933286] 'process raft request' (duration: 289.946157ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:46:38.034429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.183653ms","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-12T18:46:38.034511Z","caller":"traceutil/trace.go:171","msg":"trace[2064829979] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8684; }","duration":"131.340917ms","start":"2026-04-12T18:46:37.903148Z","end":"2026-04-12T18:46:38.034489Z","steps":["trace[2064829979] 'agreement among raft nodes before linearized reading' (duration: 131.066459ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:46:55.236717Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023e9.wal"} {"level":"info","ts":"2026-04-12T18:47:37.540504Z","caller":"traceutil/trace.go:171","msg":"trace[1795476601] transaction","detail":"{read_only:false; response_revision:9330; number_of_response:1; }","duration":"134.063275ms","start":"2026-04-12T18:47:37.406392Z","end":"2026-04-12T18:47:37.540456Z","steps":["trace[1795476601] 'process raft request' (duration: 64.78972ms)","trace[1795476601] 'compare' (duration: 68.895755ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T18:47:50.584012Z","caller":"traceutil/trace.go:171","msg":"trace[505200962] linearizableReadLoop","detail":"{readStateIndex:9724; appliedIndex:9723; }","duration":"159.137242ms","start":"2026-04-12T18:47:50.424853Z","end":"2026-04-12T18:47:50.58399Z","steps":["trace[505200962] 'read index received' (duration: 159.07289ms)","trace[505200962] 'applied index is now lower than readState.Index' (duration: 62.932µs)"],"step_count":2} {"level":"info","ts":"2026-04-12T18:47:50.584113Z","caller":"traceutil/trace.go:171","msg":"trace[1963093778] transaction","detail":"{read_only:false; response_revision:9405; number_of_response:1; }","duration":"160.79689ms","start":"2026-04-12T18:47:50.423293Z","end":"2026-04-12T18:47:50.58409Z","steps":["trace[1963093778] 'process raft request' (duration: 160.555552ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T18:47:50.584263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.38695ms","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-12T18:47:50.58434Z","caller":"traceutil/trace.go:171","msg":"trace[422834507] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9405; }","duration":"159.521964ms","start":"2026-04-12T18:47:50.424797Z","end":"2026-04-12T18:47:50.584318Z","steps":["trace[422834507] 'agreement among raft nodes before linearized reading' (duration: 159.313938ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:47:50.715456Z","caller":"traceutil/trace.go:171","msg":"trace[1801900783] linearizableReadLoop","detail":"{readStateIndex:9725; appliedIndex:9724; }","duration":"131.347269ms","start":"2026-04-12T18:47:50.584082Z","end":"2026-04-12T18:47:50.715429Z","steps":["trace[1801900783] 'read index received' (duration: 109.940525ms)","trace[1801900783] 'applied index is now lower than readState.Index' (duration: 21.405154ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T18:47:50.715565Z","caller":"traceutil/trace.go:171","msg":"trace[1614558207] transaction","detail":"{read_only:false; response_revision:9406; number_of_response:1; }","duration":"171.423874ms","start":"2026-04-12T18:47:50.544083Z","end":"2026-04-12T18:47:50.715507Z","steps":["trace[1614558207] 'process raft request' (duration: 149.941378ms)","trace[1614558207] 'compare' (duration: 21.162097ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T18:47:50.715799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.049638ms","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-12T18:47:50.715889Z","caller":"traceutil/trace.go:171","msg":"trace[1889348190] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:9407; }","duration":"142.196592ms","start":"2026-04-12T18:47:50.573672Z","end":"2026-04-12T18:47:50.715868Z","steps":["trace[1889348190] 'agreement among raft nodes before linearized reading' (duration: 141.869242ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:47:50.715848Z","caller":"traceutil/trace.go:171","msg":"trace[662386788] transaction","detail":"{read_only:false; response_revision:9407; number_of_response:1; }","duration":"126.757894ms","start":"2026-04-12T18:47:50.589024Z","end":"2026-04-12T18:47:50.715782Z","steps":["trace[662386788] 'process raft request' (duration: 126.360212ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T18:48:27.32949Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"cf8c3a138c9a77a2","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-12T18:48:27.337945Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-12T18:48:27.338049Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-12T18:50:53.158178Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8345} {"level":"info","ts":"2026-04-12T18:50:53.24063Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8345,"took":"80.320679ms","hash":3120392241,"current-db-size-bytes":57737216,"current-db-size":"58 MB","current-db-size-in-use-bytes":23973888,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-04-12T18:50:53.240704Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3120392241,"revision":8345,"compact-revision":6174} {"level":"info","ts":"2026-04-12T18:55:53.16611Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10564} {"level":"info","ts":"2026-04-12T18:55:53.247006Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10564,"took":"77.899561ms","hash":3338226456,"current-db-size-bytes":57737216,"current-db-size":"58 MB","current-db-size-in-use-bytes":20926464,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-12T18:55:53.247082Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3338226456,"revision":10564,"compact-revision":8345}