{"level":"warn","ts":"2026-09-01T04:20:56.97904Z","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-01T04:20:56.979231Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.214: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.214:2380","--initial-cluster=controller=https://162.253.55.214:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.214:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.214:2380","--name=controller","--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-01T04:20:56.979347Z","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-01T04:20:56.979364Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.214:2380"]} {"level":"info","ts":"2026-09-01T04:20:56.979385Z","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-01T04:20:56.980321Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.214:2379"]} {"level":"info","ts":"2026-09-01T04:20:56.980428Z","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":"controller","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.214:2380"],"listen-peer-urls":["https://162.253.55.214:2380"],"advertise-client-urls":["https://162.253.55.214:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.214:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"controller=https://162.253.55.214: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-01T04:20:56.986269Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.474109ms"} {"level":"info","ts":"2026-09-01T04:20:56.994785Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"86f12f2ae020828","cluster-id":"dfe59afaaa064e4a"} {"level":"info","ts":"2026-09-01T04:20:56.99487Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 switched to configuration voters=()"} {"level":"info","ts":"2026-09-01T04:20:56.994914Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 became follower at term 0"} {"level":"info","ts":"2026-09-01T04:20:56.994932Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 86f12f2ae020828 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-01T04:20:56.99494Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 became follower at term 1"} {"level":"info","ts":"2026-09-01T04:20:56.994981Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 switched to configuration voters=(607725308229060648)"} {"level":"warn","ts":"2026-09-01T04:20:57.004775Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-01T04:20:57.006468Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-01T04:20:57.008266Z","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-01T04:20:57.010662Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"86f12f2ae020828","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-01T04:20:57.01088Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"86f12f2ae020828","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-01T04:20:57.010973Z","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-01T04:20:57.01123Z","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-01T04:20:57.011348Z","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-01T04:20:57.014835Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 switched to configuration voters=(607725308229060648)"} {"level":"info","ts":"2026-09-01T04:20:57.015063Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dfe59afaaa064e4a","local-member-id":"86f12f2ae020828","added-peer-id":"86f12f2ae020828","added-peer-peer-urls":["https://162.253.55.214:2380"]} {"level":"info","ts":"2026-09-01T04:20:57.015657Z","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-01T04:20:57.015949Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"86f12f2ae020828","initial-advertise-peer-urls":["https://162.253.55.214:2380"],"listen-peer-urls":["https://162.253.55.214:2380"],"advertise-client-urls":["https://162.253.55.214:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.214:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-01T04:20:57.015989Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-01T04:20:57.016155Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.214:2380"} {"level":"info","ts":"2026-09-01T04:20:57.016192Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.214:2380"} {"level":"info","ts":"2026-09-01T04:20:57.195615Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 is starting a new election at term 1"} {"level":"info","ts":"2026-09-01T04:20:57.195778Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-01T04:20:57.19582Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 received MsgPreVoteResp from 86f12f2ae020828 at term 1"} {"level":"info","ts":"2026-09-01T04:20:57.195839Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 became candidate at term 2"} {"level":"info","ts":"2026-09-01T04:20:57.195846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 received MsgVoteResp from 86f12f2ae020828 at term 2"} {"level":"info","ts":"2026-09-01T04:20:57.19586Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 became leader at term 2"} {"level":"info","ts":"2026-09-01T04:20:57.195872Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 86f12f2ae020828 elected leader 86f12f2ae020828 at term 2"} {"level":"info","ts":"2026-09-01T04:20:57.196905Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T04:20:57.197906Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"86f12f2ae020828","local-member-attributes":"{Name:controller ClientURLs:[https://162.253.55.214:2379]}","request-path":"/0/members/86f12f2ae020828/attributes","cluster-id":"dfe59afaaa064e4a","publish-timeout":"7s"} {"level":"info","ts":"2026-09-01T04:20:57.19801Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-01T04:20:57.198065Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-01T04:20:57.198307Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dfe59afaaa064e4a","local-member-id":"86f12f2ae020828","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T04:20:57.201272Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T04:20:57.201301Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T04:20:57.198961Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-01T04:20:57.201315Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-01T04:20:57.200997Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-01T04:20:57.203152Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.214:2379"} {"level":"warn","ts":"2026-09-01T04:21:00.918751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.121217ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-01T04:21:00.919025Z","caller":"traceutil/trace.go:171","msg":"trace[290623842] transaction","detail":"{read_only:false; response_revision:195; number_of_response:1; }","duration":"220.219797ms","start":"2026-09-01T04:21:00.698785Z","end":"2026-09-01T04:21:00.919005Z","steps":["trace[290623842] 'process raft request' (duration: 220.133126ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:21:00.919071Z","caller":"traceutil/trace.go:171","msg":"trace[1536490728] transaction","detail":"{read_only:false; response_revision:194; number_of_response:1; }","duration":"307.861726ms","start":"2026-09-01T04:21:00.611171Z","end":"2026-09-01T04:21:00.919033Z","steps":["trace[1536490728] 'process raft request' (duration: 97.547182ms)","trace[1536490728] 'compare' (duration: 208.989385ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:21:00.919262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:21:00.611075Z","time spent":"308.107649ms","remote":"127.0.0.1:56426","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":689,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-01T04:21:06.522321Z","caller":"traceutil/trace.go:171","msg":"trace[226312858] linearizableReadLoop","detail":"{readStateIndex:313; appliedIndex:312; }","duration":"126.624299ms","start":"2026-09-01T04:21:06.395677Z","end":"2026-09-01T04:21:06.522301Z","steps":["trace[226312858] 'read index received' (duration: 126.504508ms)","trace[226312858] 'applied index is now lower than readState.Index' (duration: 118.941µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:21:06.522622Z","caller":"traceutil/trace.go:171","msg":"trace[1360984918] transaction","detail":"{read_only:false; response_revision:303; number_of_response:1; }","duration":"168.084239ms","start":"2026-09-01T04:21:06.354527Z","end":"2026-09-01T04:21:06.522611Z","steps":["trace[1360984918] 'process raft request' (duration: 167.659653ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:21:06.522919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.197038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-09-01T04:21:06.522948Z","caller":"traceutil/trace.go:171","msg":"trace[1751542683] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:303; }","duration":"127.267329ms","start":"2026-09-01T04:21:06.39567Z","end":"2026-09-01T04:21:06.522938Z","steps":["trace[1751542683] 'agreement among raft nodes before linearized reading' (duration: 127.117606ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:21:07.005357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.706494ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-01T04:21:07.005474Z","caller":"traceutil/trace.go:171","msg":"trace[1469263465] transaction","detail":"{read_only:false; response_revision:304; number_of_response:1; }","duration":"476.044897ms","start":"2026-09-01T04:21:06.529406Z","end":"2026-09-01T04:21:07.005451Z","steps":["trace[1469263465] 'process raft request' (duration: 290.157722ms)","trace[1469263465] 'compare' (duration: 185.48975ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:21:07.005536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:21:06.529371Z","time spent":"476.141279ms","remote":"127.0.0.1:56306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":680,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-01T04:21:07.406319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.782763ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T04:21:07.406655Z","caller":"traceutil/trace.go:171","msg":"trace[860002449] transaction","detail":"{read_only:false; response_revision:305; number_of_response:1; }","duration":"874.558724ms","start":"2026-09-01T04:21:06.532065Z","end":"2026-09-01T04:21:07.406623Z","steps":["trace[860002449] 'process raft request' (duration: 634.0387ms)","trace[860002449] 'compare' (duration: 239.60432ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:21:07.406843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:21:06.532047Z","time spent":"874.678435ms","remote":"127.0.0.1:56684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3691,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T04:21:07.406854Z","caller":"traceutil/trace.go:171","msg":"trace[41748509] linearizableReadLoop","detail":"{readStateIndex:320; appliedIndex:313; }","duration":"861.664628ms","start":"2026-09-01T04:21:06.545106Z","end":"2026-09-01T04:21:07.40677Z","steps":["trace[41748509] 'read index received' (duration: 274.380255ms)","trace[41748509] 'applied index is now lower than readState.Index' (duration: 587.283033ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:21:07.406981Z","caller":"traceutil/trace.go:171","msg":"trace[196542478] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"874.542174ms","start":"2026-09-01T04:21:06.532427Z","end":"2026-09-01T04:21:07.406969Z","steps":["trace[196542478] 'process raft request' (duration: 873.994576ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:21:07.407019Z","caller":"traceutil/trace.go:171","msg":"trace[1443145480] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"868.623907ms","start":"2026-09-01T04:21:06.538386Z","end":"2026-09-01T04:21:07.40701Z","steps":["trace[1443145480] 'process raft request' (duration: 868.235872ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:21:07.407062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:21:06.53834Z","time spent":"868.698958ms","remote":"127.0.0.1:56596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2094,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T04:21:07.407059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:21:06.532413Z","time spent":"874.609975ms","remote":"127.0.0.1:56524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1050,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-01T04:21:07.407347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"811.512082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-09-01T04:21:07.407398Z","caller":"traceutil/trace.go:171","msg":"trace[1622892504] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:310; }","duration":"811.607303ms","start":"2026-09-01T04:21:06.595764Z","end":"2026-09-01T04:21:07.407371Z","steps":["trace[1622892504] 'agreement among raft nodes before linearized reading' (duration: 811.536602ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:21:07.40742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:21:06.595737Z","time spent":"811.678014ms","remote":"127.0.0.1:56442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" "} {"level":"info","ts":"2026-09-01T04:21:07.407504Z","caller":"traceutil/trace.go:171","msg":"trace[1975593485] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"868.727208ms","start":"2026-09-01T04:21:06.53877Z","end":"2026-09-01T04:21:07.407497Z","steps":["trace[1975593485] 'process raft request' (duration: 867.954967ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:21:07.407539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:21:06.538762Z","time spent":"868.758159ms","remote":"127.0.0.1:56596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2191,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T04:21:07.407628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.030901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-09-01T04:21:07.40765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.622932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-09-01T04:21:07.407672Z","caller":"traceutil/trace.go:171","msg":"trace[1891757981] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:310; }","duration":"660.680532ms","start":"2026-09-01T04:21:06.746985Z","end":"2026-09-01T04:21:07.407665Z","steps":["trace[1891757981] 'agreement among raft nodes before linearized reading' (duration: 660.638912ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:21:07.407674Z","caller":"traceutil/trace.go:171","msg":"trace[1067876615] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:310; }","duration":"612.107681ms","start":"2026-09-01T04:21:06.795552Z","end":"2026-09-01T04:21:07.40766Z","steps":["trace[1067876615] 'agreement among raft nodes before linearized reading' (duration: 612.02086ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:21:07.407688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:21:06.74696Z","time spent":"660.724153ms","remote":"127.0.0.1:56442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":218,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" "} {"level":"warn","ts":"2026-09-01T04:21:07.407712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:21:06.795531Z","time spent":"612.172642ms","remote":"127.0.0.1:56442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" "} {"level":"warn","ts":"2026-09-01T04:21:07.407776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"710.744007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-09-01T04:21:07.407847Z","caller":"traceutil/trace.go:171","msg":"trace[1561212984] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:310; }","duration":"710.789358ms","start":"2026-09-01T04:21:06.696999Z","end":"2026-09-01T04:21:07.407788Z","steps":["trace[1561212984] 'agreement among raft nodes before linearized reading' (duration: 710.759868ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:21:07.407911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:21:06.69698Z","time spent":"710.92144ms","remote":"127.0.0.1:56442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" "} {"level":"warn","ts":"2026-09-01T04:21:07.408008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"762.550285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-09-01T04:21:07.408041Z","caller":"traceutil/trace.go:171","msg":"trace[1525338674] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:310; }","duration":"762.620156ms","start":"2026-09-01T04:21:06.645411Z","end":"2026-09-01T04:21:07.408031Z","steps":["trace[1525338674] 'agreement among raft nodes before linearized reading' (duration: 762.573176ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:21:07.408081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:21:06.645398Z","time spent":"762.674237ms","remote":"127.0.0.1:56442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":226,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"info","ts":"2026-09-01T04:21:07.4082Z","caller":"traceutil/trace.go:171","msg":"trace[73659678] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"869.043523ms","start":"2026-09-01T04:21:06.53824Z","end":"2026-09-01T04:21:07.407283Z","steps":["trace[73659678] 'process raft request' (duration: 868.287713ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:21:07.408513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.957882ms","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-01T04:21:07.40855Z","caller":"traceutil/trace.go:171","msg":"trace[630469914] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:310; }","duration":"111.020663ms","start":"2026-09-01T04:21:07.297516Z","end":"2026-09-01T04:21:07.408537Z","steps":["trace[630469914] 'agreement among raft nodes before linearized reading' (duration: 110.966223ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:21:07.408568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.452103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-01T04:21:07.408723Z","caller":"traceutil/trace.go:171","msg":"trace[873447837] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:310; }","duration":"492.744708ms","start":"2026-09-01T04:21:06.915961Z","end":"2026-09-01T04:21:07.408706Z","steps":["trace[873447837] 'agreement among raft nodes before linearized reading' (duration: 492.445513ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:21:07.408833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:21:06.915937Z","time spent":"492.882199ms","remote":"127.0.0.1:56518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-09-01T04:21:07.408954Z","caller":"traceutil/trace.go:171","msg":"trace[207283756] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"872.514664ms","start":"2026-09-01T04:21:06.536425Z","end":"2026-09-01T04:21:07.408939Z","steps":["trace[207283756] 'process raft request' (duration: 870.057399ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:21:07.409023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:21:06.536396Z","time spent":"872.595524ms","remote":"127.0.0.1:56442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":156,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-01T04:21:07.40934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:21:06.538219Z","time spent":"871.065584ms","remote":"127.0.0.1:56596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":899,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T04:21:07.408366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.928737ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:21:07.409467Z","caller":"traceutil/trace.go:171","msg":"trace[1734183616] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:310; }","duration":"381.026803ms","start":"2026-09-01T04:21:07.028424Z","end":"2026-09-01T04:21:07.409451Z","steps":["trace[1734183616] 'agreement among raft nodes before linearized reading' (duration: 379.905526ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:21:07.408468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"863.372652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-09-01T04:21:07.409629Z","caller":"traceutil/trace.go:171","msg":"trace[303296151] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:310; }","duration":"864.540349ms","start":"2026-09-01T04:21:06.545052Z","end":"2026-09-01T04:21:07.409592Z","steps":["trace[303296151] 'agreement among raft nodes before linearized reading' (duration: 863.369472ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:21:07.409709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:21:06.545036Z","time spent":"864.65156ms","remote":"127.0.0.1:56442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"info","ts":"2026-09-01T04:21:26.29646Z","caller":"traceutil/trace.go:171","msg":"trace[70761637] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"152.624099ms","start":"2026-09-01T04:21:26.143804Z","end":"2026-09-01T04:21:26.296428Z","steps":["trace[70761637] 'process raft request' (duration: 152.378881ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:21:29.029888Z","caller":"traceutil/trace.go:171","msg":"trace[530894012] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"104.662567ms","start":"2026-09-01T04:21:28.9252Z","end":"2026-09-01T04:21:29.029862Z","steps":["trace[530894012] 'process raft request' (duration: 104.483631ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:21:34.901097Z","caller":"traceutil/trace.go:171","msg":"trace[792546130] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"136.750925ms","start":"2026-09-01T04:21:34.764328Z","end":"2026-09-01T04:21:34.901079Z","steps":["trace[792546130] 'process raft request' (duration: 136.691843ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:21:34.905885Z","caller":"traceutil/trace.go:171","msg":"trace[2105471349] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"176.017788ms","start":"2026-09-01T04:21:34.729494Z","end":"2026-09-01T04:21:34.905511Z","steps":["trace[2105471349] 'process raft request' (duration: 171.081905ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:21:39.352623Z","caller":"traceutil/trace.go:171","msg":"trace[550194085] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"177.544401ms","start":"2026-09-01T04:21:39.175045Z","end":"2026-09-01T04:21:39.352589Z","steps":["trace[550194085] 'process raft request' (duration: 177.384326ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:21:40.114994Z","caller":"traceutil/trace.go:171","msg":"trace[746402947] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"451.88893ms","start":"2026-09-01T04:21:39.66308Z","end":"2026-09-01T04:21:40.114969Z","steps":["trace[746402947] 'process raft request' (duration: 451.683573ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:21:40.115195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:21:39.663057Z","time spent":"452.011085ms","remote":"127.0.0.1:56412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17138,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T04:21:40.123252Z","caller":"traceutil/trace.go:171","msg":"trace[1803364211] linearizableReadLoop","detail":"{readStateIndex:666; appliedIndex:664; }","duration":"432.461776ms","start":"2026-09-01T04:21:39.690761Z","end":"2026-09-01T04:21:40.123222Z","steps":["trace[1803364211] 'read index received' (duration: 423.995781ms)","trace[1803364211] 'applied index is now lower than readState.Index' (duration: 8.464655ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:21:40.123663Z","caller":"traceutil/trace.go:171","msg":"trace[259263457] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"452.594464ms","start":"2026-09-01T04:21:39.671055Z","end":"2026-09-01T04:21:40.12365Z","steps":["trace[259263457] 'process raft request' (duration: 451.978263ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:21:40.124023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.154044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:21:40.124174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.406418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-09-01T04:21:40.124216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.506612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-09-01T04:21:40.124238Z","caller":"traceutil/trace.go:171","msg":"trace[215061120] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:644; }","duration":"433.493731ms","start":"2026-09-01T04:21:39.690722Z","end":"2026-09-01T04:21:40.124216Z","steps":["trace[215061120] 'agreement among raft nodes before linearized reading' (duration: 433.300465ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:21:40.12427Z","caller":"traceutil/trace.go:171","msg":"trace[703052824] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:644; }","duration":"319.592855ms","start":"2026-09-01T04:21:39.804664Z","end":"2026-09-01T04:21:40.124257Z","steps":["trace[703052824] 'agreement among raft nodes before linearized reading' (duration: 319.389749ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:21:40.12428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.032371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-09-01T04:21:40.124309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:21:39.804652Z","time spent":"319.649347ms","remote":"127.0.0.1:56518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-09-01T04:21:40.124329Z","caller":"traceutil/trace.go:171","msg":"trace[1009968195] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:644; }","duration":"332.119574ms","start":"2026-09-01T04:21:39.792194Z","end":"2026-09-01T04:21:40.124314Z","steps":["trace[1009968195] 'agreement among raft nodes before linearized reading' (duration: 331.99007ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:21:40.124322Z","caller":"traceutil/trace.go:171","msg":"trace[1171636739] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:644; }","duration":"190.454754ms","start":"2026-09-01T04:21:39.933848Z","end":"2026-09-01T04:21:40.124079Z","steps":["trace[1171636739] 'agreement among raft nodes before linearized reading' (duration: 190.120123ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:21:40.124325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:21:39.690708Z","time spent":"433.570113ms","remote":"127.0.0.1:56518","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-01T04:21:40.124527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:21:39.792174Z","time spent":"332.187096ms","remote":"127.0.0.1:56518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-01T04:21:40.12517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:21:39.671028Z","time spent":"452.678157ms","remote":"127.0.0.1:56518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":675,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T04:21:40.621616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.597279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-09-01T04:21:40.621685Z","caller":"traceutil/trace.go:171","msg":"trace[1225124414] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:647; }","duration":"200.717783ms","start":"2026-09-01T04:21:40.42095Z","end":"2026-09-01T04:21:40.621668Z","steps":["trace[1225124414] 'range keys from in-memory index tree' (duration: 200.452925ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:21:40.886788Z","caller":"traceutil/trace.go:171","msg":"trace[1674602760] linearizableReadLoop","detail":"{readStateIndex:671; appliedIndex:670; }","duration":"251.351792ms","start":"2026-09-01T04:21:40.635396Z","end":"2026-09-01T04:21:40.886748Z","steps":["trace[1674602760] 'read index received' (duration: 219.914128ms)","trace[1674602760] 'applied index is now lower than readState.Index' (duration: 31.436324ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:21:40.886937Z","caller":"traceutil/trace.go:171","msg":"trace[179268732] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"260.483609ms","start":"2026-09-01T04:21:40.626391Z","end":"2026-09-01T04:21:40.886874Z","steps":["trace[179268732] 'process raft request' (duration: 260.112696ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:21:40.887017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.59676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:21:40.887057Z","caller":"traceutil/trace.go:171","msg":"trace[2139922273] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:648; }","duration":"251.705673ms","start":"2026-09-01T04:21:40.635339Z","end":"2026-09-01T04:21:40.887045Z","steps":["trace[2139922273] 'agreement among raft nodes before linearized reading' (duration: 251.60228ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:22:02.836581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.694073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:22:02.836676Z","caller":"traceutil/trace.go:171","msg":"trace[116797283] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:779; }","duration":"202.824816ms","start":"2026-09-01T04:22:02.633828Z","end":"2026-09-01T04:22:02.836653Z","steps":["trace[116797283] 'range keys from in-memory index tree' (duration: 202.60231ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:22:02.836923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.1876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-01T04:22:02.836991Z","caller":"traceutil/trace.go:171","msg":"trace[24188324] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:779; }","duration":"422.269583ms","start":"2026-09-01T04:22:02.414704Z","end":"2026-09-01T04:22:02.836974Z","steps":["trace[24188324] 'count revisions from in-memory index tree' (duration: 422.116779ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:22:02.83703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:22:02.414645Z","time spent":"422.374086ms","remote":"127.0.0.1:56426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":2,"response size":30,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"warn","ts":"2026-09-01T04:22:02.83706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.835256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-01T04:22:02.837166Z","caller":"traceutil/trace.go:171","msg":"trace[1922871952] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:779; }","duration":"217.97945ms","start":"2026-09-01T04:22:02.619172Z","end":"2026-09-01T04:22:02.837151Z","steps":["trace[1922871952] 'count revisions from in-memory index tree' (duration: 217.711312ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:22:02.902388Z","caller":"traceutil/trace.go:171","msg":"trace[1588341908] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"126.607259ms","start":"2026-09-01T04:22:02.775731Z","end":"2026-09-01T04:22:02.902338Z","steps":["trace[1588341908] 'process raft request' (duration: 126.275329ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:23:08.380802Z","caller":"traceutil/trace.go:171","msg":"trace[1785377425] transaction","detail":"{read_only:false; response_revision:1510; number_of_response:1; }","duration":"102.050063ms","start":"2026-09-01T04:23:08.278723Z","end":"2026-09-01T04:23:08.380773Z","steps":["trace[1785377425] 'process raft request' (duration: 101.890539ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:23:31.579007Z","caller":"traceutil/trace.go:171","msg":"trace[251154505] linearizableReadLoop","detail":"{readStateIndex:1981; appliedIndex:1980; }","duration":"268.502277ms","start":"2026-09-01T04:23:31.310484Z","end":"2026-09-01T04:23:31.578986Z","steps":["trace[251154505] 'read index received' (duration: 268.282341ms)","trace[251154505] 'applied index is now lower than readState.Index' (duration: 218.536µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:23:31.579142Z","caller":"traceutil/trace.go:171","msg":"trace[1342904090] transaction","detail":"{read_only:false; response_revision:1904; number_of_response:1; }","duration":"365.209095ms","start":"2026-09-01T04:23:31.213873Z","end":"2026-09-01T04:23:31.579082Z","steps":["trace[1342904090] 'process raft request' (duration: 364.979669ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:23:31.579193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.683841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:23:31.579231Z","caller":"traceutil/trace.go:171","msg":"trace[1647103546] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:1904; }","duration":"268.771064ms","start":"2026-09-01T04:23:31.310449Z","end":"2026-09-01T04:23:31.57922Z","steps":["trace[1647103546] 'agreement among raft nodes before linearized reading' (duration: 268.688732ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:23:31.579389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:23:31.213858Z","time spent":"365.42701ms","remote":"127.0.0.1:56412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3740,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T04:23:32.177751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.421428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-56a9e24e-7821-42ff-891f-c6d266d66677\" ","response":"range_response_count:1 size:3755"} {"level":"info","ts":"2026-09-01T04:23:32.178104Z","caller":"traceutil/trace.go:171","msg":"trace[1264370610] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-56a9e24e-7821-42ff-891f-c6d266d66677; range_end:; response_count:1; response_revision:1906; }","duration":"209.846309ms","start":"2026-09-01T04:23:31.968238Z","end":"2026-09-01T04:23:32.178084Z","steps":["trace[1264370610] 'range keys from in-memory index tree' (duration: 208.245747ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:23:42.505969Z","caller":"traceutil/trace.go:171","msg":"trace[983460549] transaction","detail":"{read_only:false; response_revision:1994; number_of_response:1; }","duration":"115.090099ms","start":"2026-09-01T04:23:42.390847Z","end":"2026-09-01T04:23:42.505937Z","steps":["trace[983460549] 'process raft request' (duration: 109.179293ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:23:48.033205Z","caller":"traceutil/trace.go:171","msg":"trace[1737637201] transaction","detail":"{read_only:false; response_revision:2037; number_of_response:1; }","duration":"302.316376ms","start":"2026-09-01T04:23:47.730855Z","end":"2026-09-01T04:23:48.033172Z","steps":["trace[1737637201] 'process raft request' (duration: 301.870294ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:23:48.033367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:23:47.730827Z","time spent":"302.473369ms","remote":"127.0.0.1:56518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":425,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T04:23:48.50985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.421568ms","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-01T04:23:48.509914Z","caller":"traceutil/trace.go:171","msg":"trace[85732035] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2037; }","duration":"243.520971ms","start":"2026-09-01T04:23:48.266378Z","end":"2026-09-01T04:23:48.509899Z","steps":["trace[85732035] 'range keys from in-memory index tree' (duration: 243.296595ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:23:48.510341Z","caller":"traceutil/trace.go:171","msg":"trace[1942068216] transaction","detail":"{read_only:false; response_revision:2038; number_of_response:1; }","duration":"223.449808ms","start":"2026-09-01T04:23:48.28687Z","end":"2026-09-01T04:23:48.51032Z","steps":["trace[1942068216] 'process raft request' (duration: 196.896826ms)","trace[1942068216] 'compare' (duration: 25.938726ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:24:09.559395Z","caller":"traceutil/trace.go:171","msg":"trace[1988506262] transaction","detail":"{read_only:false; response_revision:2165; number_of_response:1; }","duration":"167.841046ms","start":"2026-09-01T04:24:09.391527Z","end":"2026-09-01T04:24:09.559368Z","steps":["trace[1988506262] 'process raft request' (duration: 129.116987ms)","trace[1988506262] 'compare' (duration: 38.623706ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:24:10.973217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.589415ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T04:24:10.97331Z","caller":"traceutil/trace.go:171","msg":"trace[2057779016] linearizableReadLoop","detail":"{readStateIndex:2255; appliedIndex:2254; }","duration":"238.793791ms","start":"2026-09-01T04:24:10.734501Z","end":"2026-09-01T04:24:10.973295Z","steps":["trace[2057779016] 'read index received' (duration: 7.94793ms)","trace[2057779016] 'applied index is now lower than readState.Index' (duration: 230.843861ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:24:10.973367Z","caller":"traceutil/trace.go:171","msg":"trace[1732287850] transaction","detail":"{read_only:false; response_revision:2169; number_of_response:1; }","duration":"274.157076ms","start":"2026-09-01T04:24:10.699174Z","end":"2026-09-01T04:24:10.973331Z","steps":["trace[1732287850] 'process raft request' (duration: 43.340605ms)","trace[1732287850] 'compare' (duration: 230.231666ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:24:10.973492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.986876ms","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-01T04:24:10.973527Z","caller":"traceutil/trace.go:171","msg":"trace[519543286] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2169; }","duration":"239.024587ms","start":"2026-09-01T04:24:10.734494Z","end":"2026-09-01T04:24:10.973518Z","steps":["trace[519543286] 'agreement among raft nodes before linearized reading' (duration: 238.839113ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:24:11.316258Z","caller":"traceutil/trace.go:171","msg":"trace[1326642638] transaction","detail":"{read_only:false; response_revision:2173; number_of_response:1; }","duration":"138.847172ms","start":"2026-09-01T04:24:11.177375Z","end":"2026-09-01T04:24:11.316222Z","steps":["trace[1326642638] 'process raft request' (duration: 88.40447ms)","trace[1326642638] 'compare' (duration: 50.182776ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:24:11.316361Z","caller":"traceutil/trace.go:171","msg":"trace[1633500098] linearizableReadLoop","detail":"{readStateIndex:2259; appliedIndex:2258; }","duration":"131.070847ms","start":"2026-09-01T04:24:11.185269Z","end":"2026-09-01T04:24:11.31634Z","steps":["trace[1633500098] 'read index received' (duration: 80.545343ms)","trace[1633500098] 'applied index is now lower than readState.Index' (duration: 50.521904ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:24:11.316568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.282522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5700"} {"level":"info","ts":"2026-09-01T04:24:11.316617Z","caller":"traceutil/trace.go:171","msg":"trace[1999924803] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2174; }","duration":"131.369573ms","start":"2026-09-01T04:24:11.185233Z","end":"2026-09-01T04:24:11.316603Z","steps":["trace[1999924803] 'agreement among raft nodes before linearized reading' (duration: 131.2095ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:24:11.772234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.308726ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T04:24:11.772363Z","caller":"traceutil/trace.go:171","msg":"trace[508718404] transaction","detail":"{read_only:false; response_revision:2175; number_of_response:1; }","duration":"450.797732ms","start":"2026-09-01T04:24:11.32154Z","end":"2026-09-01T04:24:11.772338Z","steps":["trace[508718404] 'process raft request' (duration: 146.232639ms)","trace[508718404] 'compare' (duration: 303.782713ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:24:11.772445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:24:11.321517Z","time spent":"450.886573ms","remote":"127.0.0.1:56518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T04:24:12.510439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.357079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5700"} {"level":"info","ts":"2026-09-01T04:24:12.510536Z","caller":"traceutil/trace.go:171","msg":"trace[1534446524] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2176; }","duration":"187.461722ms","start":"2026-09-01T04:24:12.323051Z","end":"2026-09-01T04:24:12.510513Z","steps":["trace[1534446524] 'range keys from in-memory index tree' (duration: 187.171125ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:24:12.510528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.576787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-09-01T04:24:12.5106Z","caller":"traceutil/trace.go:171","msg":"trace[38405416] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2176; }","duration":"147.681969ms","start":"2026-09-01T04:24:12.362897Z","end":"2026-09-01T04:24:12.510579Z","steps":["trace[38405416] 'range keys from in-memory index tree' (duration: 147.440163ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:26:25.905494Z","caller":"traceutil/trace.go:171","msg":"trace[1670837088] linearizableReadLoop","detail":"{readStateIndex:3103; appliedIndex:3102; }","duration":"112.0117ms","start":"2026-09-01T04:26:25.793461Z","end":"2026-09-01T04:26:25.905473Z","steps":["trace[1670837088] 'read index received' (duration: 111.815926ms)","trace[1670837088] 'applied index is now lower than readState.Index' (duration: 194.904µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:26:25.905642Z","caller":"traceutil/trace.go:171","msg":"trace[1766647967] transaction","detail":"{read_only:false; response_revision:2989; number_of_response:1; }","duration":"161.860373ms","start":"2026-09-01T04:26:25.743695Z","end":"2026-09-01T04:26:25.905556Z","steps":["trace[1766647967] 'process raft request' (duration: 161.636358ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:26:25.906673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.219214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-09-01T04:26:25.906811Z","caller":"traceutil/trace.go:171","msg":"trace[1839601505] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2989; }","duration":"113.370969ms","start":"2026-09-01T04:26:25.79342Z","end":"2026-09-01T04:26:25.906791Z","steps":["trace[1839601505] 'agreement among raft nodes before linearized reading' (duration: 112.145663ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:26:26.223313Z","caller":"traceutil/trace.go:171","msg":"trace[593870352] linearizableReadLoop","detail":"{readStateIndex:3107; appliedIndex:3106; }","duration":"166.020519ms","start":"2026-09-01T04:26:26.057267Z","end":"2026-09-01T04:26:26.223287Z","steps":["trace[593870352] 'read index received' (duration: 165.812954ms)","trace[593870352] 'applied index is now lower than readState.Index' (duration: 206.385µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:26:26.223396Z","caller":"traceutil/trace.go:171","msg":"trace[1055237343] transaction","detail":"{read_only:false; response_revision:2992; number_of_response:1; }","duration":"169.276538ms","start":"2026-09-01T04:26:26.05409Z","end":"2026-09-01T04:26:26.223367Z","steps":["trace[1055237343] 'process raft request' (duration: 169.013703ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:26:26.223546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.255784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18d117dd3f081ec2\" ","response":"range_response_count:1 size:789"} {"level":"info","ts":"2026-09-01T04:26:26.223582Z","caller":"traceutil/trace.go:171","msg":"trace[1007428247] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18d117dd3f081ec2; range_end:; response_count:1; response_revision:2992; }","duration":"166.343466ms","start":"2026-09-01T04:26:26.057227Z","end":"2026-09-01T04:26:26.22357Z","steps":["trace[1007428247] 'agreement among raft nodes before linearized reading' (duration: 166.184632ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:26:26.388145Z","caller":"traceutil/trace.go:171","msg":"trace[1765136221] transaction","detail":"{read_only:false; response_revision:2994; number_of_response:1; }","duration":"159.757443ms","start":"2026-09-01T04:26:26.228325Z","end":"2026-09-01T04:26:26.388082Z","steps":["trace[1765136221] 'process raft request' (duration: 85.562718ms)","trace[1765136221] 'compare' (duration: 73.705915ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:30:57.390365Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2832} {"level":"info","ts":"2026-09-01T04:30:57.461577Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2832,"took":"70.489139ms","hash":2426248703,"current-db-size-bytes":35733504,"current-db-size":"36 MB","current-db-size-in-use-bytes":12247040,"current-db-size-in-use":"12 MB"} {"level":"info","ts":"2026-09-01T04:30:57.461625Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2426248703,"revision":2832,"compact-revision":-1} {"level":"info","ts":"2026-09-01T04:33:36.983608Z","caller":"traceutil/trace.go:171","msg":"trace[2123391651] transaction","detail":"{read_only:false; response_revision:5883; number_of_response:1; }","duration":"151.384783ms","start":"2026-09-01T04:33:36.832193Z","end":"2026-09-01T04:33:36.983578Z","steps":["trace[2123391651] 'process raft request' (duration: 151.231441ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:33:36.984202Z","caller":"traceutil/trace.go:171","msg":"trace[230153797] linearizableReadLoop","detail":"{readStateIndex:6100; appliedIndex:6100; }","duration":"151.955053ms","start":"2026-09-01T04:33:36.832226Z","end":"2026-09-01T04:33:36.984181Z","steps":["trace[230153797] 'read index received' (duration: 151.945363ms)","trace[230153797] 'applied index is now lower than readState.Index' (duration: 7.79µs)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:33:36.984366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.122966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-09-01T04:33:36.984398Z","caller":"traceutil/trace.go:171","msg":"trace[92579816] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5883; }","duration":"152.195817ms","start":"2026-09-01T04:33:36.83219Z","end":"2026-09-01T04:33:36.984386Z","steps":["trace[92579816] 'agreement among raft nodes before linearized reading' (duration: 152.060915ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:33:36.985301Z","caller":"traceutil/trace.go:171","msg":"trace[1276103312] transaction","detail":"{read_only:false; response_revision:5884; number_of_response:1; }","duration":"146.453149ms","start":"2026-09-01T04:33:36.838825Z","end":"2026-09-01T04:33:36.985279Z","steps":["trace[1276103312] 'process raft request' (duration: 146.366197ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:33:51.198275Z","caller":"traceutil/trace.go:171","msg":"trace[1767905944] linearizableReadLoop","detail":"{readStateIndex:6181; appliedIndex:6179; }","duration":"144.334024ms","start":"2026-09-01T04:33:51.053909Z","end":"2026-09-01T04:33:51.198243Z","steps":["trace[1767905944] 'read index received' (duration: 64.47787ms)","trace[1767905944] 'applied index is now lower than readState.Index' (duration: 79.854834ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:33:51.198515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.579448ms","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-01T04:33:51.198568Z","caller":"traceutil/trace.go:171","msg":"trace[1252157878] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5961; }","duration":"144.678ms","start":"2026-09-01T04:33:51.053876Z","end":"2026-09-01T04:33:51.198554Z","steps":["trace[1252157878] 'agreement among raft nodes before linearized reading' (duration: 144.474606ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:33:51.199013Z","caller":"traceutil/trace.go:171","msg":"trace[1623662256] transaction","detail":"{read_only:false; response_revision:5961; number_of_response:1; }","duration":"156.027573ms","start":"2026-09-01T04:33:51.042965Z","end":"2026-09-01T04:33:51.198992Z","steps":["trace[1623662256] 'process raft request' (duration: 129.865967ms)","trace[1623662256] 'compare' (duration: 25.247651ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:33:56.212991Z","caller":"traceutil/trace.go:171","msg":"trace[1107954800] transaction","detail":"{read_only:false; response_revision:5995; number_of_response:1; }","duration":"121.904599ms","start":"2026-09-01T04:33:56.091061Z","end":"2026-09-01T04:33:56.212965Z","steps":["trace[1107954800] 'process raft request' (duration: 121.504232ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:35:57.397373Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":4755} {"level":"info","ts":"2026-09-01T04:35:57.490948Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":4755,"took":"92.379093ms","hash":552158264,"current-db-size-bytes":35733504,"current-db-size":"36 MB","current-db-size-in-use-bytes":14372864,"current-db-size-in-use":"14 MB"} {"level":"info","ts":"2026-09-01T04:35:57.491019Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":552158264,"revision":4755,"compact-revision":2832} {"level":"warn","ts":"2026-09-01T04:37:09.393061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.121472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1988"} {"level":"info","ts":"2026-09-01T04:37:09.393204Z","caller":"traceutil/trace.go:171","msg":"trace[1191738978] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:7197; }","duration":"160.278765ms","start":"2026-09-01T04:37:09.2329Z","end":"2026-09-01T04:37:09.393179Z","steps":["trace[1191738978] 'range keys from in-memory index tree' (duration: 159.967549ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:37:09.393237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.846242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/percona-xtradb-cluster-operator\" ","response":"range_response_count:1 size:690"} {"level":"info","ts":"2026-09-01T04:37:09.393343Z","caller":"traceutil/trace.go:171","msg":"trace[1247240261] range","detail":"{range_begin:/registry/services/endpoints/openstack/percona-xtradb-cluster-operator; range_end:; response_count:1; response_revision:7197; }","duration":"117.968394ms","start":"2026-09-01T04:37:09.27535Z","end":"2026-09-01T04:37:09.393318Z","steps":["trace[1247240261] 'range keys from in-memory index tree' (duration: 117.673889ms)"],"step_count":1}