{"level":"warn","ts":"2026-09-02T12:19:55.840308Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-02T12:19:55.840417Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.165: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://162.253.55.165:2380","--initial-cluster=instance=https://162.253.55.165:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.165:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.165: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-09-02T12:19:55.840477Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-02T12:19:55.840491Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.165:2380"]} {"level":"info","ts":"2026-09-02T12:19:55.84051Z","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-09-02T12:19:55.841101Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.165:2379"]} {"level":"info","ts":"2026-09-02T12:19:55.84118Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.165:2380"],"listen-peer-urls":["https://162.253.55.165:2380"],"advertise-client-urls":["https://162.253.55.165:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.165:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.165: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-09-02T12:19:55.845569Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.177834ms"} {"level":"info","ts":"2026-09-02T12:19:55.855561Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e9d471e5f5fb9faf","cluster-id":"fb4c33c289aeb291"} {"level":"info","ts":"2026-09-02T12:19:55.855621Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9d471e5f5fb9faf switched to configuration voters=()"} {"level":"info","ts":"2026-09-02T12:19:55.855636Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9d471e5f5fb9faf became follower at term 0"} {"level":"info","ts":"2026-09-02T12:19:55.855646Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e9d471e5f5fb9faf [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-02T12:19:55.855652Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9d471e5f5fb9faf became follower at term 1"} {"level":"info","ts":"2026-09-02T12:19:55.855682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9d471e5f5fb9faf switched to configuration voters=(16849217338388225967)"} {"level":"warn","ts":"2026-09-02T12:19:55.866054Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-02T12:19:55.867568Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-02T12:19:55.868897Z","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-09-02T12:19:55.870837Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e9d471e5f5fb9faf","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-02T12:19:55.872492Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e9d471e5f5fb9faf","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-02T12:19:55.872431Z","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-09-02T12:19:55.872753Z","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-09-02T12:19:55.872768Z","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-09-02T12:19:55.874847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9d471e5f5fb9faf switched to configuration voters=(16849217338388225967)"} {"level":"info","ts":"2026-09-02T12:19:55.875024Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fb4c33c289aeb291","local-member-id":"e9d471e5f5fb9faf","added-peer-id":"e9d471e5f5fb9faf","added-peer-peer-urls":["https://162.253.55.165:2380"]} {"level":"info","ts":"2026-09-02T12:19:55.875668Z","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-09-02T12:19:55.875825Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e9d471e5f5fb9faf","initial-advertise-peer-urls":["https://162.253.55.165:2380"],"listen-peer-urls":["https://162.253.55.165:2380"],"advertise-client-urls":["https://162.253.55.165:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.165:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-02T12:19:55.875847Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-02T12:19:55.87591Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.165:2380"} {"level":"info","ts":"2026-09-02T12:19:55.87592Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.165:2380"} {"level":"info","ts":"2026-09-02T12:19:56.256601Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9d471e5f5fb9faf is starting a new election at term 1"} {"level":"info","ts":"2026-09-02T12:19:56.256696Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9d471e5f5fb9faf became pre-candidate at term 1"} {"level":"info","ts":"2026-09-02T12:19:56.256722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9d471e5f5fb9faf received MsgPreVoteResp from e9d471e5f5fb9faf at term 1"} {"level":"info","ts":"2026-09-02T12:19:56.256747Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9d471e5f5fb9faf became candidate at term 2"} {"level":"info","ts":"2026-09-02T12:19:56.256758Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9d471e5f5fb9faf received MsgVoteResp from e9d471e5f5fb9faf at term 2"} {"level":"info","ts":"2026-09-02T12:19:56.256774Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9d471e5f5fb9faf became leader at term 2"} {"level":"info","ts":"2026-09-02T12:19:56.256787Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e9d471e5f5fb9faf elected leader e9d471e5f5fb9faf at term 2"} {"level":"info","ts":"2026-09-02T12:19:56.264243Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-02T12:19:56.269698Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-02T12:19:56.269694Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e9d471e5f5fb9faf","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.165:2379]}","request-path":"/0/members/e9d471e5f5fb9faf/attributes","cluster-id":"fb4c33c289aeb291","publish-timeout":"7s"} {"level":"info","ts":"2026-09-02T12:19:56.269756Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-02T12:19:56.27008Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-02T12:19:56.270108Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-02T12:19:56.27234Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-02T12:19:56.272684Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fb4c33c289aeb291","local-member-id":"e9d471e5f5fb9faf","cluster-version":"3.5"} {"level":"info","ts":"2026-09-02T12:19:56.272783Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-02T12:19:56.272813Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-02T12:19:56.273327Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.165:2379"} {"level":"warn","ts":"2026-09-02T12:19:59.255424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.325586ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-09-02T12:19:59.255629Z","caller":"traceutil/trace.go:171","msg":"trace[1751660970] transaction","detail":"{read_only:false; response_revision:112; number_of_response:1; }","duration":"370.83005ms","start":"2026-09-02T12:19:58.884749Z","end":"2026-09-02T12:19:59.255579Z","steps":["trace[1751660970] 'process raft request' (duration: 129.657903ms)","trace[1751660970] 'compare' (duration: 240.122611ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T12:19:59.255698Z","caller":"traceutil/trace.go:171","msg":"trace[309785722] linearizableReadLoop","detail":"{readStateIndex:117; appliedIndex:116; }","duration":"369.789024ms","start":"2026-09-02T12:19:58.885756Z","end":"2026-09-02T12:19:59.255545Z","steps":["trace[309785722] 'read index received' (duration: 128.543006ms)","trace[309785722] 'applied index is now lower than readState.Index' (duration: 241.244788ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T12:19:59.255801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T12:19:58.884736Z","time spent":"370.989523ms","remote":"127.0.0.1:59864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-02T12:19:59.255922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.145452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-view\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-02T12:19:59.255991Z","caller":"traceutil/trace.go:171","msg":"trace[522077731] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-view; range_end:; response_count:0; response_revision:112; }","duration":"370.221304ms","start":"2026-09-02T12:19:58.885752Z","end":"2026-09-02T12:19:59.255974Z","steps":["trace[522077731] 'agreement among raft nodes before linearized reading' (duration: 370.06273ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T12:19:59.256039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T12:19:58.885728Z","time spent":"370.298607ms","remote":"127.0.0.1:59850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/system:aggregate-to-view\" "} {"level":"warn","ts":"2026-09-02T12:19:59.256019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.089487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-02T12:19:59.256106Z","caller":"traceutil/trace.go:171","msg":"trace[1725363280] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:112; }","duration":"301.23098ms","start":"2026-09-02T12:19:58.954854Z","end":"2026-09-02T12:19:59.256085Z","steps":["trace[1725363280] 'agreement among raft nodes before linearized reading' (duration: 301.079706ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T12:19:59.256158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T12:19:58.954832Z","time spent":"301.316823ms","remote":"127.0.0.1:59574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-02T12:20:21.870111Z","caller":"traceutil/trace.go:171","msg":"trace[2013118898] transaction","detail":"{read_only:false; response_revision:446; number_of_response:1; }","duration":"106.28514ms","start":"2026-09-02T12:20:21.763798Z","end":"2026-09-02T12:20:21.870083Z","steps":["trace[2013118898] 'process raft request' (duration: 61.876067ms)","trace[2013118898] 'compare' (duration: 44.28826ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T12:20:38.415829Z","caller":"traceutil/trace.go:171","msg":"trace[1951732179] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"106.932308ms","start":"2026-09-02T12:20:38.308853Z","end":"2026-09-02T12:20:38.415785Z","steps":["trace[1951732179] 'process raft request' (duration: 106.798426ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T12:20:38.778234Z","caller":"traceutil/trace.go:171","msg":"trace[1775518490] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"101.61529ms","start":"2026-09-02T12:20:38.6766Z","end":"2026-09-02T12:20:38.778215Z","steps":["trace[1775518490] 'process raft request' (duration: 101.530038ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T12:20:38.78809Z","caller":"traceutil/trace.go:171","msg":"trace[2146203790] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"106.702102ms","start":"2026-09-02T12:20:38.681349Z","end":"2026-09-02T12:20:38.788051Z","steps":["trace[2146203790] 'process raft request' (duration: 106.553409ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T12:20:44.977489Z","caller":"traceutil/trace.go:171","msg":"trace[264730792] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:666; }","duration":"152.495075ms","start":"2026-09-02T12:20:44.82497Z","end":"2026-09-02T12:20:44.977465Z","steps":["trace[264730792] 'read index received' (duration: 151.65844ms)","trace[264730792] 'applied index is now lower than readState.Index' (duration: 835.635µs)"],"step_count":2} {"level":"info","ts":"2026-09-02T12:20:44.977594Z","caller":"traceutil/trace.go:171","msg":"trace[1449319959] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"197.96186ms","start":"2026-09-02T12:20:44.779572Z","end":"2026-09-02T12:20:44.977534Z","steps":["trace[1449319959] 'process raft request' (duration: 197.272938ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T12:20:44.977881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.900711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-09-02T12:20:44.977959Z","caller":"traceutil/trace.go:171","msg":"trace[235352830] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:644; }","duration":"153.022744ms","start":"2026-09-02T12:20:44.824913Z","end":"2026-09-02T12:20:44.977936Z","steps":["trace[235352830] 'agreement among raft nodes before linearized reading' (duration: 152.696848ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T12:20:45.501613Z","caller":"traceutil/trace.go:171","msg":"trace[4582757] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"512.858162ms","start":"2026-09-02T12:20:44.988722Z","end":"2026-09-02T12:20:45.50158Z","steps":["trace[4582757] 'process raft request' (duration: 506.724105ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T12:20:45.502032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T12:20:44.988693Z","time spent":"513.001174ms","remote":"127.0.0.1:59792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-02T12:20:45.528122Z","caller":"traceutil/trace.go:171","msg":"trace[1084177139] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"480.481717ms","start":"2026-09-02T12:20:45.047623Z","end":"2026-09-02T12:20:45.528105Z","steps":["trace[1084177139] 'process raft request' (duration: 480.166522ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T12:20:45.52821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T12:20:45.047607Z","time spent":"480.562389ms","remote":"127.0.0.1:60066","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-02T12:21:01.841046Z","caller":"traceutil/trace.go:171","msg":"trace[586449676] linearizableReadLoop","detail":"{readStateIndex:838; appliedIndex:837; }","duration":"256.48697ms","start":"2026-09-02T12:21:01.584536Z","end":"2026-09-02T12:21:01.841023Z","steps":["trace[586449676] 'read index received' (duration: 256.215565ms)","trace[586449676] 'applied index is now lower than readState.Index' (duration: 270.435µs)"],"step_count":2} {"level":"warn","ts":"2026-09-02T12:21:01.841435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.121493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-02T12:21:01.841499Z","caller":"traceutil/trace.go:171","msg":"trace[195862736] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:809; }","duration":"128.221934ms","start":"2026-09-02T12:21:01.713256Z","end":"2026-09-02T12:21:01.841478Z","steps":["trace[195862736] 'agreement among raft nodes before linearized reading' (duration: 128.127533ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T12:21:01.841605Z","caller":"traceutil/trace.go:171","msg":"trace[523730361] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"370.00611ms","start":"2026-09-02T12:21:01.471564Z","end":"2026-09-02T12:21:01.84157Z","steps":["trace[523730361] 'process raft request' (duration: 369.274798ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T12:21:01.841646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.094619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-09-02T12:21:01.841781Z","caller":"traceutil/trace.go:171","msg":"trace[563835404] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:809; }","duration":"257.275502ms","start":"2026-09-02T12:21:01.584461Z","end":"2026-09-02T12:21:01.841736Z","steps":["trace[563835404] 'agreement among raft nodes before linearized reading' (duration: 256.832065ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T12:21:01.841794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T12:21:01.471548Z","time spent":"370.144902ms","remote":"127.0.0.1:59714","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4022,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-02T12:21:33.637807Z","caller":"traceutil/trace.go:171","msg":"trace[2103376191] linearizableReadLoop","detail":"{readStateIndex:1252; appliedIndex:1251; }","duration":"215.345648ms","start":"2026-09-02T12:21:33.422443Z","end":"2026-09-02T12:21:33.637789Z","steps":["trace[2103376191] 'read index received' (duration: 215.222756ms)","trace[2103376191] 'applied index is now lower than readState.Index' (duration: 122.132µs)"],"step_count":2} {"level":"warn","ts":"2026-09-02T12:21:33.6379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.450859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-02T12:21:33.637931Z","caller":"traceutil/trace.go:171","msg":"trace[133229516] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1215; }","duration":"215.519951ms","start":"2026-09-02T12:21:33.422394Z","end":"2026-09-02T12:21:33.637914Z","steps":["trace[133229516] 'agreement among raft nodes before linearized reading' (duration: 215.46477ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T12:21:33.637926Z","caller":"traceutil/trace.go:171","msg":"trace[1487506351] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"294.110449ms","start":"2026-09-02T12:21:33.343773Z","end":"2026-09-02T12:21:33.637883Z","steps":["trace[1487506351] 'process raft request' (duration: 293.908286ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T12:21:57.937214Z","caller":"traceutil/trace.go:171","msg":"trace[1834183975] transaction","detail":"{read_only:false; response_revision:1480; number_of_response:1; }","duration":"143.600239ms","start":"2026-09-02T12:21:57.79356Z","end":"2026-09-02T12:21:57.93716Z","steps":["trace[1834183975] 'process raft request' (duration: 143.455037ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T12:22:25.33982Z","caller":"traceutil/trace.go:171","msg":"trace[1388887416] transaction","detail":"{read_only:false; response_revision:1911; number_of_response:1; }","duration":"187.662645ms","start":"2026-09-02T12:22:25.152087Z","end":"2026-09-02T12:22:25.339749Z","steps":["trace[1388887416] 'process raft request' (duration: 147.203737ms)","trace[1388887416] 'compare' (duration: 40.085503ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T12:23:13.705338Z","caller":"traceutil/trace.go:171","msg":"trace[1189256053] transaction","detail":"{read_only:false; response_revision:2224; number_of_response:1; }","duration":"122.869142ms","start":"2026-09-02T12:23:13.582438Z","end":"2026-09-02T12:23:13.705307Z","steps":["trace[1189256053] 'process raft request' (duration: 122.639909ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T12:23:13.990953Z","caller":"traceutil/trace.go:171","msg":"trace[426844368] transaction","detail":"{read_only:false; response_revision:2227; number_of_response:1; }","duration":"184.588367ms","start":"2026-09-02T12:23:13.806323Z","end":"2026-09-02T12:23:13.990911Z","steps":["trace[426844368] 'process raft request' (duration: 171.235933ms)","trace[426844368] 'compare' (duration: 13.152402ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T12:23:14.40069Z","caller":"traceutil/trace.go:171","msg":"trace[1367488654] transaction","detail":"{read_only:false; response_revision:2228; number_of_response:1; }","duration":"169.602752ms","start":"2026-09-02T12:23:14.23105Z","end":"2026-09-02T12:23:14.400652Z","steps":["trace[1367488654] 'process raft request' (duration: 169.457181ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T12:23:14.619267Z","caller":"traceutil/trace.go:171","msg":"trace[1732149708] transaction","detail":"{read_only:false; response_revision:2229; number_of_response:1; }","duration":"203.380383ms","start":"2026-09-02T12:23:14.415852Z","end":"2026-09-02T12:23:14.619232Z","steps":["trace[1732149708] 'process raft request' (duration: 203.206261ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T12:23:14.906013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.847077ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-02T12:23:14.906209Z","caller":"traceutil/trace.go:171","msg":"trace[445926491] transaction","detail":"{read_only:false; response_revision:2230; number_of_response:1; }","duration":"268.778949ms","start":"2026-09-02T12:23:14.637344Z","end":"2026-09-02T12:23:14.906123Z","steps":["trace[445926491] 'process raft request' (duration: 78.68828ms)","trace[445926491] 'compare' (duration: 189.711555ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T12:24:34.523717Z","caller":"traceutil/trace.go:171","msg":"trace[854518838] transaction","detail":"{read_only:false; response_revision:2755; number_of_response:1; }","duration":"242.412877ms","start":"2026-09-02T12:24:34.281276Z","end":"2026-09-02T12:24:34.523688Z","steps":["trace[854518838] 'process raft request' (duration: 242.242841ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T12:24:34.524313Z","caller":"traceutil/trace.go:171","msg":"trace[2036881767] linearizableReadLoop","detail":"{readStateIndex:2860; appliedIndex:2858; }","duration":"122.929276ms","start":"2026-09-02T12:24:34.401361Z","end":"2026-09-02T12:24:34.52429Z","steps":["trace[2036881767] 'read index received' (duration: 122.14235ms)","trace[2036881767] 'applied index is now lower than readState.Index' (duration: 786.016µs)"],"step_count":2} {"level":"info","ts":"2026-09-02T12:24:34.524497Z","caller":"traceutil/trace.go:171","msg":"trace[1786817172] transaction","detail":"{read_only:false; response_revision:2756; number_of_response:1; }","duration":"215.922424ms","start":"2026-09-02T12:24:34.308547Z","end":"2026-09-02T12:24:34.52447Z","steps":["trace[1786817172] 'process raft request' (duration: 215.617984ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T12:24:34.524566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.181354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-02T12:24:34.524607Z","caller":"traceutil/trace.go:171","msg":"trace[13609580] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:2756; }","duration":"123.276457ms","start":"2026-09-02T12:24:34.401317Z","end":"2026-09-02T12:24:34.524594Z","steps":["trace[13609580] 'agreement among raft nodes before linearized reading' (duration: 123.189564ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T12:25:06.309705Z","caller":"traceutil/trace.go:171","msg":"trace[1693175054] linearizableReadLoop","detail":"{readStateIndex:3041; appliedIndex:3040; }","duration":"155.301395ms","start":"2026-09-02T12:25:06.154369Z","end":"2026-09-02T12:25:06.309671Z","steps":["trace[1693175054] 'read index received' (duration: 155.096119ms)","trace[1693175054] 'applied index is now lower than readState.Index' (duration: 204.066µs)"],"step_count":2} {"level":"warn","ts":"2026-09-02T12:25:06.309916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.523912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-09-02T12:25:06.309954Z","caller":"traceutil/trace.go:171","msg":"trace[1055569367] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2930; }","duration":"155.618864ms","start":"2026-09-02T12:25:06.154325Z","end":"2026-09-02T12:25:06.309944Z","steps":["trace[1055569367] 'agreement among raft nodes before linearized reading' (duration: 155.4616ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T12:25:06.310061Z","caller":"traceutil/trace.go:171","msg":"trace[1401497261] transaction","detail":"{read_only:false; response_revision:2930; number_of_response:1; }","duration":"168.77933ms","start":"2026-09-02T12:25:06.141181Z","end":"2026-09-02T12:25:06.30996Z","steps":["trace[1401497261] 'process raft request' (duration: 168.337007ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T12:25:06.460473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.46634ms","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-09-02T12:25:06.460549Z","caller":"traceutil/trace.go:171","msg":"trace[537473099] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2930; }","duration":"100.585094ms","start":"2026-09-02T12:25:06.359947Z","end":"2026-09-02T12:25:06.460532Z","steps":["trace[537473099] 'range keys from in-memory index tree' (duration: 100.268814ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T12:25:06.460544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.631129ms","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-09-02T12:25:06.46063Z","caller":"traceutil/trace.go:171","msg":"trace[1792746920] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2930; }","duration":"109.771073ms","start":"2026-09-02T12:25:06.350834Z","end":"2026-09-02T12:25:06.460605Z","steps":["trace[1792746920] 'range keys from in-memory index tree' (duration: 109.415623ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T12:25:11.9706Z","caller":"traceutil/trace.go:171","msg":"trace[225102007] transaction","detail":"{read_only:false; response_revision:2962; number_of_response:1; }","duration":"104.712338ms","start":"2026-09-02T12:25:11.865863Z","end":"2026-09-02T12:25:11.970575Z","steps":["trace[225102007] 'process raft request' (duration: 104.557623ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T12:25:12.078045Z","caller":"traceutil/trace.go:171","msg":"trace[1114126298] linearizableReadLoop","detail":"{readStateIndex:3075; appliedIndex:3074; }","duration":"107.4642ms","start":"2026-09-02T12:25:11.970557Z","end":"2026-09-02T12:25:12.078021Z","steps":["trace[1114126298] 'read index received' (duration: 105.800212ms)","trace[1114126298] 'applied index is now lower than readState.Index' (duration: 1.662868ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T12:25:12.078071Z","caller":"traceutil/trace.go:171","msg":"trace[1340681675] transaction","detail":"{read_only:false; response_revision:2963; number_of_response:1; }","duration":"115.51043ms","start":"2026-09-02T12:25:11.962535Z","end":"2026-09-02T12:25:12.078045Z","steps":["trace[1340681675] 'process raft request' (duration: 113.904735ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T12:25:12.078205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.397389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-02T12:25:12.078245Z","caller":"traceutil/trace.go:171","msg":"trace[2090038895] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2963; }","duration":"106.449401ms","start":"2026-09-02T12:25:11.971784Z","end":"2026-09-02T12:25:12.078233Z","steps":["trace[2090038895] 'agreement among raft nodes before linearized reading' (duration: 106.377179ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T12:25:12.078465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.600449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-02T12:25:12.07864Z","caller":"traceutil/trace.go:171","msg":"trace[1853547951] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:2963; }","duration":"118.807345ms","start":"2026-09-02T12:25:11.959819Z","end":"2026-09-02T12:25:12.078627Z","steps":["trace[1853547951] 'agreement among raft nodes before linearized reading' (duration: 118.27419ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T12:27:33.253141Z","caller":"traceutil/trace.go:171","msg":"trace[1696217740] transaction","detail":"{read_only:false; response_revision:3691; number_of_response:1; }","duration":"108.818737ms","start":"2026-09-02T12:27:33.144294Z","end":"2026-09-02T12:27:33.253112Z","steps":["trace[1696217740] 'process raft request' (duration: 58.570715ms)","trace[1696217740] 'compare' (duration: 49.824544ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T12:27:36.746508Z","caller":"traceutil/trace.go:171","msg":"trace[1346268506] transaction","detail":"{read_only:false; response_revision:3735; number_of_response:1; }","duration":"185.560148ms","start":"2026-09-02T12:27:36.560921Z","end":"2026-09-02T12:27:36.746481Z","steps":["trace[1346268506] 'process raft request' (duration: 185.421975ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T12:27:36.758398Z","caller":"traceutil/trace.go:171","msg":"trace[835589954] transaction","detail":"{read_only:false; response_revision:3736; number_of_response:1; }","duration":"101.433463ms","start":"2026-09-02T12:27:36.656945Z","end":"2026-09-02T12:27:36.758379Z","steps":["trace[835589954] 'process raft request' (duration: 101.027825ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T12:27:38.470122Z","caller":"traceutil/trace.go:171","msg":"trace[1748300429] transaction","detail":"{read_only:false; response_revision:3762; number_of_response:1; }","duration":"108.608754ms","start":"2026-09-02T12:27:38.361496Z","end":"2026-09-02T12:27:38.470105Z","steps":["trace[1748300429] 'process raft request' (duration: 70.058797ms)","trace[1748300429] 'compare' (duration: 38.362333ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T12:27:38.66305Z","caller":"traceutil/trace.go:171","msg":"trace[1697616275] transaction","detail":"{read_only:false; response_revision:3766; number_of_response:1; }","duration":"135.851012ms","start":"2026-09-02T12:27:38.527174Z","end":"2026-09-02T12:27:38.663025Z","steps":["trace[1697616275] 'process raft request' (duration: 68.841494ms)","trace[1697616275] 'compare' (duration: 66.932887ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T12:27:38.66365Z","caller":"traceutil/trace.go:171","msg":"trace[879275307] linearizableReadLoop","detail":"{readStateIndex:3912; appliedIndex:3910; }","duration":"100.230462ms","start":"2026-09-02T12:27:38.563401Z","end":"2026-09-02T12:27:38.663631Z","steps":["trace[879275307] 'read index received' (duration: 32.698533ms)","trace[879275307] 'applied index is now lower than readState.Index' (duration: 67.531179ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T12:27:38.663756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.339625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/passwords.secretgen.k14s.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-02T12:27:38.663788Z","caller":"traceutil/trace.go:171","msg":"trace[1567226786] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/passwords.secretgen.k14s.io; range_end:; response_count:0; response_revision:3768; }","duration":"100.407546ms","start":"2026-09-02T12:27:38.563371Z","end":"2026-09-02T12:27:38.663779Z","steps":["trace[1567226786] 'agreement among raft nodes before linearized reading' (duration: 100.331144ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T12:27:38.664054Z","caller":"traceutil/trace.go:171","msg":"trace[1522668006] transaction","detail":"{read_only:false; response_revision:3767; number_of_response:1; }","duration":"100.882925ms","start":"2026-09-02T12:27:38.563155Z","end":"2026-09-02T12:27:38.664038Z","steps":["trace[1522668006] 'process raft request' (duration: 100.326854ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T12:27:39.004025Z","caller":"traceutil/trace.go:171","msg":"trace[431266930] transaction","detail":"{read_only:false; response_revision:3778; number_of_response:1; }","duration":"108.659935ms","start":"2026-09-02T12:27:38.895331Z","end":"2026-09-02T12:27:39.003991Z","steps":["trace[431266930] 'process raft request' (duration: 64.930428ms)","trace[431266930] 'compare' (duration: 43.523093ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T12:27:39.010892Z","caller":"traceutil/trace.go:171","msg":"trace[1556941531] transaction","detail":"{read_only:false; response_revision:3779; number_of_response:1; }","duration":"112.473389ms","start":"2026-09-02T12:27:38.898399Z","end":"2026-09-02T12:27:39.010872Z","steps":["trace[1556941531] 'process raft request' (duration: 112.265285ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T12:29:40.235181Z","caller":"traceutil/trace.go:171","msg":"trace[1100702520] transaction","detail":"{read_only:false; response_revision:4981; number_of_response:1; }","duration":"115.006803ms","start":"2026-09-02T12:29:40.120156Z","end":"2026-09-02T12:29:40.235163Z","steps":["trace[1100702520] 'process raft request' (duration: 110.66935ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T12:29:43.168658Z","caller":"traceutil/trace.go:171","msg":"trace[489792939] transaction","detail":"{read_only:false; response_revision:5060; number_of_response:1; }","duration":"114.302577ms","start":"2026-09-02T12:29:43.054323Z","end":"2026-09-02T12:29:43.168626Z","steps":["trace[489792939] 'process raft request' (duration: 114.093603ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T12:29:43.301738Z","caller":"traceutil/trace.go:171","msg":"trace[117061145] transaction","detail":"{read_only:false; response_revision:5061; number_of_response:1; }","duration":"124.782162ms","start":"2026-09-02T12:29:43.176934Z","end":"2026-09-02T12:29:43.301716Z","steps":["trace[117061145] 'process raft request' (duration: 85.364754ms)","trace[117061145] 'compare' (duration: 39.300006ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T12:29:48.470494Z","caller":"traceutil/trace.go:171","msg":"trace[1432366686] transaction","detail":"{read_only:false; response_revision:5191; number_of_response:1; }","duration":"325.386037ms","start":"2026-09-02T12:29:48.145084Z","end":"2026-09-02T12:29:48.47047Z","steps":["trace[1432366686] 'process raft request' (duration: 325.227774ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T12:29:48.470661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T12:29:48.14506Z","time spent":"325.51254ms","remote":"127.0.0.1:59792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-02T12:29:48.574961Z","caller":"traceutil/trace.go:171","msg":"trace[1721984888] linearizableReadLoop","detail":"{readStateIndex:5388; appliedIndex:5385; }","duration":"229.839209ms","start":"2026-09-02T12:29:48.345096Z","end":"2026-09-02T12:29:48.574935Z","steps":["trace[1721984888] 'read index received' (duration: 125.19647ms)","trace[1721984888] 'applied index is now lower than readState.Index' (duration: 104.641559ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T12:29:48.575027Z","caller":"traceutil/trace.go:171","msg":"trace[1689533752] transaction","detail":"{read_only:false; response_revision:5193; number_of_response:1; }","duration":"428.916728ms","start":"2026-09-02T12:29:48.146087Z","end":"2026-09-02T12:29:48.575004Z","steps":["trace[1689533752] 'process raft request' (duration: 428.770326ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T12:29:48.57501Z","caller":"traceutil/trace.go:171","msg":"trace[586587485] transaction","detail":"{read_only:false; response_revision:5192; number_of_response:1; }","duration":"429.804203ms","start":"2026-09-02T12:29:48.145142Z","end":"2026-09-02T12:29:48.574946Z","steps":["trace[586587485] 'process raft request' (duration: 389.985792ms)","trace[586587485] 'compare' (duration: 39.587447ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T12:29:48.575161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T12:29:48.146074Z","time spent":"429.004929ms","remote":"127.0.0.1:59796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1408,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-02T12:29:48.575238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T12:29:48.145116Z","time spent":"430.007566ms","remote":"127.0.0.1:59708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-02T12:29:48.575243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.130855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a8acd1f1-2c91-401c-a2e1-aa07bbbb59f8\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-09-02T12:29:48.575392Z","caller":"traceutil/trace.go:171","msg":"trace[1012062040] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a8acd1f1-2c91-401c-a2e1-aa07bbbb59f8; range_end:; response_count:1; response_revision:5193; }","duration":"230.319427ms","start":"2026-09-02T12:29:48.345053Z","end":"2026-09-02T12:29:48.575372Z","steps":["trace[1012062040] 'agreement among raft nodes before linearized reading' (duration: 229.990282ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T12:29:48.863833Z","caller":"traceutil/trace.go:171","msg":"trace[1357875382] transaction","detail":"{read_only:false; response_revision:5194; number_of_response:1; }","duration":"112.158244ms","start":"2026-09-02T12:29:48.751645Z","end":"2026-09-02T12:29:48.863803Z","steps":["trace[1357875382] 'process raft request' (duration: 112.005141ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T12:29:56.524108Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2881} {"level":"info","ts":"2026-09-02T12:29:56.60399Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2881,"took":"78.67767ms","hash":774078289,"current-db-size-bytes":52248576,"current-db-size":"52 MB","current-db-size-in-use-bytes":27484160,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-02T12:29:56.604063Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":774078289,"revision":2881,"compact-revision":-1} {"level":"info","ts":"2026-09-02T12:30:03.12078Z","caller":"traceutil/trace.go:171","msg":"trace[9352460] transaction","detail":"{read_only:false; response_revision:5389; number_of_response:1; }","duration":"180.390348ms","start":"2026-09-02T12:30:02.940367Z","end":"2026-09-02T12:30:03.120757Z","steps":["trace[9352460] 'process raft request' (duration: 180.145174ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T12:30:03.340195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.523989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16549"} {"level":"info","ts":"2026-09-02T12:30:03.340273Z","caller":"traceutil/trace.go:171","msg":"trace[1042410779] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5389; }","duration":"121.64829ms","start":"2026-09-02T12:30:03.218607Z","end":"2026-09-02T12:30:03.340255Z","steps":["trace[1042410779] 'range keys from in-memory index tree' (duration: 121.312985ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T12:30:03.79935Z","caller":"traceutil/trace.go:171","msg":"trace[1484616921] transaction","detail":"{read_only:false; response_revision:5394; number_of_response:1; }","duration":"169.858403ms","start":"2026-09-02T12:30:03.629456Z","end":"2026-09-02T12:30:03.799314Z","steps":["trace[1484616921] 'process raft request' (duration: 169.480097ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T12:30:03.926174Z","caller":"traceutil/trace.go:171","msg":"trace[131998131] transaction","detail":"{read_only:false; response_revision:5396; number_of_response:1; }","duration":"118.929886ms","start":"2026-09-02T12:30:03.807212Z","end":"2026-09-02T12:30:03.926141Z","steps":["trace[131998131] 'process raft request' (duration: 101.903356ms)","trace[131998131] 'compare' (duration: 16.770466ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T12:30:03.926538Z","caller":"traceutil/trace.go:171","msg":"trace[96374525] transaction","detail":"{read_only:false; response_revision:5397; number_of_response:1; }","duration":"119.16017ms","start":"2026-09-02T12:30:03.807341Z","end":"2026-09-02T12:30:03.926501Z","steps":["trace[96374525] 'process raft request' (duration: 118.701352ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T12:30:03.926626Z","caller":"traceutil/trace.go:171","msg":"trace[1536028108] transaction","detail":"{read_only:false; response_revision:5398; number_of_response:1; }","duration":"112.004612ms","start":"2026-09-02T12:30:03.8146Z","end":"2026-09-02T12:30:03.926605Z","steps":["trace[1536028108] 'process raft request' (duration: 111.705167ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T12:34:56.532738Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5330} {"level":"info","ts":"2026-09-02T12:34:56.623273Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5330,"took":"89.058186ms","hash":2216131290,"current-db-size-bytes":52248576,"current-db-size":"52 MB","current-db-size-in-use-bytes":19197952,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-02T12:34:56.623341Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2216131290,"revision":5330,"compact-revision":2881} {"level":"info","ts":"2026-09-02T12:39:56.538913Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7437} {"level":"info","ts":"2026-09-02T12:39:56.603628Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7437,"took":"63.074177ms","hash":244130232,"current-db-size-bytes":52248576,"current-db-size":"52 MB","current-db-size-in-use-bytes":15761408,"current-db-size-in-use":"16 MB"} {"level":"info","ts":"2026-09-02T12:39:56.603691Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":244130232,"revision":7437,"compact-revision":5330} {"level":"info","ts":"2026-09-02T12:42:12.733772Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e9d471e5f5fb9faf","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-02T12:42:12.74122Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-09-02T12:42:12.741336Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}