{"level":"warn","ts":"2026-09-25T22:02:24.25167Z","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-25T22:02:24.251756Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.176: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.176:2380","--initial-cluster=instance=https://162.253.55.176:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.176:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.176: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-25T22:02:24.251819Z","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-25T22:02:24.251843Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.176:2380"]} {"level":"info","ts":"2026-09-25T22:02:24.251859Z","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-25T22:02:24.252668Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.176:2379"]} {"level":"info","ts":"2026-09-25T22:02:24.252739Z","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.176:2380"],"listen-peer-urls":["https://162.253.55.176:2380"],"advertise-client-urls":["https://162.253.55.176:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.176:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.176: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-25T22:02:24.257899Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.789994ms"} {"level":"info","ts":"2026-09-25T22:02:24.267696Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"590b810b00f00655","cluster-id":"dcc6923d0deac545"} {"level":"info","ts":"2026-09-25T22:02:24.267757Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 switched to configuration voters=()"} {"level":"info","ts":"2026-09-25T22:02:24.267776Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became follower at term 0"} {"level":"info","ts":"2026-09-25T22:02:24.267789Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 590b810b00f00655 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-25T22:02:24.267902Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became follower at term 1"} {"level":"info","ts":"2026-09-25T22:02:24.267985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 switched to configuration voters=(6416363978379757141)"} {"level":"warn","ts":"2026-09-25T22:02:24.275598Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-25T22:02:24.277426Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-25T22:02:24.278849Z","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-25T22:02:24.280904Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"590b810b00f00655","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-25T22:02:24.280959Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"590b810b00f00655","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-25T22:02:24.281229Z","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-25T22:02:24.281325Z","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-25T22:02:24.281335Z","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-25T22:02:24.283001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 switched to configuration voters=(6416363978379757141)"} {"level":"info","ts":"2026-09-25T22:02:24.283123Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dcc6923d0deac545","local-member-id":"590b810b00f00655","added-peer-id":"590b810b00f00655","added-peer-peer-urls":["https://162.253.55.176:2380"]} {"level":"info","ts":"2026-09-25T22:02:24.286586Z","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-25T22:02:24.286705Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.176:2380"} {"level":"info","ts":"2026-09-25T22:02:24.286746Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.176:2380"} {"level":"info","ts":"2026-09-25T22:02:24.286939Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"590b810b00f00655","initial-advertise-peer-urls":["https://162.253.55.176:2380"],"listen-peer-urls":["https://162.253.55.176:2380"],"advertise-client-urls":["https://162.253.55.176:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.176:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-25T22:02:24.286995Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-25T22:02:24.969209Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 is starting a new election at term 1"} {"level":"info","ts":"2026-09-25T22:02:24.969363Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-25T22:02:24.969673Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 received MsgPreVoteResp from 590b810b00f00655 at term 1"} {"level":"info","ts":"2026-09-25T22:02:24.969717Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became candidate at term 2"} {"level":"info","ts":"2026-09-25T22:02:24.969735Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 received MsgVoteResp from 590b810b00f00655 at term 2"} {"level":"info","ts":"2026-09-25T22:02:24.969759Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became leader at term 2"} {"level":"info","ts":"2026-09-25T22:02:24.969795Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 590b810b00f00655 elected leader 590b810b00f00655 at term 2"} {"level":"info","ts":"2026-09-25T22:02:24.975893Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-25T22:02:24.988131Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-25T22:02:24.988175Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-25T22:02:24.988087Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"590b810b00f00655","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.176:2379]}","request-path":"/0/members/590b810b00f00655/attributes","cluster-id":"dcc6923d0deac545","publish-timeout":"7s"} {"level":"info","ts":"2026-09-25T22:02:24.9886Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-25T22:02:24.988658Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-25T22:02:24.989625Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dcc6923d0deac545","local-member-id":"590b810b00f00655","cluster-version":"3.5"} {"level":"info","ts":"2026-09-25T22:02:24.989767Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-25T22:02:24.989803Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-25T22:02:24.99135Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.176:2379"} {"level":"info","ts":"2026-09-25T22:02:24.999689Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-25T22:02:38.43387Z","caller":"traceutil/trace.go:171","msg":"trace[479136752] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"277.067591ms","start":"2026-09-25T22:02:38.156781Z","end":"2026-09-25T22:02:38.433848Z","steps":["trace[479136752] 'process raft request' (duration: 276.91384ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T22:02:38.834658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.537466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.176\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-09-25T22:02:38.834721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.002488ms","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-25T22:02:38.83481Z","caller":"traceutil/trace.go:171","msg":"trace[25294427] range","detail":"{range_begin:/registry/masterleases/162.253.55.176; range_end:; response_count:1; response_revision:364; }","duration":"379.800519ms","start":"2026-09-25T22:02:38.45498Z","end":"2026-09-25T22:02:38.834781Z","steps":["trace[25294427] 'range keys from in-memory index tree' (duration: 379.371724ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:02:38.834852Z","caller":"traceutil/trace.go:171","msg":"trace[1700276809] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:364; }","duration":"129.23256ms","start":"2026-09-25T22:02:38.705583Z","end":"2026-09-25T22:02:38.834816Z","steps":["trace[1700276809] 'range keys from in-memory index tree' (duration: 128.883147ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T22:02:38.83486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T22:02:38.454946Z","time spent":"379.90264ms","remote":"127.0.0.1:59712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/162.253.55.176\" "} {"level":"info","ts":"2026-09-25T22:03:01.914738Z","caller":"traceutil/trace.go:171","msg":"trace[1108590572] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"197.674683ms","start":"2026-09-25T22:03:01.717023Z","end":"2026-09-25T22:03:01.914698Z","steps":["trace[1108590572] 'process raft request' (duration: 197.454605ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:03:01.922542Z","caller":"traceutil/trace.go:171","msg":"trace[327968725] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"189.80733ms","start":"2026-09-25T22:03:01.732694Z","end":"2026-09-25T22:03:01.922501Z","steps":["trace[327968725] 'process raft request' (duration: 188.748532ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:03:01.92285Z","caller":"traceutil/trace.go:171","msg":"trace[489139878] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"188.72014ms","start":"2026-09-25T22:03:01.734115Z","end":"2026-09-25T22:03:01.922835Z","steps":["trace[489139878] 'process raft request' (duration: 187.410713ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:03:01.922894Z","caller":"traceutil/trace.go:171","msg":"trace[57185860] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"134.696251ms","start":"2026-09-25T22:03:01.788193Z","end":"2026-09-25T22:03:01.922889Z","steps":["trace[57185860] 'process raft request' (duration: 133.791118ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:03:01.922783Z","caller":"traceutil/trace.go:171","msg":"trace[286810892] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"187.827168ms","start":"2026-09-25T22:03:01.734926Z","end":"2026-09-25T22:03:01.922753Z","steps":["trace[286810892] 'process raft request' (duration: 186.633715ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:03:01.922743Z","caller":"traceutil/trace.go:171","msg":"trace[2059091711] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"203.702321ms","start":"2026-09-25T22:03:01.719Z","end":"2026-09-25T22:03:01.922702Z","steps":["trace[2059091711] 'process raft request' (duration: 202.251199ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:03:01.922811Z","caller":"traceutil/trace.go:171","msg":"trace[477324997] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"190.006177ms","start":"2026-09-25T22:03:01.7328Z","end":"2026-09-25T22:03:01.922806Z","steps":["trace[477324997] 'process raft request' (duration: 188.68899ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:03:01.923122Z","caller":"traceutil/trace.go:171","msg":"trace[1298840956] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"175.157692ms","start":"2026-09-25T22:03:01.747941Z","end":"2026-09-25T22:03:01.923099Z","steps":["trace[1298840956] 'process raft request' (duration: 173.656908ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:03:01.922996Z","caller":"traceutil/trace.go:171","msg":"trace[1349961342] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"190.317808ms","start":"2026-09-25T22:03:01.73263Z","end":"2026-09-25T22:03:01.922948Z","steps":["trace[1349961342] 'process raft request' (duration: 188.772162ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:03:01.923526Z","caller":"traceutil/trace.go:171","msg":"trace[1385053189] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"203.625528ms","start":"2026-09-25T22:03:01.719874Z","end":"2026-09-25T22:03:01.9235Z","steps":["trace[1385053189] 'process raft request' (duration: 201.489581ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:03:01.92382Z","caller":"traceutil/trace.go:171","msg":"trace[1156625423] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"143.088654ms","start":"2026-09-25T22:03:01.780665Z","end":"2026-09-25T22:03:01.923754Z","steps":["trace[1156625423] 'process raft request' (duration: 140.980888ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:03:08.411355Z","caller":"traceutil/trace.go:171","msg":"trace[1311949136] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"162.954479ms","start":"2026-09-25T22:03:08.248379Z","end":"2026-09-25T22:03:08.411333Z","steps":["trace[1311949136] 'process raft request' (duration: 162.819785ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T22:03:08.635709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.041934ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-25T22:03:08.635807Z","caller":"traceutil/trace.go:171","msg":"trace[169992020] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:617; }","duration":"180.000002ms","start":"2026-09-25T22:03:08.455791Z","end":"2026-09-25T22:03:08.635791Z","steps":["trace[169992020] 'read index received' (duration: 78.985896ms)","trace[169992020] 'applied index is now lower than readState.Index' (duration: 101.012906ms)"],"step_count":2} {"level":"info","ts":"2026-09-25T22:03:08.636073Z","caller":"traceutil/trace.go:171","msg":"trace[937501207] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"233.342416ms","start":"2026-09-25T22:03:08.402694Z","end":"2026-09-25T22:03:08.636037Z","steps":["trace[937501207] 'process raft request' (duration: 132.324859ms)","trace[937501207] 'compare' (duration: 99.504626ms)"],"step_count":2} {"level":"warn","ts":"2026-09-25T22:03:08.635999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.20421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.176\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-09-25T22:03:08.636545Z","caller":"traceutil/trace.go:171","msg":"trace[298580874] range","detail":"{range_begin:/registry/masterleases/162.253.55.176; range_end:; response_count:1; response_revision:597; }","duration":"180.793609ms","start":"2026-09-25T22:03:08.455738Z","end":"2026-09-25T22:03:08.636532Z","steps":["trace[298580874] 'agreement among raft nodes before linearized reading' (duration: 180.093996ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:03:09.387491Z","caller":"traceutil/trace.go:171","msg":"trace[1765729959] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:619; }","duration":"327.545795ms","start":"2026-09-25T22:03:09.05992Z","end":"2026-09-25T22:03:09.387466Z","steps":["trace[1765729959] 'read index received' (duration: 273.845397ms)","trace[1765729959] 'applied index is now lower than readState.Index' (duration: 53.699398ms)"],"step_count":2} {"level":"info","ts":"2026-09-25T22:03:09.387507Z","caller":"traceutil/trace.go:171","msg":"trace[1712871852] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"680.431231ms","start":"2026-09-25T22:03:08.707041Z","end":"2026-09-25T22:03:09.387472Z","steps":["trace[1712871852] 'process raft request' (duration: 626.819596ms)","trace[1712871852] 'compare' (duration: 53.398998ms)"],"step_count":2} {"level":"info","ts":"2026-09-25T22:03:09.387606Z","caller":"traceutil/trace.go:171","msg":"trace[1772744196] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"675.512656ms","start":"2026-09-25T22:03:08.712083Z","end":"2026-09-25T22:03:09.387596Z","steps":["trace[1772744196] 'process raft request' (duration: 675.33098ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T22:03:09.387631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T22:03:08.707014Z","time spent":"680.558096ms","remote":"127.0.0.1:59946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-25T22:03:09.387704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T22:03:08.712069Z","time spent":"675.561748ms","remote":"127.0.0.1:59712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-25T22:03:09.38804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.699264ms","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-09-25T22:03:09.388088Z","caller":"traceutil/trace.go:171","msg":"trace[462460269] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:599; }","duration":"313.803947ms","start":"2026-09-25T22:03:09.074272Z","end":"2026-09-25T22:03:09.388076Z","steps":["trace[462460269] 'agreement among raft nodes before linearized reading' (duration: 313.499197ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T22:03:09.388116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T22:03:09.074253Z","time spent":"313.856439ms","remote":"127.0.0.1:59974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-25T22:03:09.388158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.808307ms","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-09-25T22:03:09.388204Z","caller":"traceutil/trace.go:171","msg":"trace[771750486] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:599; }","duration":"182.873828ms","start":"2026-09-25T22:03:09.205319Z","end":"2026-09-25T22:03:09.388193Z","steps":["trace[771750486] 'agreement among raft nodes before linearized reading' (duration: 182.716543ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T22:03:09.388356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.443884ms","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-09-25T22:03:09.388384Z","caller":"traceutil/trace.go:171","msg":"trace[627513075] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:599; }","duration":"328.515567ms","start":"2026-09-25T22:03:09.059861Z","end":"2026-09-25T22:03:09.388377Z","steps":["trace[627513075] 'agreement among raft nodes before linearized reading' (duration: 328.437425ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T22:03:09.388406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T22:03:09.059824Z","time spent":"328.576569ms","remote":"127.0.0.1:59974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-25T22:03:09.388487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.653312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-25T22:03:09.388549Z","caller":"traceutil/trace.go:171","msg":"trace[1320059029] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:599; }","duration":"240.731635ms","start":"2026-09-25T22:03:09.147806Z","end":"2026-09-25T22:03:09.388537Z","steps":["trace[1320059029] 'agreement among raft nodes before linearized reading' (duration: 240.58215ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T22:03:09.388633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.935347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-25T22:03:09.388668Z","caller":"traceutil/trace.go:171","msg":"trace[1793006135] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:599; }","duration":"282.004749ms","start":"2026-09-25T22:03:09.106655Z","end":"2026-09-25T22:03:09.38866Z","steps":["trace[1793006135] 'agreement among raft nodes before linearized reading' (duration: 281.952817ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:03:27.190684Z","caller":"traceutil/trace.go:171","msg":"trace[396290887] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"246.644819ms","start":"2026-09-25T22:03:26.944008Z","end":"2026-09-25T22:03:27.190653Z","steps":["trace[396290887] 'process raft request' (duration: 246.434533ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:03:57.987576Z","caller":"traceutil/trace.go:171","msg":"trace[532742310] transaction","detail":"{read_only:false; response_revision:1167; number_of_response:1; }","duration":"195.197194ms","start":"2026-09-25T22:03:57.792357Z","end":"2026-09-25T22:03:57.987554Z","steps":["trace[532742310] 'process raft request' (duration: 195.112282ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:03:57.987776Z","caller":"traceutil/trace.go:171","msg":"trace[1155392781] transaction","detail":"{read_only:false; response_revision:1168; number_of_response:1; }","duration":"195.04337ms","start":"2026-09-25T22:03:57.792668Z","end":"2026-09-25T22:03:57.987711Z","steps":["trace[1155392781] 'process raft request' (duration: 194.857696ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:03:57.987826Z","caller":"traceutil/trace.go:171","msg":"trace[1108752325] transaction","detail":"{read_only:false; response_revision:1166; number_of_response:1; }","duration":"196.125294ms","start":"2026-09-25T22:03:57.791688Z","end":"2026-09-25T22:03:57.987813Z","steps":["trace[1108752325] 'process raft request' (duration: 193.476186ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:04:19.048374Z","caller":"traceutil/trace.go:171","msg":"trace[923463714] transaction","detail":"{read_only:false; response_revision:1348; number_of_response:1; }","duration":"126.252357ms","start":"2026-09-25T22:04:18.9221Z","end":"2026-09-25T22:04:19.048353Z","steps":["trace[923463714] 'process raft request' (duration: 124.634345ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:04:19.04926Z","caller":"traceutil/trace.go:171","msg":"trace[39073803] transaction","detail":"{read_only:false; response_revision:1349; number_of_response:1; }","duration":"101.236189ms","start":"2026-09-25T22:04:18.947996Z","end":"2026-09-25T22:04:19.049233Z","steps":["trace[39073803] 'process raft request' (duration: 101.081856ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:04:19.049249Z","caller":"traceutil/trace.go:171","msg":"trace[499280191] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"101.178787ms","start":"2026-09-25T22:04:18.948038Z","end":"2026-09-25T22:04:19.049216Z","steps":["trace[499280191] 'process raft request' (duration: 101.136947ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:04:19.24965Z","caller":"traceutil/trace.go:171","msg":"trace[684863684] transaction","detail":"{read_only:false; response_revision:1353; number_of_response:1; }","duration":"172.799651ms","start":"2026-09-25T22:04:19.076824Z","end":"2026-09-25T22:04:19.249623Z","steps":["trace[684863684] 'process raft request' (duration: 122.71726ms)","trace[684863684] 'compare' (duration: 49.800465ms)"],"step_count":2} {"level":"info","ts":"2026-09-25T22:04:19.249805Z","caller":"traceutil/trace.go:171","msg":"trace[856624990] transaction","detail":"{read_only:false; response_revision:1354; number_of_response:1; }","duration":"171.928544ms","start":"2026-09-25T22:04:19.077851Z","end":"2026-09-25T22:04:19.24978Z","steps":["trace[856624990] 'process raft request' (duration: 171.615778ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:04:19.250082Z","caller":"traceutil/trace.go:171","msg":"trace[740824495] linearizableReadLoop","detail":"{readStateIndex:1398; appliedIndex:1396; }","duration":"142.87153ms","start":"2026-09-25T22:04:19.107192Z","end":"2026-09-25T22:04:19.250064Z","steps":["trace[740824495] 'read index received' (duration: 92.358631ms)","trace[740824495] 'applied index is now lower than readState.Index' (duration: 50.511239ms)"],"step_count":2} {"level":"info","ts":"2026-09-25T22:04:19.25006Z","caller":"traceutil/trace.go:171","msg":"trace[1194115618] transaction","detail":"{read_only:false; response_revision:1355; number_of_response:1; }","duration":"142.216638ms","start":"2026-09-25T22:04:19.107782Z","end":"2026-09-25T22:04:19.249999Z","steps":["trace[1194115618] 'process raft request' (duration: 141.735609ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T22:04:19.250269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.255089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-25T22:04:19.250309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.112686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:103657"} {"level":"info","ts":"2026-09-25T22:04:19.250342Z","caller":"traceutil/trace.go:171","msg":"trace[1903340775] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:1356; }","duration":"143.195718ms","start":"2026-09-25T22:04:19.107137Z","end":"2026-09-25T22:04:19.250332Z","steps":["trace[1903340775] 'agreement among raft nodes before linearized reading' (duration: 143.017044ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:04:19.250355Z","caller":"traceutil/trace.go:171","msg":"trace[1298460045] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1356; }","duration":"142.396661ms","start":"2026-09-25T22:04:19.107917Z","end":"2026-09-25T22:04:19.250314Z","steps":["trace[1298460045] 'agreement among raft nodes before linearized reading' (duration: 142.266519ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:04:23.785573Z","caller":"traceutil/trace.go:171","msg":"trace[298477419] transaction","detail":"{read_only:false; response_revision:1439; number_of_response:1; }","duration":"148.400005ms","start":"2026-09-25T22:04:23.637138Z","end":"2026-09-25T22:04:23.785538Z","steps":["trace[298477419] 'process raft request' (duration: 148.15003ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T22:04:49.89764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.765683ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-25T22:04:49.897782Z","caller":"traceutil/trace.go:171","msg":"trace[277582264] linearizableReadLoop","detail":"{readStateIndex:1934; appliedIndex:1933; }","duration":"232.537825ms","start":"2026-09-25T22:04:49.665226Z","end":"2026-09-25T22:04:49.897764Z","steps":["trace[277582264] 'read index received' (duration: 116.567758ms)","trace[277582264] 'applied index is now lower than readState.Index' (duration: 115.932746ms)"],"step_count":2} {"level":"warn","ts":"2026-09-25T22:04:49.898114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.87248ms","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-09-25T22:04:49.898158Z","caller":"traceutil/trace.go:171","msg":"trace[2062546747] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"249.920436ms","start":"2026-09-25T22:04:49.648209Z","end":"2026-09-25T22:04:49.89813Z","steps":["trace[2062546747] 'process raft request' (duration: 133.580403ms)","trace[2062546747] 'compare' (duration: 115.607821ms)"],"step_count":2} {"level":"info","ts":"2026-09-25T22:04:49.898217Z","caller":"traceutil/trace.go:171","msg":"trace[1322987587] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1861; }","duration":"233.019432ms","start":"2026-09-25T22:04:49.665178Z","end":"2026-09-25T22:04:49.898197Z","steps":["trace[1322987587] 'agreement among raft nodes before linearized reading' (duration: 232.797008ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:04:50.150939Z","caller":"traceutil/trace.go:171","msg":"trace[1013883978] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"425.191829ms","start":"2026-09-25T22:04:49.725726Z","end":"2026-09-25T22:04:50.150918Z","steps":["trace[1013883978] 'process raft request' (duration: 413.788908ms)","trace[1013883978] 'compare' (duration: 11.275529ms)"],"step_count":2} {"level":"info","ts":"2026-09-25T22:04:50.150936Z","caller":"traceutil/trace.go:171","msg":"trace[367572811] linearizableReadLoop","detail":"{readStateIndex:1935; appliedIndex:1934; }","duration":"253.09806ms","start":"2026-09-25T22:04:49.897807Z","end":"2026-09-25T22:04:50.150905Z","steps":["trace[367572811] 'read index received' (duration: 241.701639ms)","trace[367572811] 'applied index is now lower than readState.Index' (duration: 11.395031ms)"],"step_count":2} {"level":"warn","ts":"2026-09-25T22:04:50.151083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T22:04:49.725705Z","time spent":"425.30728ms","remote":"127.0.0.1:59974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-25T22:04:50.151112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.067842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ddc5e481-1a89-4203-9ec7-3ea4be193beb\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-25T22:04:50.151164Z","caller":"traceutil/trace.go:171","msg":"trace[73418269] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ddc5e481-1a89-4203-9ec7-3ea4be193beb; range_end:; response_count:1; response_revision:1862; }","duration":"386.122723ms","start":"2026-09-25T22:04:49.765025Z","end":"2026-09-25T22:04:50.151148Z","steps":["trace[73418269] 'agreement among raft nodes before linearized reading' (duration: 385.96648ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T22:04:50.151214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T22:04:49.765008Z","time spent":"386.195424ms","remote":"127.0.0.1:59888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ddc5e481-1a89-4203-9ec7-3ea4be193beb\" "} {"level":"warn","ts":"2026-09-25T22:04:50.151313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.509934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ddc5e481-1a89-4203-9ec7-3ea4be193beb\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-25T22:04:50.151395Z","caller":"traceutil/trace.go:171","msg":"trace[897498215] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ddc5e481-1a89-4203-9ec7-3ea4be193beb; range_end:; response_count:1; response_revision:1862; }","duration":"288.673856ms","start":"2026-09-25T22:04:49.862699Z","end":"2026-09-25T22:04:50.151373Z","steps":["trace[897498215] 'agreement among raft nodes before linearized reading' (duration: 288.332541ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:04:50.157804Z","caller":"traceutil/trace.go:171","msg":"trace[1525686015] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"255.288005ms","start":"2026-09-25T22:04:49.90249Z","end":"2026-09-25T22:04:50.157778Z","steps":["trace[1525686015] 'process raft request' (duration: 254.926119ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:04:50.274452Z","caller":"traceutil/trace.go:171","msg":"trace[256312385] transaction","detail":"{read_only:false; response_revision:1865; number_of_response:1; }","duration":"109.640683ms","start":"2026-09-25T22:04:50.164791Z","end":"2026-09-25T22:04:50.274432Z","steps":["trace[256312385] 'process raft request' (duration: 96.243549ms)","trace[256312385] 'compare' (duration: 13.249012ms)"],"step_count":2} {"level":"info","ts":"2026-09-25T22:04:50.552835Z","caller":"traceutil/trace.go:171","msg":"trace[467238254] linearizableReadLoop","detail":"{readStateIndex:1942; appliedIndex:1941; }","duration":"169.704127ms","start":"2026-09-25T22:04:50.383108Z","end":"2026-09-25T22:04:50.552812Z","steps":["trace[467238254] 'read index received' (duration: 158.684753ms)","trace[467238254] 'applied index is now lower than readState.Index' (duration: 11.018074ms)"],"step_count":2} {"level":"warn","ts":"2026-09-25T22:04:50.553082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.964303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-25T22:04:50.55315Z","caller":"traceutil/trace.go:171","msg":"trace[1385767101] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1869; }","duration":"170.073904ms","start":"2026-09-25T22:04:50.383063Z","end":"2026-09-25T22:04:50.553137Z","steps":["trace[1385767101] 'agreement among raft nodes before linearized reading' (duration: 169.86905ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:04:50.552867Z","caller":"traceutil/trace.go:171","msg":"trace[166109160] transaction","detail":"{read_only:false; response_revision:1869; number_of_response:1; }","duration":"257.166791ms","start":"2026-09-25T22:04:50.295668Z","end":"2026-09-25T22:04:50.552835Z","steps":["trace[166109160] 'process raft request' (duration: 246.201777ms)","trace[166109160] 'compare' (duration: 10.642708ms)"],"step_count":2} {"level":"info","ts":"2026-09-25T22:05:02.325894Z","caller":"traceutil/trace.go:171","msg":"trace[2064765732] transaction","detail":"{read_only:false; response_revision:1960; number_of_response:1; }","duration":"100.70905ms","start":"2026-09-25T22:05:02.225161Z","end":"2026-09-25T22:05:02.32587Z","steps":["trace[2064765732] 'process raft request' (duration: 100.06907ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T22:05:23.761787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.688115ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-09-25T22:05:24.844034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.697249ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-25T22:05:24.844175Z","caller":"traceutil/trace.go:171","msg":"trace[1281017926] linearizableReadLoop","detail":"{readStateIndex:2185; appliedIndex:2183; }","duration":"134.925459ms","start":"2026-09-25T22:05:24.709234Z","end":"2026-09-25T22:05:24.84416Z","steps":["trace[1281017926] 'read index received' (duration: 67.221µs)","trace[1281017926] 'applied index is now lower than readState.Index' (duration: 134.856958ms)"],"step_count":2} {"level":"info","ts":"2026-09-25T22:05:24.844376Z","caller":"traceutil/trace.go:171","msg":"trace[367443524] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"352.255201ms","start":"2026-09-25T22:05:24.492108Z","end":"2026-09-25T22:05:24.844363Z","steps":["trace[367443524] 'process raft request' (duration: 176.131896ms)","trace[367443524] 'compare' (duration: 175.605907ms)"],"step_count":2} {"level":"warn","ts":"2026-09-25T22:05:24.844441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T22:05:24.492096Z","time spent":"352.312172ms","remote":"127.0.0.1:59974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-25T22:05:24.84459Z","caller":"traceutil/trace.go:171","msg":"trace[410143865] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"352.381223ms","start":"2026-09-25T22:05:24.492181Z","end":"2026-09-25T22:05:24.844563Z","steps":["trace[410143865] 'process raft request' (duration: 351.928066ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T22:05:24.844742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T22:05:24.492165Z","time spent":"352.499575ms","remote":"127.0.0.1:59974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-25T22:05:24.844774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.523398ms","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-25T22:05:24.845126Z","caller":"traceutil/trace.go:171","msg":"trace[1513781662] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2104; }","duration":"135.832093ms","start":"2026-09-25T22:05:24.70918Z","end":"2026-09-25T22:05:24.845012Z","steps":["trace[1513781662] 'agreement among raft nodes before linearized reading' (duration: 135.321645ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T22:05:24.866877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.151058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-25T22:05:24.866932Z","caller":"traceutil/trace.go:171","msg":"trace[225605895] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2105; }","duration":"120.241579ms","start":"2026-09-25T22:05:24.746677Z","end":"2026-09-25T22:05:24.866918Z","steps":["trace[225605895] 'agreement among raft nodes before linearized reading' (duration: 120.127318ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T22:05:25.255003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.387012ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-25T22:05:25.255486Z","caller":"traceutil/trace.go:171","msg":"trace[1773004303] transaction","detail":"{read_only:false; response_revision:2106; number_of_response:1; }","duration":"405.398487ms","start":"2026-09-25T22:05:24.849708Z","end":"2026-09-25T22:05:25.255106Z","steps":["trace[1773004303] 'process raft request' (duration: 157.778351ms)","trace[1773004303] 'compare' (duration: 247.141559ms)"],"step_count":2} {"level":"warn","ts":"2026-09-25T22:05:25.25602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T22:05:24.849688Z","time spent":"405.859023ms","remote":"127.0.0.1:59974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-25T22:05:25.421511Z","caller":"traceutil/trace.go:171","msg":"trace[293946279] transaction","detail":"{read_only:false; response_revision:2107; number_of_response:1; }","duration":"248.630091ms","start":"2026-09-25T22:05:25.172852Z","end":"2026-09-25T22:05:25.421482Z","steps":["trace[293946279] 'process raft request' (duration: 244.407748ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:07:34.05597Z","caller":"traceutil/trace.go:171","msg":"trace[218896265] transaction","detail":"{read_only:false; response_revision:2900; number_of_response:1; }","duration":"119.057433ms","start":"2026-09-25T22:07:33.936879Z","end":"2026-09-25T22:07:34.055936Z","steps":["trace[218896265] 'process raft request' (duration: 118.806785ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T22:11:50.111874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.506961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-09-25T22:11:50.11197Z","caller":"traceutil/trace.go:171","msg":"trace[1416796857] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4930; }","duration":"124.631574ms","start":"2026-09-25T22:11:49.987318Z","end":"2026-09-25T22:11:50.11195Z","steps":["trace[1416796857] 'range keys from in-memory index tree' (duration: 124.40306ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:11:56.97637Z","caller":"traceutil/trace.go:171","msg":"trace[790785003] linearizableReadLoop","detail":"{readStateIndex:5232; appliedIndex:5231; }","duration":"178.770747ms","start":"2026-09-25T22:11:56.797575Z","end":"2026-09-25T22:11:56.976346Z","steps":["trace[790785003] 'read index received' (duration: 177.581486ms)","trace[790785003] 'applied index is now lower than readState.Index' (duration: 1.188351ms)"],"step_count":2} {"level":"info","ts":"2026-09-25T22:11:56.976482Z","caller":"traceutil/trace.go:171","msg":"trace[1168282012] transaction","detail":"{read_only:false; response_revision:5038; number_of_response:1; }","duration":"214.93924ms","start":"2026-09-25T22:11:56.761488Z","end":"2026-09-25T22:11:56.976428Z","steps":["trace[1168282012] 'process raft request' (duration: 213.484685ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T22:11:56.976619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.023631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12975"} {"level":"info","ts":"2026-09-25T22:11:56.976684Z","caller":"traceutil/trace.go:171","msg":"trace[1186320428] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5038; }","duration":"179.127233ms","start":"2026-09-25T22:11:56.797544Z","end":"2026-09-25T22:11:56.976672Z","steps":["trace[1186320428] 'agreement among raft nodes before linearized reading' (duration: 178.94772ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:11:57.122601Z","caller":"traceutil/trace.go:171","msg":"trace[425308612] transaction","detail":"{read_only:false; response_revision:5039; number_of_response:1; }","duration":"168.020287ms","start":"2026-09-25T22:11:56.954548Z","end":"2026-09-25T22:11:57.122568Z","steps":["trace[425308612] 'process raft request' (duration: 155.538969ms)","trace[425308612] 'compare' (duration: 11.969159ms)"],"step_count":2} {"level":"info","ts":"2026-09-25T22:11:57.122578Z","caller":"traceutil/trace.go:171","msg":"trace[1890369913] linearizableReadLoop","detail":"{readStateIndex:5233; appliedIndex:5232; }","duration":"146.039782ms","start":"2026-09-25T22:11:56.976468Z","end":"2026-09-25T22:11:57.122508Z","steps":["trace[1890369913] 'read index received' (duration: 133.626605ms)","trace[1890369913] 'applied index is now lower than readState.Index' (duration: 12.410497ms)"],"step_count":2} {"level":"warn","ts":"2026-09-25T22:11:57.123014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.36685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-84f88678bc-wcntv.18d8aff4539d8745\" ","response":"range_response_count:1 size:896"} {"level":"warn","ts":"2026-09-25T22:11:57.12305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.352012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-09-25T22:11:57.123101Z","caller":"traceutil/trace.go:171","msg":"trace[996228029] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5039; }","duration":"268.461514ms","start":"2026-09-25T22:11:56.854622Z","end":"2026-09-25T22:11:57.123083Z","steps":["trace[996228029] 'agreement among raft nodes before linearized reading' (duration: 268.137599ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:11:57.123124Z","caller":"traceutil/trace.go:171","msg":"trace[95887991] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-84f88678bc-wcntv.18d8aff4539d8745; range_end:; response_count:1; response_revision:5039; }","duration":"325.476051ms","start":"2026-09-25T22:11:56.797601Z","end":"2026-09-25T22:11:57.123077Z","steps":["trace[95887991] 'agreement among raft nodes before linearized reading' (duration: 325.252377ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T22:11:57.123176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T22:11:56.797589Z","time spent":"325.572483ms","remote":"127.0.0.1:59776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":93,"response count":1,"response size":919,"request content":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-84f88678bc-wcntv.18d8aff4539d8745\" "} {"level":"warn","ts":"2026-09-25T22:11:57.12453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.924205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-09-25T22:11:57.124589Z","caller":"traceutil/trace.go:171","msg":"trace[1509952503] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:5039; }","duration":"164.020247ms","start":"2026-09-25T22:11:56.960552Z","end":"2026-09-25T22:11:57.124573Z","steps":["trace[1509952503] 'agreement among raft nodes before linearized reading' (duration: 161.973012ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:11:57.13927Z","caller":"traceutil/trace.go:171","msg":"trace[879608756] transaction","detail":"{read_only:false; response_revision:5040; number_of_response:1; }","duration":"147.111041ms","start":"2026-09-25T22:11:56.99214Z","end":"2026-09-25T22:11:57.139251Z","steps":["trace[879608756] 'process raft request' (duration: 146.981239ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T22:11:57.140003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.275112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-25T22:11:57.140038Z","caller":"traceutil/trace.go:171","msg":"trace[1991403455] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5040; }","duration":"108.354974ms","start":"2026-09-25T22:11:57.031672Z","end":"2026-09-25T22:11:57.140027Z","steps":["trace[1991403455] 'agreement among raft nodes before linearized reading' (duration: 108.266322ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:11:57.600679Z","caller":"traceutil/trace.go:171","msg":"trace[1449439524] transaction","detail":"{read_only:false; response_revision:5049; number_of_response:1; }","duration":"305.518379ms","start":"2026-09-25T22:11:57.295132Z","end":"2026-09-25T22:11:57.600651Z","steps":["trace[1449439524] 'process raft request' (duration: 305.340636ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T22:11:57.601767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T22:11:57.295085Z","time spent":"305.662411ms","remote":"127.0.0.1:41568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7567,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-25T22:11:57.722258Z","caller":"traceutil/trace.go:171","msg":"trace[1166525351] linearizableReadLoop","detail":"{readStateIndex:5244; appliedIndex:5242; }","duration":"381.662839ms","start":"2026-09-25T22:11:57.340571Z","end":"2026-09-25T22:11:57.722234Z","steps":["trace[1166525351] 'read index received' (duration: 259.901982ms)","trace[1166525351] 'applied index is now lower than readState.Index' (duration: 121.759617ms)"],"step_count":2} {"level":"info","ts":"2026-09-25T22:11:57.722282Z","caller":"traceutil/trace.go:171","msg":"trace[696804293] transaction","detail":"{read_only:false; response_revision:5050; number_of_response:1; }","duration":"397.441276ms","start":"2026-09-25T22:11:57.324806Z","end":"2026-09-25T22:11:57.722247Z","steps":["trace[696804293] 'process raft request' (duration: 383.064554ms)","trace[696804293] 'compare' (duration: 14.070206ms)"],"step_count":2} {"level":"info","ts":"2026-09-25T22:11:57.722376Z","caller":"traceutil/trace.go:171","msg":"trace[65279379] transaction","detail":"{read_only:false; response_revision:5051; number_of_response:1; }","duration":"131.168183ms","start":"2026-09-25T22:11:57.591198Z","end":"2026-09-25T22:11:57.722366Z","steps":["trace[65279379] 'process raft request' (duration: 130.968699ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T22:11:57.722438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T22:11:57.324781Z","time spent":"397.564227ms","remote":"127.0.0.1:43810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2230,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-25T22:11:57.722807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.216339ms","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-09-25T22:11:57.72284Z","caller":"traceutil/trace.go:171","msg":"trace[1657680363] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5051; }","duration":"382.292261ms","start":"2026-09-25T22:11:57.340538Z","end":"2026-09-25T22:11:57.72283Z","steps":["trace[1657680363] 'agreement among raft nodes before linearized reading' (duration: 382.127958ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T22:11:57.722868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T22:11:57.340526Z","time spent":"382.334081ms","remote":"127.0.0.1:59974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-25T22:11:57.72287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.479507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-25T22:11:57.722911Z","caller":"traceutil/trace.go:171","msg":"trace[751784003] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:5051; }","duration":"234.573339ms","start":"2026-09-25T22:11:57.488326Z","end":"2026-09-25T22:11:57.7229Z","steps":["trace[751784003] 'agreement among raft nodes before linearized reading' (duration: 234.476117ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T22:11:57.724616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.858948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7684c65b-98bc-421c-bd1e-6d0111c1874f\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-09-25T22:11:57.724701Z","caller":"traceutil/trace.go:171","msg":"trace[715034554] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7684c65b-98bc-421c-bd1e-6d0111c1874f; range_end:; response_count:1; response_revision:5051; }","duration":"157.996821ms","start":"2026-09-25T22:11:57.566684Z","end":"2026-09-25T22:11:57.724681Z","steps":["trace[715034554] 'agreement among raft nodes before linearized reading' (duration: 156.246751ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:12:02.706753Z","caller":"traceutil/trace.go:171","msg":"trace[1819626066] transaction","detail":"{read_only:false; response_revision:5109; number_of_response:1; }","duration":"107.712273ms","start":"2026-09-25T22:12:02.599011Z","end":"2026-09-25T22:12:02.706723Z","steps":["trace[1819626066] 'process raft request' (duration: 50.157812ms)","trace[1819626066] 'compare' (duration: 57.177325ms)"],"step_count":2} {"level":"info","ts":"2026-09-25T22:12:10.716563Z","caller":"traceutil/trace.go:171","msg":"trace[1830817982] transaction","detail":"{read_only:false; response_revision:5224; number_of_response:1; }","duration":"148.006435ms","start":"2026-09-25T22:12:10.568518Z","end":"2026-09-25T22:12:10.716525Z","steps":["trace[1830817982] 'process raft request' (duration: 147.73464ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T22:12:10.916432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.940961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-25T22:12:10.916508Z","caller":"traceutil/trace.go:171","msg":"trace[1151202589] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5224; }","duration":"167.060884ms","start":"2026-09-25T22:12:10.749429Z","end":"2026-09-25T22:12:10.91649Z","steps":["trace[1151202589] 'range keys from in-memory index tree' (duration: 166.724198ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T22:12:10.916879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.487937ms","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-09-25T22:12:10.917019Z","caller":"traceutil/trace.go:171","msg":"trace[1605384025] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5224; }","duration":"176.68584ms","start":"2026-09-25T22:12:10.740294Z","end":"2026-09-25T22:12:10.91698Z","steps":["trace[1605384025] 'range keys from in-memory index tree' (duration: 176.206422ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:12:25.155707Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2850} {"level":"info","ts":"2026-09-25T22:12:25.23798Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2850,"took":"80.36145ms","hash":272981621,"current-db-size-bytes":51396608,"current-db-size":"51 MB","current-db-size-in-use-bytes":27541504,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-25T22:12:25.238087Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":272981621,"revision":2850,"compact-revision":-1} {"level":"info","ts":"2026-09-25T22:12:50.703148Z","caller":"traceutil/trace.go:171","msg":"trace[1811791257] transaction","detail":"{read_only:false; response_revision:5571; number_of_response:1; }","duration":"428.448066ms","start":"2026-09-25T22:12:50.274671Z","end":"2026-09-25T22:12:50.703119Z","steps":["trace[1811791257] 'process raft request' (duration: 428.275553ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T22:12:50.703319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T22:12:50.274656Z","time spent":"428.576228ms","remote":"127.0.0.1:59974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-25T22:12:50.737246Z","caller":"traceutil/trace.go:171","msg":"trace[229750283] transaction","detail":"{read_only:false; response_revision:5572; number_of_response:1; }","duration":"458.675271ms","start":"2026-09-25T22:12:50.278547Z","end":"2026-09-25T22:12:50.737222Z","steps":["trace[229750283] 'process raft request' (duration: 458.493458ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:12:50.737437Z","caller":"traceutil/trace.go:171","msg":"trace[8361196] linearizableReadLoop","detail":"{readStateIndex:5782; appliedIndex:5780; }","duration":"435.396822ms","start":"2026-09-25T22:12:50.302017Z","end":"2026-09-25T22:12:50.737414Z","steps":["trace[8361196] 'read index received' (duration: 401.014837ms)","trace[8361196] 'applied index is now lower than readState.Index' (duration: 34.380555ms)"],"step_count":2} {"level":"info","ts":"2026-09-25T22:12:50.737523Z","caller":"traceutil/trace.go:171","msg":"trace[1469703920] transaction","detail":"{read_only:false; response_revision:5573; number_of_response:1; }","duration":"210.745225ms","start":"2026-09-25T22:12:50.526737Z","end":"2026-09-25T22:12:50.737482Z","steps":["trace[1469703920] 'process raft request' (duration: 210.44707ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T22:12:50.737638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.606076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-09-25T22:12:50.737685Z","caller":"traceutil/trace.go:171","msg":"trace[535134684] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:5573; }","duration":"435.681567ms","start":"2026-09-25T22:12:50.301987Z","end":"2026-09-25T22:12:50.737669Z","steps":["trace[535134684] 'agreement among raft nodes before linearized reading' (duration: 435.533914ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T22:12:50.737713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T22:12:50.301972Z","time spent":"435.733017ms","remote":"127.0.0.1:59794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":1844,"request content":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" "} {"level":"warn","ts":"2026-09-25T22:12:50.737711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.640397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-25T22:12:50.737814Z","caller":"traceutil/trace.go:171","msg":"trace[112021597] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5573; }","duration":"279.79141ms","start":"2026-09-25T22:12:50.458Z","end":"2026-09-25T22:12:50.737791Z","steps":["trace[112021597] 'agreement among raft nodes before linearized reading' (duration: 279.623267ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T22:12:50.737848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.508717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-credential-setup\" ","response":"range_response_count:1 size:6157"} {"level":"info","ts":"2026-09-25T22:12:50.737905Z","caller":"traceutil/trace.go:171","msg":"trace[438057760] range","detail":"{range_begin:/registry/jobs/openstack/keystone-credential-setup; range_end:; response_count:1; response_revision:5573; }","duration":"272.617209ms","start":"2026-09-25T22:12:50.465272Z","end":"2026-09-25T22:12:50.737889Z","steps":["trace[438057760] 'agreement among raft nodes before linearized reading' (duration: 272.434806ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T22:12:50.737921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T22:12:50.278523Z","time spent":"458.790633ms","remote":"127.0.0.1:59974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-25T22:12:50.737989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.65871ms","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-09-25T22:12:50.738136Z","caller":"traceutil/trace.go:171","msg":"trace[1490191577] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:5573; }","duration":"272.849743ms","start":"2026-09-25T22:12:50.465261Z","end":"2026-09-25T22:12:50.73811Z","steps":["trace[1490191577] 'agreement among raft nodes before linearized reading' (duration: 272.583879ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T22:12:50.739599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.009353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-25T22:12:50.739746Z","caller":"traceutil/trace.go:171","msg":"trace[1534653090] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5573; }","duration":"281.58554ms","start":"2026-09-25T22:12:50.458109Z","end":"2026-09-25T22:12:50.739694Z","steps":["trace[1534653090] 'agreement among raft nodes before linearized reading' (duration: 279.867421ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:13:04.41723Z","caller":"traceutil/trace.go:171","msg":"trace[368833666] transaction","detail":"{read_only:false; response_revision:5671; number_of_response:1; }","duration":"101.424071ms","start":"2026-09-25T22:13:04.315777Z","end":"2026-09-25T22:13:04.417201Z","steps":["trace[368833666] 'process raft request' (duration: 101.162777ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:16:21.31607Z","caller":"traceutil/trace.go:171","msg":"trace[8933061] transaction","detail":"{read_only:false; response_revision:7040; number_of_response:1; }","duration":"118.243386ms","start":"2026-09-25T22:16:21.197796Z","end":"2026-09-25T22:16:21.31604Z","steps":["trace[8933061] 'process raft request' (duration: 118.0775ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T22:17:25.161915Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5332} {"level":"info","ts":"2026-09-25T22:17:25.26604Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5332,"took":"102.41581ms","hash":2314575561,"current-db-size-bytes":51396608,"current-db-size":"51 MB","current-db-size-in-use-bytes":18739200,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-25T22:17:25.266114Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2314575561,"revision":5332,"compact-revision":2850}