{"level":"warn","ts":"2026-10-01T06:21:17.034963Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-01T06:21:17.035296Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.113: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.113:2380","--initial-cluster=instance=https://162.253.55.113:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.113:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.113: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-10-01T06:21:17.03546Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-01T06:21:17.035494Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.113:2380"]} {"level":"info","ts":"2026-10-01T06:21:17.03555Z","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-10-01T06:21:17.03695Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.113:2379"]} {"level":"info","ts":"2026-10-01T06:21:17.037207Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.113:2380"],"listen-peer-urls":["https://162.253.55.113:2380"],"advertise-client-urls":["https://162.253.55.113:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.113:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.113: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-10-01T06:21:17.043686Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.807252ms"} {"level":"info","ts":"2026-10-01T06:21:17.0536Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3b717bddf98d48e3","cluster-id":"cef0f7c69f0576fc"} {"level":"info","ts":"2026-10-01T06:21:17.053751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3b717bddf98d48e3 switched to configuration voters=()"} {"level":"info","ts":"2026-10-01T06:21:17.053792Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3b717bddf98d48e3 became follower at term 0"} {"level":"info","ts":"2026-10-01T06:21:17.053815Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3b717bddf98d48e3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-01T06:21:17.053846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3b717bddf98d48e3 became follower at term 1"} {"level":"info","ts":"2026-10-01T06:21:17.053911Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3b717bddf98d48e3 switched to configuration voters=(4283340913910827235)"} {"level":"warn","ts":"2026-10-01T06:21:17.063382Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-01T06:21:17.066405Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-01T06:21:17.069282Z","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-10-01T06:21:17.072818Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3b717bddf98d48e3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-01T06:21:17.073219Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3b717bddf98d48e3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-01T06:21:17.073991Z","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-10-01T06:21:17.074368Z","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-10-01T06:21:17.074407Z","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-10-01T06:21:17.075782Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3b717bddf98d48e3 switched to configuration voters=(4283340913910827235)"} {"level":"info","ts":"2026-10-01T06:21:17.075974Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cef0f7c69f0576fc","local-member-id":"3b717bddf98d48e3","added-peer-id":"3b717bddf98d48e3","added-peer-peer-urls":["https://162.253.55.113:2380"]} {"level":"info","ts":"2026-10-01T06:21:17.07744Z","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-10-01T06:21:17.07759Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.113:2380"} {"level":"info","ts":"2026-10-01T06:21:17.077667Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.113:2380"} {"level":"info","ts":"2026-10-01T06:21:17.077703Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3b717bddf98d48e3","initial-advertise-peer-urls":["https://162.253.55.113:2380"],"listen-peer-urls":["https://162.253.55.113:2380"],"advertise-client-urls":["https://162.253.55.113:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.113:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-01T06:21:17.077781Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-01T06:21:17.45483Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3b717bddf98d48e3 is starting a new election at term 1"} {"level":"info","ts":"2026-10-01T06:21:17.454912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3b717bddf98d48e3 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-01T06:21:17.45494Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3b717bddf98d48e3 received MsgPreVoteResp from 3b717bddf98d48e3 at term 1"} {"level":"info","ts":"2026-10-01T06:21:17.454962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3b717bddf98d48e3 became candidate at term 2"} {"level":"info","ts":"2026-10-01T06:21:17.454973Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3b717bddf98d48e3 received MsgVoteResp from 3b717bddf98d48e3 at term 2"} {"level":"info","ts":"2026-10-01T06:21:17.45499Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3b717bddf98d48e3 became leader at term 2"} {"level":"info","ts":"2026-10-01T06:21:17.455005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3b717bddf98d48e3 elected leader 3b717bddf98d48e3 at term 2"} {"level":"info","ts":"2026-10-01T06:21:17.465904Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-01T06:21:17.477202Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-01T06:21:17.477194Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3b717bddf98d48e3","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.113:2379]}","request-path":"/0/members/3b717bddf98d48e3/attributes","cluster-id":"cef0f7c69f0576fc","publish-timeout":"7s"} {"level":"info","ts":"2026-10-01T06:21:17.477314Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-01T06:21:17.477763Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-01T06:21:17.47782Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-01T06:21:17.478703Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cef0f7c69f0576fc","local-member-id":"3b717bddf98d48e3","cluster-version":"3.5"} {"level":"info","ts":"2026-10-01T06:21:17.481249Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-01T06:21:17.481384Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-01T06:21:17.484221Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.113:2379"} {"level":"info","ts":"2026-10-01T06:21:17.484464Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-10-01T06:21:35.772184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.373538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4326"} {"level":"info","ts":"2026-10-01T06:21:35.772266Z","caller":"traceutil/trace.go:171","msg":"trace[999087751] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:407; }","duration":"166.543201ms","start":"2026-10-01T06:21:35.605709Z","end":"2026-10-01T06:21:35.772252Z","steps":["trace[999087751] 'range keys from in-memory index tree' (duration: 166.279577ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:21:41.176217Z","caller":"traceutil/trace.go:171","msg":"trace[1357488175] transaction","detail":"{read_only:false; response_revision:422; number_of_response:1; }","duration":"120.544621ms","start":"2026-10-01T06:21:41.055637Z","end":"2026-10-01T06:21:41.176182Z","steps":["trace[1357488175] 'process raft request' (duration: 120.307418ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:21:58.032134Z","caller":"traceutil/trace.go:171","msg":"trace[1339938496] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"153.446406ms","start":"2026-10-01T06:21:57.878664Z","end":"2026-10-01T06:21:58.032111Z","steps":["trace[1339938496] 'process raft request' (duration: 153.255153ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:21:58.334094Z","caller":"traceutil/trace.go:171","msg":"trace[1878772014] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:611; }","duration":"319.483748ms","start":"2026-10-01T06:21:58.014518Z","end":"2026-10-01T06:21:58.334002Z","steps":["trace[1878772014] 'read index received' (duration: 17.58883ms)","trace[1878772014] 'applied index is now lower than readState.Index' (duration: 301.893438ms)"],"step_count":2} {"level":"info","ts":"2026-10-01T06:21:58.33415Z","caller":"traceutil/trace.go:171","msg":"trace[329742839] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"455.438705ms","start":"2026-10-01T06:21:57.878663Z","end":"2026-10-01T06:21:58.334102Z","steps":["trace[329742839] 'process raft request' (duration: 452.123435ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:21:58.334292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.717221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-01T06:21:58.334388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.982669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:21:58.334426Z","caller":"traceutil/trace.go:171","msg":"trace[677268625] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:584; }","duration":"153.038499ms","start":"2026-10-01T06:21:58.181374Z","end":"2026-10-01T06:21:58.334412Z","steps":["trace[677268625] 'agreement among raft nodes before linearized reading' (duration: 152.988279ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:21:58.334509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.972445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:21:58.33456Z","caller":"traceutil/trace.go:171","msg":"trace[1267441641] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:584; }","duration":"274.020986ms","start":"2026-10-01T06:21:58.060524Z","end":"2026-10-01T06:21:58.334545Z","steps":["trace[1267441641] 'agreement among raft nodes before linearized reading' (duration: 273.953045ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:21:58.334618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.088857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:21:58.334679Z","caller":"traceutil/trace.go:171","msg":"trace[869154225] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:584; }","duration":"100.164447ms","start":"2026-10-01T06:21:58.234493Z","end":"2026-10-01T06:21:58.334658Z","steps":["trace[869154225] 'agreement among raft nodes before linearized reading' (duration: 100.098067ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:21:58.334688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.311362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:21:58.334419Z","caller":"traceutil/trace.go:171","msg":"trace[1895183686] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:584; }","duration":"319.923724ms","start":"2026-10-01T06:21:58.014465Z","end":"2026-10-01T06:21:58.334388Z","steps":["trace[1895183686] 'agreement among raft nodes before linearized reading' (duration: 319.688441ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:21:58.334697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.32577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-01T06:21:58.334783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.681954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:21:58.334795Z","caller":"traceutil/trace.go:171","msg":"trace[749101624] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:584; }","duration":"301.380571ms","start":"2026-10-01T06:21:58.033353Z","end":"2026-10-01T06:21:58.334734Z","steps":["trace[749101624] 'agreement among raft nodes before linearized reading' (duration: 301.300071ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:21:58.334803Z","caller":"traceutil/trace.go:171","msg":"trace[1843217149] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:584; }","duration":"300.482211ms","start":"2026-10-01T06:21:58.034291Z","end":"2026-10-01T06:21:58.334773Z","steps":["trace[1843217149] 'agreement among raft nodes before linearized reading' (duration: 300.32507ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:21:58.334835Z","caller":"traceutil/trace.go:171","msg":"trace[1994904505] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:584; }","duration":"152.752835ms","start":"2026-10-01T06:21:58.182069Z","end":"2026-10-01T06:21:58.334822Z","steps":["trace[1994904505] 'agreement among raft nodes before linearized reading' (duration: 152.673084ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:21:58.334776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T06:21:58.014439Z","time spent":"320.302887ms","remote":"127.0.0.1:34986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-10-01T06:21:58.334835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T06:21:57.878634Z","time spent":"455.602787ms","remote":"127.0.0.1:45070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036229,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-01T06:21:58.33486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T06:21:58.033347Z","time spent":"301.496293ms","remote":"127.0.0.1:34988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-10-01T06:21:58.33437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.899768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-01T06:21:58.334939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.453186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:21:58.334956Z","caller":"traceutil/trace.go:171","msg":"trace[1992126602] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:584; }","duration":"153.556055ms","start":"2026-10-01T06:21:58.181384Z","end":"2026-10-01T06:21:58.33494Z","steps":["trace[1992126602] 'agreement among raft nodes before linearized reading' (duration: 152.881158ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:21:58.334966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.399389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:21:58.334981Z","caller":"traceutil/trace.go:171","msg":"trace[555995367] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:584; }","duration":"272.518316ms","start":"2026-10-01T06:21:58.062449Z","end":"2026-10-01T06:21:58.334967Z","steps":["trace[555995367] 'agreement among raft nodes before linearized reading' (duration: 272.454035ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:21:58.334611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.507144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:21:58.335051Z","caller":"traceutil/trace.go:171","msg":"trace[1471964269] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:584; }","duration":"274.491061ms","start":"2026-10-01T06:21:58.060511Z","end":"2026-10-01T06:21:58.335002Z","steps":["trace[1471964269] 'agreement among raft nodes before linearized reading' (duration: 274.41213ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:21:58.335075Z","caller":"traceutil/trace.go:171","msg":"trace[1090816397] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:584; }","duration":"301.995119ms","start":"2026-10-01T06:21:58.033065Z","end":"2026-10-01T06:21:58.33506Z","steps":["trace[1090816397] 'agreement among raft nodes before linearized reading' (duration: 301.479854ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:21:58.335112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T06:21:58.033041Z","time spent":"302.05918ms","remote":"127.0.0.1:34988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-10-01T06:21:58.334322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.753342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-01T06:21:58.334869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T06:21:58.034262Z","time spent":"300.590312ms","remote":"127.0.0.1:34988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"info","ts":"2026-10-01T06:21:58.335156Z","caller":"traceutil/trace.go:171","msg":"trace[998170196] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:584; }","duration":"320.655541ms","start":"2026-10-01T06:21:58.014488Z","end":"2026-10-01T06:21:58.335143Z","steps":["trace[998170196] 'agreement among raft nodes before linearized reading' (duration: 319.762211ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:21:58.335193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T06:21:58.014465Z","time spent":"320.714793ms","remote":"127.0.0.1:34986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-10-01T06:21:58.335204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.016281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:21:58.335249Z","caller":"traceutil/trace.go:171","msg":"trace[2096177268] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:584; }","duration":"226.082422ms","start":"2026-10-01T06:21:58.109152Z","end":"2026-10-01T06:21:58.335234Z","steps":["trace[2096177268] 'agreement among raft nodes before linearized reading' (duration: 226.014721ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:21:58.335272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.010381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:21:58.335309Z","caller":"traceutil/trace.go:171","msg":"trace[992514428] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:584; }","duration":"226.073391ms","start":"2026-10-01T06:21:58.109225Z","end":"2026-10-01T06:21:58.335298Z","steps":["trace[992514428] 'agreement among raft nodes before linearized reading' (duration: 226.012891ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:21:58.903198Z","caller":"traceutil/trace.go:171","msg":"trace[1350551767] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"344.071062ms","start":"2026-10-01T06:21:58.5591Z","end":"2026-10-01T06:21:58.903171Z","steps":["trace[1350551767] 'read index received' (duration: 287.521497ms)","trace[1350551767] 'applied index is now lower than readState.Index' (duration: 56.548415ms)"],"step_count":2} {"level":"info","ts":"2026-10-01T06:21:58.903287Z","caller":"traceutil/trace.go:171","msg":"trace[77132480] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"489.689602ms","start":"2026-10-01T06:21:58.413559Z","end":"2026-10-01T06:21:58.903248Z","steps":["trace[77132480] 'process raft request' (duration: 433.165607ms)","trace[77132480] 'compare' (duration: 56.323673ms)"],"step_count":2} {"level":"warn","ts":"2026-10-01T06:21:58.903422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T06:21:58.41352Z","time spent":"489.830094ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1092,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-01T06:21:58.903457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.226784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:21:58.903484Z","caller":"traceutil/trace.go:171","msg":"trace[813328919] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:585; }","duration":"344.416516ms","start":"2026-10-01T06:21:58.55906Z","end":"2026-10-01T06:21:58.903477Z","steps":["trace[813328919] 'agreement among raft nodes before linearized reading' (duration: 344.226163ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:21:58.903438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.123403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-01T06:21:58.903533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T06:21:58.559037Z","time spent":"344.464017ms","remote":"127.0.0.1:35048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 "} {"level":"info","ts":"2026-10-01T06:21:58.90353Z","caller":"traceutil/trace.go:171","msg":"trace[1225182085] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:585; }","duration":"344.297545ms","start":"2026-10-01T06:21:58.559212Z","end":"2026-10-01T06:21:58.903509Z","steps":["trace[1225182085] 'agreement among raft nodes before linearized reading' (duration: 344.136053ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:21:58.903578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T06:21:58.55918Z","time spent":"344.388266ms","remote":"127.0.0.1:35048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-10-01T06:21:58.903936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.602756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:21:58.903986Z","caller":"traceutil/trace.go:171","msg":"trace[199741811] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:585; }","duration":"205.674128ms","start":"2026-10-01T06:21:58.698298Z","end":"2026-10-01T06:21:58.903972Z","steps":["trace[199741811] 'agreement among raft nodes before linearized reading' (duration: 205.594077ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:21:58.904078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.19541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:21:58.904118Z","caller":"traceutil/trace.go:171","msg":"trace[421094529] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:585; }","duration":"255.251651ms","start":"2026-10-01T06:21:58.648855Z","end":"2026-10-01T06:21:58.904106Z","steps":["trace[421094529] 'agreement among raft nodes before linearized reading' (duration: 255.18741ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:21:58.904316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.254849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:21:58.904357Z","caller":"traceutil/trace.go:171","msg":"trace[593084739] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:585; }","duration":"326.35975ms","start":"2026-10-01T06:21:58.577987Z","end":"2026-10-01T06:21:58.904346Z","steps":["trace[593084739] 'agreement among raft nodes before linearized reading' (duration: 326.29641ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:21:58.904389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T06:21:58.577966Z","time spent":"326.413341ms","remote":"127.0.0.1:35056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"warn","ts":"2026-10-01T06:21:58.904293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.109577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:21:58.904447Z","caller":"traceutil/trace.go:171","msg":"trace[1774796787] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:585; }","duration":"326.283169ms","start":"2026-10-01T06:21:58.578157Z","end":"2026-10-01T06:21:58.90444Z","steps":["trace[1774796787] 'agreement among raft nodes before linearized reading' (duration: 326.114577ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:21:58.904468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T06:21:58.57815Z","time spent":"326.31089ms","remote":"127.0.0.1:35056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-10-01T06:21:58.904468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.958412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:21:58.904515Z","caller":"traceutil/trace.go:171","msg":"trace[1811812914] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:585; }","duration":"114.018712ms","start":"2026-10-01T06:21:58.790483Z","end":"2026-10-01T06:21:58.904501Z","steps":["trace[1811812914] 'agreement among raft nodes before linearized reading' (duration: 113.940011ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:21:58.904619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.811301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:21:58.904708Z","caller":"traceutil/trace.go:171","msg":"trace[2124725155] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:585; }","duration":"344.852891ms","start":"2026-10-01T06:21:58.559796Z","end":"2026-10-01T06:21:58.904649Z","steps":["trace[2124725155] 'agreement among raft nodes before linearized reading' (duration: 344.78813ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:21:58.904741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T06:21:58.559782Z","time spent":"344.949433ms","remote":"127.0.0.1:35048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 "} {"level":"warn","ts":"2026-10-01T06:21:58.904787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.64089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:21:58.904826Z","caller":"traceutil/trace.go:171","msg":"trace[1667235641] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:585; }","duration":"114.705761ms","start":"2026-10-01T06:21:58.790108Z","end":"2026-10-01T06:21:58.904813Z","steps":["trace[1667235641] 'agreement among raft nodes before linearized reading' (duration: 114.62236ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:21:58.905047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.926624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:21:58.905076Z","caller":"traceutil/trace.go:171","msg":"trace[1679501133] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:585; }","duration":"114.971234ms","start":"2026-10-01T06:21:58.790098Z","end":"2026-10-01T06:21:58.905069Z","steps":["trace[1679501133] 'agreement among raft nodes before linearized reading' (duration: 114.904724ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:21:58.905422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.983434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:21:58.9055Z","caller":"traceutil/trace.go:171","msg":"trace[1678832271] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:585; }","duration":"284.062685ms","start":"2026-10-01T06:21:58.621415Z","end":"2026-10-01T06:21:58.905478Z","steps":["trace[1678832271] 'agreement among raft nodes before linearized reading' (duration: 283.949364ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:21:58.905784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.096354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:21:58.905842Z","caller":"traceutil/trace.go:171","msg":"trace[920287292] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:585; }","duration":"257.202945ms","start":"2026-10-01T06:21:58.648626Z","end":"2026-10-01T06:21:58.905828Z","steps":["trace[920287292] 'agreement among raft nodes before linearized reading' (duration: 257.086253ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:21:58.905976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.312047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:21:58.906047Z","caller":"traceutil/trace.go:171","msg":"trace[2076222982] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:585; }","duration":"284.363768ms","start":"2026-10-01T06:21:58.621637Z","end":"2026-10-01T06:21:58.906Z","steps":["trace[2076222982] 'agreement among raft nodes before linearized reading' (duration: 284.302297ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:21:58.906244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.491134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:21:58.906331Z","caller":"traceutil/trace.go:171","msg":"trace[1250365845] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:585; }","duration":"327.608746ms","start":"2026-10-01T06:21:58.578703Z","end":"2026-10-01T06:21:58.906312Z","steps":["trace[1250365845] 'agreement among raft nodes before linearized reading' (duration: 327.266621ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:21:58.906383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T06:21:58.578693Z","time spent":"327.677996ms","remote":"127.0.0.1:35056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"warn","ts":"2026-10-01T06:21:58.906557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.812951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:21:58.90829Z","caller":"traceutil/trace.go:171","msg":"trace[2022902748] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:585; }","duration":"259.575013ms","start":"2026-10-01T06:21:58.648668Z","end":"2026-10-01T06:21:58.908243Z","steps":["trace[2022902748] 'agreement among raft nodes before linearized reading' (duration: 256.534257ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:22:48.25661Z","caller":"traceutil/trace.go:171","msg":"trace[1922610848] transaction","detail":"{read_only:false; response_revision:1167; number_of_response:1; }","duration":"219.394486ms","start":"2026-10-01T06:22:48.037192Z","end":"2026-10-01T06:22:48.256587Z","steps":["trace[1922610848] 'process raft request' (duration: 219.171663ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:23:15.162568Z","caller":"traceutil/trace.go:171","msg":"trace[1381720973] transaction","detail":"{read_only:false; response_revision:1344; number_of_response:1; }","duration":"186.162223ms","start":"2026-10-01T06:23:14.976378Z","end":"2026-10-01T06:23:15.162541Z","steps":["trace[1381720973] 'process raft request' (duration: 186.010701ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:23:22.995426Z","caller":"traceutil/trace.go:171","msg":"trace[516196549] transaction","detail":"{read_only:false; response_revision:1468; number_of_response:1; }","duration":"171.763672ms","start":"2026-10-01T06:23:22.823624Z","end":"2026-10-01T06:23:22.995388Z","steps":["trace[516196549] 'process raft request' (duration: 171.542579ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:23:50.868575Z","caller":"traceutil/trace.go:171","msg":"trace[156788716] transaction","detail":"{read_only:false; response_revision:1901; number_of_response:1; }","duration":"245.393058ms","start":"2026-10-01T06:23:50.623152Z","end":"2026-10-01T06:23:50.868545Z","steps":["trace[156788716] 'process raft request' (duration: 245.213736ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:23:50.868917Z","caller":"traceutil/trace.go:171","msg":"trace[988607179] linearizableReadLoop","detail":"{readStateIndex:1979; appliedIndex:1979; }","duration":"221.45752ms","start":"2026-10-01T06:23:50.647374Z","end":"2026-10-01T06:23:50.868832Z","steps":["trace[988607179] 'read index received' (duration: 221.43155ms)","trace[988607179] 'applied index is now lower than readState.Index' (duration: 21.57µs)"],"step_count":2} {"level":"warn","ts":"2026-10-01T06:23:50.869254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.859854ms","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-10-01T06:23:50.869346Z","caller":"traceutil/trace.go:171","msg":"trace[167255734] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1901; }","duration":"221.989097ms","start":"2026-10-01T06:23:50.647335Z","end":"2026-10-01T06:23:50.869324Z","steps":["trace[167255734] 'agreement among raft nodes before linearized reading' (duration: 221.668503ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:23:50.881995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.806844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:23:50.882123Z","caller":"traceutil/trace.go:171","msg":"trace[177360608] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1902; }","duration":"181.995716ms","start":"2026-10-01T06:23:50.700107Z","end":"2026-10-01T06:23:50.882102Z","steps":["trace[177360608] 'agreement among raft nodes before linearized reading' (duration: 181.731203ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:24:07.082991Z","caller":"traceutil/trace.go:171","msg":"trace[1661617324] transaction","detail":"{read_only:false; response_revision:2032; number_of_response:1; }","duration":"158.640914ms","start":"2026-10-01T06:24:06.92432Z","end":"2026-10-01T06:24:07.082961Z","steps":["trace[1661617324] 'process raft request' (duration: 158.398231ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:24:07.08481Z","caller":"traceutil/trace.go:171","msg":"trace[235046803] linearizableReadLoop","detail":"{readStateIndex:2116; appliedIndex:2114; }","duration":"108.650305ms","start":"2026-10-01T06:24:06.976132Z","end":"2026-10-01T06:24:07.084782Z","steps":["trace[235046803] 'read index received' (duration: 106.629322ms)","trace[235046803] 'applied index is now lower than readState.Index' (duration: 2.019503ms)"],"step_count":2} {"level":"info","ts":"2026-10-01T06:24:07.084899Z","caller":"traceutil/trace.go:171","msg":"trace[926478563] transaction","detail":"{read_only:false; response_revision:2033; number_of_response:1; }","duration":"127.070391ms","start":"2026-10-01T06:24:06.957794Z","end":"2026-10-01T06:24:07.084864Z","steps":["trace[926478563] 'process raft request' (duration: 126.845888ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:24:07.085115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.962708ms","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-10-01T06:24:07.085177Z","caller":"traceutil/trace.go:171","msg":"trace[1058973498] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2033; }","duration":"109.10931ms","start":"2026-10-01T06:24:06.976053Z","end":"2026-10-01T06:24:07.085162Z","steps":["trace[1058973498] 'agreement among raft nodes before linearized reading' (duration: 108.882358ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:24:36.556483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.11547ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-10-01T06:24:42.421378Z","caller":"traceutil/trace.go:171","msg":"trace[301126477] transaction","detail":"{read_only:false; response_revision:2234; number_of_response:1; }","duration":"107.990609ms","start":"2026-10-01T06:24:42.31336Z","end":"2026-10-01T06:24:42.421351Z","steps":["trace[301126477] 'process raft request' (duration: 107.835074ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:24:43.215585Z","caller":"traceutil/trace.go:171","msg":"trace[628483959] transaction","detail":"{read_only:false; response_revision:2235; number_of_response:1; }","duration":"112.749561ms","start":"2026-10-01T06:24:43.1028Z","end":"2026-10-01T06:24:43.21555Z","steps":["trace[628483959] 'process raft request' (duration: 112.626059ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:24:49.579695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.389901ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-01T06:24:49.579824Z","caller":"traceutil/trace.go:171","msg":"trace[319204362] linearizableReadLoop","detail":"{readStateIndex:2363; appliedIndex:2362; }","duration":"114.45924ms","start":"2026-10-01T06:24:49.465345Z","end":"2026-10-01T06:24:49.579804Z","steps":["trace[319204362] 'read index received' (duration: 32.621µs)","trace[319204362] 'applied index is now lower than readState.Index' (duration: 114.425259ms)"],"step_count":2} {"level":"info","ts":"2026-10-01T06:24:49.579914Z","caller":"traceutil/trace.go:171","msg":"trace[147014835] transaction","detail":"{read_only:false; response_revision:2271; number_of_response:1; }","duration":"171.718867ms","start":"2026-10-01T06:24:49.408184Z","end":"2026-10-01T06:24:49.579903Z","steps":["trace[147014835] 'process raft request' (duration: 42.019278ms)","trace[147014835] 'compare' (duration: 129.128643ms)"],"step_count":2} {"level":"warn","ts":"2026-10-01T06:24:49.580122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.760348ms","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-10-01T06:24:49.580197Z","caller":"traceutil/trace.go:171","msg":"trace[1591326710] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2271; }","duration":"114.859451ms","start":"2026-10-01T06:24:49.465316Z","end":"2026-10-01T06:24:49.580176Z","steps":["trace[1591326710] 'agreement among raft nodes before linearized reading' (duration: 114.658876ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:26:44.814595Z","caller":"traceutil/trace.go:171","msg":"trace[1567766872] linearizableReadLoop","detail":"{readStateIndex:3199; appliedIndex:3198; }","duration":"132.201501ms","start":"2026-10-01T06:26:44.68237Z","end":"2026-10-01T06:26:44.814571Z","steps":["trace[1567766872] 'read index received' (duration: 107.536545ms)","trace[1567766872] 'applied index is now lower than readState.Index' (duration: 24.663916ms)"],"step_count":2} {"level":"info","ts":"2026-10-01T06:26:44.814695Z","caller":"traceutil/trace.go:171","msg":"trace[906926440] transaction","detail":"{read_only:false; response_revision:3076; number_of_response:1; }","duration":"153.164527ms","start":"2026-10-01T06:26:44.661498Z","end":"2026-10-01T06:26:44.814663Z","steps":["trace[906926440] 'process raft request' (duration: 128.461631ms)","trace[906926440] 'compare' (duration: 24.534382ms)"],"step_count":2} {"level":"warn","ts":"2026-10-01T06:26:44.814752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.547539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:26:44.81479Z","caller":"traceutil/trace.go:171","msg":"trace[1564470088] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3076; }","duration":"115.633822ms","start":"2026-10-01T06:26:44.699143Z","end":"2026-10-01T06:26:44.814777Z","steps":["trace[1564470088] 'agreement among raft nodes before linearized reading' (duration: 115.56719ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:26:44.814819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.438996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-10-01T06:26:44.814889Z","caller":"traceutil/trace.go:171","msg":"trace[189671008] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3076; }","duration":"132.539859ms","start":"2026-10-01T06:26:44.682331Z","end":"2026-10-01T06:26:44.814871Z","steps":["trace[189671008] 'agreement among raft nodes before linearized reading' (duration: 132.365065ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:26:50.498413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.322563ms","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-10-01T06:26:50.498519Z","caller":"traceutil/trace.go:171","msg":"trace[1537227782] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3107; }","duration":"103.482256ms","start":"2026-10-01T06:26:50.394995Z","end":"2026-10-01T06:26:50.498477Z","steps":["trace[1537227782] 'range keys from in-memory index tree' (duration: 103.139029ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:26:50.745961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.762539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-01T06:26:50.746051Z","caller":"traceutil/trace.go:171","msg":"trace[710799439] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:3108; }","duration":"140.904942ms","start":"2026-10-01T06:26:50.605132Z","end":"2026-10-01T06:26:50.746037Z","steps":["trace[710799439] 'count revisions from in-memory index tree' (duration: 140.672487ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:30:06.994996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.415069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:30:06.995129Z","caller":"traceutil/trace.go:171","msg":"trace[450735742] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4339; }","duration":"138.565661ms","start":"2026-10-01T06:30:06.856544Z","end":"2026-10-01T06:30:06.995109Z","steps":["trace[450735742] 'range keys from in-memory index tree' (duration: 138.312886ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:31:17.516698Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2905} {"level":"info","ts":"2026-10-01T06:31:17.612755Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2905,"took":"94.76653ms","hash":2739219542,"current-db-size-bytes":43540480,"current-db-size":"44 MB","current-db-size-in-use-bytes":18513920,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-10-01T06:31:17.61283Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2739219542,"revision":2905,"compact-revision":-1} {"level":"info","ts":"2026-10-01T06:31:39.147156Z","caller":"traceutil/trace.go:171","msg":"trace[1120450595] linearizableReadLoop","detail":"{readStateIndex:5615; appliedIndex:5614; }","duration":"120.953365ms","start":"2026-10-01T06:31:39.026178Z","end":"2026-10-01T06:31:39.147132Z","steps":["trace[1120450595] 'read index received' (duration: 120.799982ms)","trace[1120450595] 'applied index is now lower than readState.Index' (duration: 151.893µs)"],"step_count":2} {"level":"info","ts":"2026-10-01T06:31:39.14736Z","caller":"traceutil/trace.go:171","msg":"trace[1347874936] transaction","detail":"{read_only:false; response_revision:5402; number_of_response:1; }","duration":"170.75741ms","start":"2026-10-01T06:31:38.976573Z","end":"2026-10-01T06:31:39.147331Z","steps":["trace[1347874936] 'process raft request' (duration: 170.359644ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:31:39.147486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.167453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"warn","ts":"2026-10-01T06:31:39.147541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.274687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fa528e1b-8513-42de-b03a-55f40abc0302\" ","response":"range_response_count:1 size:4050"} {"level":"info","ts":"2026-10-01T06:31:39.147581Z","caller":"traceutil/trace.go:171","msg":"trace[477985376] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5402; }","duration":"172.283365ms","start":"2026-10-01T06:31:38.975272Z","end":"2026-10-01T06:31:39.147556Z","steps":["trace[477985376] 'agreement among raft nodes before linearized reading' (duration: 172.00695ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:31:39.147626Z","caller":"traceutil/trace.go:171","msg":"trace[1292130055] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fa528e1b-8513-42de-b03a-55f40abc0302; range_end:; response_count:1; response_revision:5402; }","duration":"176.414948ms","start":"2026-10-01T06:31:38.971192Z","end":"2026-10-01T06:31:39.147607Z","steps":["trace[1292130055] 'agreement among raft nodes before linearized reading' (duration: 176.160854ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:31:39.151049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.181094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/monitoring/loki-gateway\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:31:39.151147Z","caller":"traceutil/trace.go:171","msg":"trace[65242579] range","detail":"{range_begin:/registry/deployments/monitoring/loki-gateway; range_end:; response_count:0; response_revision:5404; }","duration":"122.53826ms","start":"2026-10-01T06:31:39.028589Z","end":"2026-10-01T06:31:39.151128Z","steps":["trace[65242579] 'agreement among raft nodes before linearized reading' (duration: 122.013031ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:31:40.752332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.236621ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-01T06:31:40.752435Z","caller":"traceutil/trace.go:171","msg":"trace[1220251105] linearizableReadLoop","detail":"{readStateIndex:5746; appliedIndex:5745; }","duration":"163.353613ms","start":"2026-10-01T06:31:40.589066Z","end":"2026-10-01T06:31:40.75242Z","steps":["trace[1220251105] 'read index received' (duration: 57.001µs)","trace[1220251105] 'applied index is now lower than readState.Index' (duration: 163.295242ms)"],"step_count":2} {"level":"info","ts":"2026-10-01T06:31:40.752493Z","caller":"traceutil/trace.go:171","msg":"trace[123562592] transaction","detail":"{read_only:false; response_revision:5530; number_of_response:1; }","duration":"261.900518ms","start":"2026-10-01T06:31:40.490557Z","end":"2026-10-01T06:31:40.752457Z","steps":["trace[123562592] 'process raft request' (duration: 91.445413ms)","trace[123562592] 'compare' (duration: 169.918236ms)"],"step_count":2} {"level":"warn","ts":"2026-10-01T06:31:40.752606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.545056ms","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-10-01T06:31:40.752637Z","caller":"traceutil/trace.go:171","msg":"trace[1017408719] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5530; }","duration":"163.574807ms","start":"2026-10-01T06:31:40.589052Z","end":"2026-10-01T06:31:40.752627Z","steps":["trace[1017408719] 'agreement among raft nodes before linearized reading' (duration: 163.442504ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:31:42.229916Z","caller":"traceutil/trace.go:171","msg":"trace[1492842148] transaction","detail":"{read_only:false; response_revision:5551; number_of_response:1; }","duration":"103.349687ms","start":"2026-10-01T06:31:42.126546Z","end":"2026-10-01T06:31:42.229896Z","steps":["trace[1492842148] 'process raft request' (duration: 103.200015ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:31:51.347072Z","caller":"traceutil/trace.go:171","msg":"trace[1697117354] transaction","detail":"{read_only:false; response_revision:5707; number_of_response:1; }","duration":"116.087273ms","start":"2026-10-01T06:31:51.230872Z","end":"2026-10-01T06:31:51.34696Z","steps":["trace[1697117354] 'process raft request' (duration: 115.92699ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:31:51.403199Z","caller":"traceutil/trace.go:171","msg":"trace[1009866127] transaction","detail":"{read_only:false; response_revision:5708; number_of_response:1; }","duration":"166.615613ms","start":"2026-10-01T06:31:51.23656Z","end":"2026-10-01T06:31:51.403175Z","steps":["trace[1009866127] 'process raft request' (duration: 166.37481ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:31:51.403451Z","caller":"traceutil/trace.go:171","msg":"trace[2023857189] transaction","detail":"{read_only:false; response_revision:5709; number_of_response:1; }","duration":"159.328372ms","start":"2026-10-01T06:31:51.244109Z","end":"2026-10-01T06:31:51.403437Z","steps":["trace[2023857189] 'process raft request' (duration: 159.014007ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:31:51.403881Z","caller":"traceutil/trace.go:171","msg":"trace[1779973606] linearizableReadLoop","detail":"{readStateIndex:5935; appliedIndex:5930; }","duration":"138.343047ms","start":"2026-10-01T06:31:51.265523Z","end":"2026-10-01T06:31:51.403866Z","steps":["trace[1779973606] 'read index received' (duration: 81.400047ms)","trace[1779973606] 'applied index is now lower than readState.Index' (duration: 56.94199ms)"],"step_count":2} {"level":"info","ts":"2026-10-01T06:31:51.403947Z","caller":"traceutil/trace.go:171","msg":"trace[244474293] transaction","detail":"{read_only:false; response_revision:5711; number_of_response:1; }","duration":"150.046008ms","start":"2026-10-01T06:31:51.253873Z","end":"2026-10-01T06:31:51.403919Z","steps":["trace[244474293] 'process raft request' (duration: 149.873185ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:31:51.403996Z","caller":"traceutil/trace.go:171","msg":"trace[300763021] transaction","detail":"{read_only:false; response_revision:5710; number_of_response:1; }","duration":"156.147152ms","start":"2026-10-01T06:31:51.247828Z","end":"2026-10-01T06:31:51.403976Z","steps":["trace[300763021] 'process raft request' (duration: 155.565823ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:31:51.404183Z","caller":"traceutil/trace.go:171","msg":"trace[1684115039] transaction","detail":"{read_only:false; response_revision:5712; number_of_response:1; }","duration":"127.253926ms","start":"2026-10-01T06:31:51.276919Z","end":"2026-10-01T06:31:51.404172Z","steps":["trace[1684115039] 'process raft request' (duration: 126.905461ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:31:51.40459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.020968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/prometheus-pushgateway\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:31:51.404671Z","caller":"traceutil/trace.go:171","msg":"trace[256876554] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/prometheus-pushgateway; range_end:; response_count:0; response_revision:5712; }","duration":"139.178941ms","start":"2026-10-01T06:31:51.265471Z","end":"2026-10-01T06:31:51.40465Z","steps":["trace[256876554] 'agreement among raft nodes before linearized reading' (duration: 139.020528ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:31:51.817838Z","caller":"traceutil/trace.go:171","msg":"trace[1021801755] transaction","detail":"{read_only:false; response_revision:5726; number_of_response:1; }","duration":"109.237878ms","start":"2026-10-01T06:31:51.708572Z","end":"2026-10-01T06:31:51.81781Z","steps":["trace[1021801755] 'process raft request' (duration: 109.010404ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:31:51.817965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.986521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-10-01T06:31:51.818096Z","caller":"traceutil/trace.go:171","msg":"trace[561627000] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:5726; }","duration":"114.155303ms","start":"2026-10-01T06:31:51.703921Z","end":"2026-10-01T06:31:51.818077Z","steps":["trace[561627000] 'agreement among raft nodes before linearized reading' (duration: 113.880109ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:31:51.856421Z","caller":"traceutil/trace.go:171","msg":"trace[1434804350] transaction","detail":"{read_only:false; response_revision:5727; number_of_response:1; }","duration":"112.894343ms","start":"2026-10-01T06:31:51.743482Z","end":"2026-10-01T06:31:51.856376Z","steps":["trace[1434804350] 'process raft request' (duration: 112.626319ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:31:51.856497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.706043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:31:51.857129Z","caller":"traceutil/trace.go:171","msg":"trace[819208509] transaction","detail":"{read_only:false; response_revision:5728; number_of_response:1; }","duration":"110.67806ms","start":"2026-10-01T06:31:51.746414Z","end":"2026-10-01T06:31:51.857092Z","steps":["trace[819208509] 'process raft request' (duration: 109.833386ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:31:51.856761Z","caller":"traceutil/trace.go:171","msg":"trace[1535254615] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5728; }","duration":"116.810804ms","start":"2026-10-01T06:31:51.739725Z","end":"2026-10-01T06:31:51.856536Z","steps":["trace[1535254615] 'agreement among raft nodes before linearized reading' (duration: 116.594551ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:31:51.857554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.068247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/monitoring/\" range_end:\"/registry/limitranges/monitoring0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:31:51.857645Z","caller":"traceutil/trace.go:171","msg":"trace[1277919041] range","detail":"{range_begin:/registry/limitranges/monitoring/; range_end:/registry/limitranges/monitoring0; response_count:0; response_revision:5728; }","duration":"111.166398ms","start":"2026-10-01T06:31:51.746456Z","end":"2026-10-01T06:31:51.857622Z","steps":["trace[1277919041] 'agreement among raft nodes before linearized reading' (duration: 110.368056ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:31:52.021984Z","caller":"traceutil/trace.go:171","msg":"trace[1193007201] linearizableReadLoop","detail":"{readStateIndex:5954; appliedIndex:5953; }","duration":"155.463991ms","start":"2026-10-01T06:31:51.866492Z","end":"2026-10-01T06:31:52.021956Z","steps":["trace[1193007201] 'read index received' (duration: 153.768686ms)","trace[1193007201] 'applied index is now lower than readState.Index' (duration: 1.694015ms)"],"step_count":2} {"level":"info","ts":"2026-10-01T06:31:52.022102Z","caller":"traceutil/trace.go:171","msg":"trace[663945364] transaction","detail":"{read_only:false; response_revision:5729; number_of_response:1; }","duration":"161.110908ms","start":"2026-10-01T06:31:51.860957Z","end":"2026-10-01T06:31:52.022068Z","steps":["trace[663945364] 'process raft request' (duration: 159.389652ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:31:52.022488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.976459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/monitoring/prometheus-pushgateway\" ","response":"range_response_count:1 size:3758"} {"level":"info","ts":"2026-10-01T06:31:52.022591Z","caller":"traceutil/trace.go:171","msg":"trace[1048008830] range","detail":"{range_begin:/registry/deployments/monitoring/prometheus-pushgateway; range_end:; response_count:1; response_revision:5729; }","duration":"156.125671ms","start":"2026-10-01T06:31:51.866441Z","end":"2026-10-01T06:31:52.022566Z","steps":["trace[1048008830] 'agreement among raft nodes before linearized reading' (duration: 155.807536ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:32:00.629737Z","caller":"traceutil/trace.go:171","msg":"trace[1341425217] transaction","detail":"{read_only:false; response_revision:5858; number_of_response:1; }","duration":"272.073586ms","start":"2026-10-01T06:32:00.357606Z","end":"2026-10-01T06:32:00.629679Z","steps":["trace[1341425217] 'process raft request' (duration: 271.867323ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:32:00.89944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.141153ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-01T06:32:00.899571Z","caller":"traceutil/trace.go:171","msg":"trace[693132296] transaction","detail":"{read_only:false; response_revision:5859; number_of_response:1; }","duration":"261.925192ms","start":"2026-10-01T06:32:00.63762Z","end":"2026-10-01T06:32:00.899546Z","steps":["trace[693132296] 'process raft request' (duration: 72.585985ms)","trace[693132296] 'compare' (duration: 188.607955ms)"],"step_count":2} {"level":"info","ts":"2026-10-01T06:32:00.940485Z","caller":"traceutil/trace.go:171","msg":"trace[1769174360] transaction","detail":"{read_only:false; response_revision:5860; number_of_response:1; }","duration":"302.501005ms","start":"2026-10-01T06:32:00.637952Z","end":"2026-10-01T06:32:00.940453Z","steps":["trace[1769174360] 'process raft request' (duration: 302.15791ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:32:00.940587Z","caller":"traceutil/trace.go:171","msg":"trace[1378912020] transaction","detail":"{read_only:false; response_revision:5861; number_of_response:1; }","duration":"302.084278ms","start":"2026-10-01T06:32:00.638482Z","end":"2026-10-01T06:32:00.940566Z","steps":["trace[1378912020] 'process raft request' (duration: 301.823594ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:32:00.940642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T06:32:00.637931Z","time spent":"302.628917ms","remote":"127.0.0.1:45238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-01T06:32:00.94062Z","caller":"traceutil/trace.go:171","msg":"trace[1328821372] transaction","detail":"{read_only:false; response_revision:5862; number_of_response:1; }","duration":"299.941985ms","start":"2026-10-01T06:32:00.640646Z","end":"2026-10-01T06:32:00.940588Z","steps":["trace[1328821372] 'process raft request' (duration: 299.750342ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:32:00.940698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T06:32:00.638467Z","time spent":"302.17465ms","remote":"127.0.0.1:45138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":681,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-01T06:32:00.940747Z","caller":"traceutil/trace.go:171","msg":"trace[520743997] linearizableReadLoop","detail":"{readStateIndex:6090; appliedIndex:6085; }","duration":"240.236719ms","start":"2026-10-01T06:32:00.700494Z","end":"2026-10-01T06:32:00.94073Z","steps":["trace[520743997] 'read index received' (duration: 9.804211ms)","trace[520743997] 'applied index is now lower than readState.Index' (duration: 230.431378ms)"],"step_count":2} {"level":"info","ts":"2026-10-01T06:32:00.940835Z","caller":"traceutil/trace.go:171","msg":"trace[1753090617] transaction","detail":"{read_only:false; response_revision:5863; number_of_response:1; }","duration":"295.917223ms","start":"2026-10-01T06:32:00.644909Z","end":"2026-10-01T06:32:00.940826Z","steps":["trace[1753090617] 'process raft request' (duration: 295.596198ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:32:00.940954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.468802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:32:00.941088Z","caller":"traceutil/trace.go:171","msg":"trace[1945906633] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5863; }","duration":"240.538594ms","start":"2026-10-01T06:32:00.700436Z","end":"2026-10-01T06:32:00.940975Z","steps":["trace[1945906633] 'agreement among raft nodes before linearized reading' (duration: 240.479583ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:32:00.941447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T06:32:00.64063Z","time spent":"300.717457ms","remote":"127.0.0.1:45036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":130809,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-01T06:32:18.971863Z","caller":"traceutil/trace.go:171","msg":"trace[1117963530] linearizableReadLoop","detail":"{readStateIndex:6362; appliedIndex:6361; }","duration":"272.668998ms","start":"2026-10-01T06:32:18.699174Z","end":"2026-10-01T06:32:18.971843Z","steps":["trace[1117963530] 'read index received' (duration: 272.468336ms)","trace[1117963530] 'applied index is now lower than readState.Index' (duration: 199.742µs)"],"step_count":2} {"level":"info","ts":"2026-10-01T06:32:18.972205Z","caller":"traceutil/trace.go:171","msg":"trace[623725924] transaction","detail":"{read_only:false; response_revision:6128; number_of_response:1; }","duration":"352.012683ms","start":"2026-10-01T06:32:18.62018Z","end":"2026-10-01T06:32:18.972193Z","steps":["trace[623725924] 'process raft request' (duration: 351.533806ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:32:18.97237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.168636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:32:18.97268Z","caller":"traceutil/trace.go:171","msg":"trace[687757932] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6128; }","duration":"273.48951ms","start":"2026-10-01T06:32:18.699142Z","end":"2026-10-01T06:32:18.972632Z","steps":["trace[687757932] 'agreement among raft nodes before linearized reading' (duration: 273.139625ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:32:18.972753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T06:32:18.620164Z","time spent":"352.48007ms","remote":"127.0.0.1:45152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3751,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-01T06:32:18.993119Z","caller":"traceutil/trace.go:171","msg":"trace[493589268] transaction","detail":"{read_only:false; response_revision:6129; number_of_response:1; }","duration":"234.461348ms","start":"2026-10-01T06:32:18.758635Z","end":"2026-10-01T06:32:18.993096Z","steps":["trace[493589268] 'process raft request' (duration: 234.257495ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:36:17.524358Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":4785} {"level":"info","ts":"2026-10-01T06:36:17.586937Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":4785,"took":"60.766293ms","hash":1972516689,"current-db-size-bytes":43540480,"current-db-size":"44 MB","current-db-size-in-use-bytes":38821888,"current-db-size-in-use":"39 MB"} {"level":"info","ts":"2026-10-01T06:36:17.587037Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1972516689,"revision":4785,"compact-revision":2905} {"level":"info","ts":"2026-10-01T06:38:47.087917Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002466.wal"} {"level":"info","ts":"2026-10-01T06:38:50.807552Z","caller":"traceutil/trace.go:171","msg":"trace[1371349091] linearizableReadLoop","detail":"{readStateIndex:9347; appliedIndex:9346; }","duration":"203.744605ms","start":"2026-10-01T06:38:50.603781Z","end":"2026-10-01T06:38:50.807526Z","steps":["trace[1371349091] 'read index received' (duration: 203.525762ms)","trace[1371349091] 'applied index is now lower than readState.Index' (duration: 217.983µs)"],"step_count":2} {"level":"info","ts":"2026-10-01T06:38:50.807798Z","caller":"traceutil/trace.go:171","msg":"trace[1332239203] transaction","detail":"{read_only:false; response_revision:9020; number_of_response:1; }","duration":"257.181944ms","start":"2026-10-01T06:38:50.550584Z","end":"2026-10-01T06:38:50.807766Z","steps":["trace[1332239203] 'process raft request' (duration: 256.790709ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:38:50.808367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.721353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:38:50.808415Z","caller":"traceutil/trace.go:171","msg":"trace[818725404] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9020; }","duration":"108.804884ms","start":"2026-10-01T06:38:50.699591Z","end":"2026-10-01T06:38:50.808396Z","steps":["trace[818725404] 'agreement among raft nodes before linearized reading' (duration: 108.738984ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:38:50.807912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.070759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:38:50.808577Z","caller":"traceutil/trace.go:171","msg":"trace[21995572] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:9020; }","duration":"204.808889ms","start":"2026-10-01T06:38:50.603747Z","end":"2026-10-01T06:38:50.808555Z","steps":["trace[21995572] 'agreement among raft nodes before linearized reading' (duration: 204.018198ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:38:51.078138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.030643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.113\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-10-01T06:38:51.078219Z","caller":"traceutil/trace.go:171","msg":"trace[1411937290] range","detail":"{range_begin:/registry/masterleases/162.253.55.113; range_end:; response_count:1; response_revision:9020; }","duration":"132.210445ms","start":"2026-10-01T06:38:50.945992Z","end":"2026-10-01T06:38:51.078203Z","steps":["trace[1411937290] 'range keys from in-memory index tree' (duration: 131.82802ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:39:03.480266Z","caller":"traceutil/trace.go:171","msg":"trace[2027310683] transaction","detail":"{read_only:false; response_revision:9085; number_of_response:1; }","duration":"308.138032ms","start":"2026-10-01T06:39:03.172095Z","end":"2026-10-01T06:39:03.480233Z","steps":["trace[2027310683] 'process raft request' (duration: 307.893948ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:39:03.480486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T06:39:03.172066Z","time spent":"308.301395ms","remote":"127.0.0.1:45238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-01T06:39:03.592884Z","caller":"traceutil/trace.go:171","msg":"trace[842498470] transaction","detail":"{read_only:false; response_revision:9086; number_of_response:1; }","duration":"415.316231ms","start":"2026-10-01T06:39:03.177538Z","end":"2026-10-01T06:39:03.592854Z","steps":["trace[842498470] 'process raft request' (duration: 415.057447ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:39:03.593124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T06:39:03.177496Z","time spent":"415.484534ms","remote":"127.0.0.1:45238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-01T06:39:03.593298Z","caller":"traceutil/trace.go:171","msg":"trace[1923065770] transaction","detail":"{read_only:false; response_revision:9088; number_of_response:1; }","duration":"283.788789ms","start":"2026-10-01T06:39:03.309495Z","end":"2026-10-01T06:39:03.593284Z","steps":["trace[1923065770] 'process raft request' (duration: 283.589336ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:39:03.593345Z","caller":"traceutil/trace.go:171","msg":"trace[1919615382] transaction","detail":"{read_only:false; response_revision:9089; number_of_response:1; }","duration":"270.97679ms","start":"2026-10-01T06:39:03.322323Z","end":"2026-10-01T06:39:03.5933Z","steps":["trace[1919615382] 'process raft request' (duration: 270.879529ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:39:03.593277Z","caller":"traceutil/trace.go:171","msg":"trace[1680035015] linearizableReadLoop","detail":"{readStateIndex:9419; appliedIndex:9414; }","duration":"230.595724ms","start":"2026-10-01T06:39:03.362658Z","end":"2026-10-01T06:39:03.593254Z","steps":["trace[1680035015] 'read index received' (duration: 117.366605ms)","trace[1680035015] 'applied index is now lower than readState.Index' (duration: 113.227909ms)"],"step_count":2} {"level":"warn","ts":"2026-10-01T06:39:03.593486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.809097ms","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-10-01T06:39:03.59355Z","caller":"traceutil/trace.go:171","msg":"trace[453307762] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9089; }","duration":"230.902138ms","start":"2026-10-01T06:39:03.362636Z","end":"2026-10-01T06:39:03.593538Z","steps":["trace[453307762] 'agreement among raft nodes before linearized reading' (duration: 230.686925ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:39:03.593616Z","caller":"traceutil/trace.go:171","msg":"trace[1361691866] transaction","detail":"{read_only:false; response_revision:9087; number_of_response:1; }","duration":"315.717152ms","start":"2026-10-01T06:39:03.277871Z","end":"2026-10-01T06:39:03.593588Z","steps":["trace[1361691866] 'process raft request' (duration: 314.932211ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:39:03.593758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.646673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-10-01T06:39:03.593759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T06:39:03.277837Z","time spent":"315.840314ms","remote":"127.0.0.1:45238","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-10-01T06:39:03.593806Z","caller":"traceutil/trace.go:171","msg":"trace[9812852] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9089; }","duration":"149.717234ms","start":"2026-10-01T06:39:03.44408Z","end":"2026-10-01T06:39:03.593797Z","steps":["trace[9812852] 'agreement among raft nodes before linearized reading' (duration: 149.599982ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:39:03.593816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.57014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-10-01T06:39:03.593873Z","caller":"traceutil/trace.go:171","msg":"trace[1309612489] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9089; }","duration":"158.679892ms","start":"2026-10-01T06:39:03.435176Z","end":"2026-10-01T06:39:03.593856Z","steps":["trace[1309612489] 'agreement among raft nodes before linearized reading' (duration: 158.475309ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:39:05.168053Z","caller":"traceutil/trace.go:171","msg":"trace[724688846] linearizableReadLoop","detail":"{readStateIndex:9426; appliedIndex:9425; }","duration":"219.125633ms","start":"2026-10-01T06:39:04.948879Z","end":"2026-10-01T06:39:05.168005Z","steps":["trace[724688846] 'read index received' (duration: 218.979691ms)","trace[724688846] 'applied index is now lower than readState.Index' (duration: 144.922µs)"],"step_count":2} {"level":"info","ts":"2026-10-01T06:39:05.168132Z","caller":"traceutil/trace.go:171","msg":"trace[1613976911] transaction","detail":"{read_only:false; response_revision:9096; number_of_response:1; }","duration":"221.613115ms","start":"2026-10-01T06:39:04.946481Z","end":"2026-10-01T06:39:05.168094Z","steps":["trace[1613976911] 'process raft request' (duration: 221.372372ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:39:05.168258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.366656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-qfg57\" ","response":"range_response_count:1 size:6451"} {"level":"info","ts":"2026-10-01T06:39:05.16829Z","caller":"traceutil/trace.go:171","msg":"trace[213355256] range","detail":"{range_begin:/registry/pods/openstack/keepalived-qfg57; range_end:; response_count:1; response_revision:9096; }","duration":"219.450096ms","start":"2026-10-01T06:39:04.94883Z","end":"2026-10-01T06:39:05.16828Z","steps":["trace[213355256] 'agreement among raft nodes before linearized reading' (duration: 219.297664ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:39:05.721459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.620502ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-01T06:39:05.721581Z","caller":"traceutil/trace.go:171","msg":"trace[811868677] transaction","detail":"{read_only:false; response_revision:9098; number_of_response:1; }","duration":"122.952718ms","start":"2026-10-01T06:39:05.598609Z","end":"2026-10-01T06:39:05.721562Z","steps":["trace[811868677] 'process raft request' (duration: 16.171304ms)","trace[811868677] 'compare' (duration: 106.375439ms)"],"step_count":2} {"level":"info","ts":"2026-10-01T06:39:05.725246Z","caller":"traceutil/trace.go:171","msg":"trace[1625918495] linearizableReadLoop","detail":"{readStateIndex:9431; appliedIndex:9428; }","duration":"110.112198ms","start":"2026-10-01T06:39:05.615124Z","end":"2026-10-01T06:39:05.725236Z","steps":["trace[1625918495] 'read index received' (duration: 109.973107ms)","trace[1625918495] 'applied index is now lower than readState.Index' (duration: 138.591µs)"],"step_count":2} {"level":"info","ts":"2026-10-01T06:39:05.725413Z","caller":"traceutil/trace.go:171","msg":"trace[1557256333] transaction","detail":"{read_only:false; response_revision:9099; number_of_response:1; }","duration":"126.269903ms","start":"2026-10-01T06:39:05.599136Z","end":"2026-10-01T06:39:05.725406Z","steps":["trace[1557256333] 'process raft request' (duration: 125.999699ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:39:05.725529Z","caller":"traceutil/trace.go:171","msg":"trace[2135573601] transaction","detail":"{read_only:false; response_revision:9100; number_of_response:1; }","duration":"126.082969ms","start":"2026-10-01T06:39:05.599435Z","end":"2026-10-01T06:39:05.725518Z","steps":["trace[2135573601] 'process raft request' (duration: 125.750695ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:39:05.725623Z","caller":"traceutil/trace.go:171","msg":"trace[1066274191] transaction","detail":"{read_only:false; response_revision:9101; number_of_response:1; }","duration":"125.730036ms","start":"2026-10-01T06:39:05.599887Z","end":"2026-10-01T06:39:05.725617Z","steps":["trace[1066274191] 'process raft request' (duration: 125.32447ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:39:05.725796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.676495ms","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-10-01T06:39:05.725825Z","caller":"traceutil/trace.go:171","msg":"trace[915982053] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9101; }","duration":"110.742666ms","start":"2026-10-01T06:39:05.615075Z","end":"2026-10-01T06:39:05.725817Z","steps":["trace[915982053] 'agreement among raft nodes before linearized reading' (duration: 110.628495ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:39:05.725956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.995537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-10-01T06:39:05.725977Z","caller":"traceutil/trace.go:171","msg":"trace[1598623891] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9101; }","duration":"101.043318ms","start":"2026-10-01T06:39:05.624925Z","end":"2026-10-01T06:39:05.725969Z","steps":["trace[1598623891] 'agreement among raft nodes before linearized reading' (duration: 100.988228ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:39:05.726332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.284282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-10-01T06:39:05.72645Z","caller":"traceutil/trace.go:171","msg":"trace[194575685] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9101; }","duration":"101.440604ms","start":"2026-10-01T06:39:05.624982Z","end":"2026-10-01T06:39:05.726423Z","steps":["trace[194575685] 'agreement among raft nodes before linearized reading' (duration: 101.089569ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:39:36.391778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.133219ms","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-10-01T06:39:36.391904Z","caller":"traceutil/trace.go:171","msg":"trace[1739413285] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:9321; }","duration":"319.332592ms","start":"2026-10-01T06:39:36.072554Z","end":"2026-10-01T06:39:36.391886Z","steps":["trace[1739413285] 'count revisions from in-memory index tree' (duration: 319.050638ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:39:36.3919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.530264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-10-01T06:39:36.391947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T06:39:36.072536Z","time spent":"319.400802ms","remote":"127.0.0.1:45326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":64,"response size":30,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"info","ts":"2026-10-01T06:39:36.391973Z","caller":"traceutil/trace.go:171","msg":"trace[1661667664] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:9321; }","duration":"156.658956ms","start":"2026-10-01T06:39:36.235297Z","end":"2026-10-01T06:39:36.391956Z","steps":["trace[1661667664] 'count revisions from in-memory index tree' (duration: 156.404952ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:39:36.675314Z","caller":"traceutil/trace.go:171","msg":"trace[377368928] transaction","detail":"{read_only:false; response_revision:9322; number_of_response:1; }","duration":"302.360037ms","start":"2026-10-01T06:39:36.372909Z","end":"2026-10-01T06:39:36.675269Z","steps":["trace[377368928] 'process raft request' (duration: 300.860698ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:39:36.675494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T06:39:36.372873Z","time spent":"302.53105ms","remote":"127.0.0.1:40670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":450958,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-01T06:39:36.68312Z","caller":"traceutil/trace.go:171","msg":"trace[875759504] linearizableReadLoop","detail":"{readStateIndex:9662; appliedIndex:9660; }","duration":"138.861641ms","start":"2026-10-01T06:39:36.544236Z","end":"2026-10-01T06:39:36.683097Z","steps":["trace[875759504] 'read index received' (duration: 128.717087ms)","trace[875759504] 'applied index is now lower than readState.Index' (duration: 10.143334ms)"],"step_count":2} {"level":"warn","ts":"2026-10-01T06:39:36.683315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.075824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-10-01T06:39:36.683369Z","caller":"traceutil/trace.go:171","msg":"trace[191682923] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9322; }","duration":"139.159394ms","start":"2026-10-01T06:39:36.544197Z","end":"2026-10-01T06:39:36.683357Z","steps":["trace[191682923] 'agreement among raft nodes before linearized reading' (duration: 138.976502ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:39:47.917173Z","caller":"traceutil/trace.go:171","msg":"trace[619604197] transaction","detail":"{read_only:false; response_revision:9378; number_of_response:1; }","duration":"124.430159ms","start":"2026-10-01T06:39:47.792718Z","end":"2026-10-01T06:39:47.917148Z","steps":["trace[619604197] 'process raft request' (duration: 124.210856ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:40:17.147562Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"3b717bddf98d48e3","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-01T06:40:17.160986Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-01T06:40:17.161121Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-10-01T06:41:17.532067Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7813} {"level":"info","ts":"2026-10-01T06:41:17.64237Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7813,"took":"108.13914ms","hash":126203579,"current-db-size-bytes":43540480,"current-db-size":"44 MB","current-db-size-in-use-bytes":25534464,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-01T06:41:17.642454Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":126203579,"revision":7813,"compact-revision":4785} {"level":"info","ts":"2026-10-01T06:41:20.419527Z","caller":"traceutil/trace.go:171","msg":"trace[2116770424] transaction","detail":"{read_only:false; response_revision:10254; number_of_response:1; }","duration":"120.550687ms","start":"2026-10-01T06:41:20.298938Z","end":"2026-10-01T06:41:20.419489Z","steps":["trace[2116770424] 'process raft request' (duration: 120.323691ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:41:20.544904Z","caller":"traceutil/trace.go:171","msg":"trace[710162707] linearizableReadLoop","detail":"{readStateIndex:10625; appliedIndex:10621; }","duration":"152.55212ms","start":"2026-10-01T06:41:20.39233Z","end":"2026-10-01T06:41:20.544882Z","steps":["trace[710162707] 'read index received' (duration: 26.913388ms)","trace[710162707] 'applied index is now lower than readState.Index' (duration: 125.637782ms)"],"step_count":2} {"level":"info","ts":"2026-10-01T06:41:20.545195Z","caller":"traceutil/trace.go:171","msg":"trace[616204821] transaction","detail":"{read_only:false; response_revision:10257; number_of_response:1; }","duration":"228.671005ms","start":"2026-10-01T06:41:20.316476Z","end":"2026-10-01T06:41:20.545147Z","steps":["trace[616204821] 'process raft request' (duration: 228.368578ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:41:20.54528Z","caller":"traceutil/trace.go:171","msg":"trace[1509615366] transaction","detail":"{read_only:false; response_revision:10255; number_of_response:1; }","duration":"243.807134ms","start":"2026-10-01T06:41:20.301457Z","end":"2026-10-01T06:41:20.545265Z","steps":["trace[1509615366] 'process raft request' (duration: 243.197659ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:41:20.545427Z","caller":"traceutil/trace.go:171","msg":"trace[1646712004] transaction","detail":"{read_only:false; response_revision:10256; number_of_response:1; }","duration":"242.135089ms","start":"2026-10-01T06:41:20.303222Z","end":"2026-10-01T06:41:20.545357Z","steps":["trace[1646712004] 'process raft request' (duration: 241.581186ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:41:20.545451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.623511ms","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-10-01T06:41:20.545559Z","caller":"traceutil/trace.go:171","msg":"trace[1849736468] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:10257; }","duration":"103.790205ms","start":"2026-10-01T06:41:20.441744Z","end":"2026-10-01T06:41:20.545534Z","steps":["trace[1849736468] 'agreement among raft nodes before linearized reading' (duration: 103.477837ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:41:20.545626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.285019ms","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-10-01T06:41:20.54573Z","caller":"traceutil/trace.go:171","msg":"trace[368985013] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:10257; }","duration":"153.432283ms","start":"2026-10-01T06:41:20.392273Z","end":"2026-10-01T06:41:20.545705Z","steps":["trace[368985013] 'agreement among raft nodes before linearized reading' (duration: 153.139865ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:46:17.5399Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10241} {"level":"info","ts":"2026-10-01T06:46:17.630994Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10241,"took":"88.552581ms","hash":604516283,"current-db-size-bytes":43540480,"current-db-size":"44 MB","current-db-size-in-use-bytes":25075712,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-10-01T06:46:17.631121Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":604516283,"revision":10241,"compact-revision":7813} {"level":"info","ts":"2026-10-01T06:46:45.984606Z","caller":"traceutil/trace.go:171","msg":"trace[2073073961] linearizableReadLoop","detail":"{readStateIndex:13058; appliedIndex:13057; }","duration":"124.190826ms","start":"2026-10-01T06:46:45.860388Z","end":"2026-10-01T06:46:45.984579Z","steps":["trace[2073073961] 'read index received' (duration: 124.135405ms)","trace[2073073961] 'applied index is now lower than readState.Index' (duration: 54.151µs)"],"step_count":2} {"level":"warn","ts":"2026-10-01T06:46:45.984803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.38284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/servicemonitors/\" range_end:\"/registry/monitoring.coreos.com/servicemonitors0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-01T06:46:45.984772Z","caller":"traceutil/trace.go:171","msg":"trace[1439345854] transaction","detail":"{read_only:false; response_revision:12613; number_of_response:1; }","duration":"177.943717ms","start":"2026-10-01T06:46:45.80676Z","end":"2026-10-01T06:46:45.984704Z","steps":["trace[1439345854] 'process raft request' (duration: 177.654801ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:46:45.984846Z","caller":"traceutil/trace.go:171","msg":"trace[661673553] range","detail":"{range_begin:/registry/monitoring.coreos.com/servicemonitors/; range_end:/registry/monitoring.coreos.com/servicemonitors0; response_count:0; response_revision:12613; }","duration":"124.485002ms","start":"2026-10-01T06:46:45.860349Z","end":"2026-10-01T06:46:45.984834Z","steps":["trace[661673553] 'agreement among raft nodes before linearized reading' (duration: 124.337969ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:47:04.244612Z","caller":"traceutil/trace.go:171","msg":"trace[1796173834] transaction","detail":"{read_only:false; response_revision:12719; number_of_response:1; }","duration":"119.100384ms","start":"2026-10-01T06:47:04.12547Z","end":"2026-10-01T06:47:04.24457Z","steps":["trace[1796173834] 'process raft request' (duration: 67.464438ms)","trace[1796173834] 'compare' (duration: 51.504393ms)"],"step_count":2} {"level":"info","ts":"2026-10-01T06:47:06.311946Z","caller":"traceutil/trace.go:171","msg":"trace[1500558427] transaction","detail":"{read_only:false; response_revision:12727; number_of_response:1; }","duration":"245.278745ms","start":"2026-10-01T06:47:06.066645Z","end":"2026-10-01T06:47:06.311923Z","steps":["trace[1500558427] 'process raft request' (duration: 245.136652ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:47:06.481997Z","caller":"traceutil/trace.go:171","msg":"trace[108680612] transaction","detail":"{read_only:false; response_revision:12728; number_of_response:1; }","duration":"408.549047ms","start":"2026-10-01T06:47:06.07342Z","end":"2026-10-01T06:47:06.481969Z","steps":["trace[108680612] 'process raft request' (duration: 408.353953ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:47:06.482189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T06:47:06.073394Z","time spent":"408.710031ms","remote":"127.0.0.1:45238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-01T06:47:06.482331Z","caller":"traceutil/trace.go:171","msg":"trace[1095481569] linearizableReadLoop","detail":"{readStateIndex:13177; appliedIndex:13175; }","duration":"379.411073ms","start":"2026-10-01T06:47:06.102851Z","end":"2026-10-01T06:47:06.482262Z","steps":["trace[1095481569] 'read index received' (duration: 209.027245ms)","trace[1095481569] 'applied index is now lower than readState.Index' (duration: 170.378808ms)"],"step_count":2} {"level":"info","ts":"2026-10-01T06:47:06.482362Z","caller":"traceutil/trace.go:171","msg":"trace[442341283] transaction","detail":"{read_only:false; response_revision:12729; number_of_response:1; }","duration":"231.903783ms","start":"2026-10-01T06:47:06.250419Z","end":"2026-10-01T06:47:06.482323Z","steps":["trace[442341283] 'process raft request' (duration: 231.502515ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:47:06.482542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.689178ms","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-10-01T06:47:06.482586Z","caller":"traceutil/trace.go:171","msg":"trace[703919430] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:12729; }","duration":"379.76366ms","start":"2026-10-01T06:47:06.102809Z","end":"2026-10-01T06:47:06.482573Z","steps":["trace[703919430] 'agreement among raft nodes before linearized reading' (duration: 379.614827ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:47:06.482617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T06:47:06.102796Z","time spent":"379.814251ms","remote":"127.0.0.1:45238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-10-01T06:47:06.546155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.269222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:1 size:5004"} {"level":"info","ts":"2026-10-01T06:47:06.546218Z","caller":"traceutil/trace.go:171","msg":"trace[1171258476] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:12729; }","duration":"113.358904ms","start":"2026-10-01T06:47:06.432843Z","end":"2026-10-01T06:47:06.546202Z","steps":["trace[1171258476] 'agreement among raft nodes before linearized reading' (duration: 113.200741ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:47:06.54647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.048029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-01T06:47:06.546484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.410746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:47:06.546546Z","caller":"traceutil/trace.go:171","msg":"trace[41795734] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:12729; }","duration":"190.493658ms","start":"2026-10-01T06:47:06.356036Z","end":"2026-10-01T06:47:06.54653Z","steps":["trace[41795734] 'agreement among raft nodes before linearized reading' (duration: 190.391546ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:47:06.546549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.272623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-01T06:47:06.54657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.146601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:47:06.546594Z","caller":"traceutil/trace.go:171","msg":"trace[1066427823] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:12729; }","duration":"116.337855ms","start":"2026-10-01T06:47:06.430241Z","end":"2026-10-01T06:47:06.546579Z","steps":["trace[1066427823] 'agreement among raft nodes before linearized reading' (duration: 116.282094ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:47:06.546632Z","caller":"traceutil/trace.go:171","msg":"trace[705633066] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:12729; }","duration":"191.250574ms","start":"2026-10-01T06:47:06.355364Z","end":"2026-10-01T06:47:06.546614Z","steps":["trace[705633066] 'agreement among raft nodes before linearized reading' (duration: 191.118901ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:47:06.546484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.957827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-01T06:47:06.546678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.936117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/cinder-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-10-01T06:47:06.546753Z","caller":"traceutil/trace.go:171","msg":"trace[1132549228] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:12729; }","duration":"117.250243ms","start":"2026-10-01T06:47:06.429477Z","end":"2026-10-01T06:47:06.546727Z","steps":["trace[1132549228] 'agreement among raft nodes before linearized reading' (duration: 116.922877ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:47:06.54678Z","caller":"traceutil/trace.go:171","msg":"trace[532611527] range","detail":"{range_begin:/registry/services/endpoints/openstack/cinder-api; range_end:; response_count:1; response_revision:12729; }","duration":"191.067719ms","start":"2026-10-01T06:47:06.355689Z","end":"2026-10-01T06:47:06.546757Z","steps":["trace[532611527] 'agreement among raft nodes before linearized reading' (duration: 190.660521ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:47:06.546505Z","caller":"traceutil/trace.go:171","msg":"trace[1747437346] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:12729; }","duration":"191.127451ms","start":"2026-10-01T06:47:06.355369Z","end":"2026-10-01T06:47:06.546496Z","steps":["trace[1747437346] 'agreement among raft nodes before linearized reading' (duration: 191.07314ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:47:06.563416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.2226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-01T06:47:06.563476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.402562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:47:06.563503Z","caller":"traceutil/trace.go:171","msg":"trace[92839709] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:12730; }","duration":"134.367962ms","start":"2026-10-01T06:47:06.429112Z","end":"2026-10-01T06:47:06.56348Z","steps":["trace[92839709] 'agreement among raft nodes before linearized reading' (duration: 117.458348ms)","trace[92839709] 'range keys from in-memory index tree' (duration: 16.778613ms)"],"step_count":2} {"level":"info","ts":"2026-10-01T06:47:06.563536Z","caller":"traceutil/trace.go:171","msg":"trace[1585565971] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:12730; }","duration":"133.551966ms","start":"2026-10-01T06:47:06.429966Z","end":"2026-10-01T06:47:06.563518Z","steps":["trace[1585565971] 'agreement among raft nodes before linearized reading' (duration: 116.643142ms)","trace[1585565971] 'range keys from in-memory index tree' (duration: 16.820903ms)"],"step_count":2} {"level":"warn","ts":"2026-10-01T06:47:06.563586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.576906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-01T06:47:06.563638Z","caller":"traceutil/trace.go:171","msg":"trace[287148743] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:12730; }","duration":"207.628227ms","start":"2026-10-01T06:47:06.355996Z","end":"2026-10-01T06:47:06.563624Z","steps":["trace[287148743] 'agreement among raft nodes before linearized reading' (duration: 190.647911ms)","trace[287148743] 'range keys from in-memory index tree' (duration: 16.916805ms)"],"step_count":2} {"level":"warn","ts":"2026-10-01T06:47:06.563845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.485014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:1 size:5004"} {"level":"info","ts":"2026-10-01T06:47:06.563896Z","caller":"traceutil/trace.go:171","msg":"trace[1288920132] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:12730; }","duration":"208.589766ms","start":"2026-10-01T06:47:06.355291Z","end":"2026-10-01T06:47:06.563881Z","steps":["trace[1288920132] 'agreement among raft nodes before linearized reading' (duration: 191.338955ms)","trace[1288920132] 'range keys from in-memory index tree' (duration: 17.074808ms)"],"step_count":2} {"level":"info","ts":"2026-10-01T06:47:07.982199Z","caller":"traceutil/trace.go:171","msg":"trace[230933889] transaction","detail":"{read_only:false; response_revision:12735; number_of_response:1; }","duration":"113.986196ms","start":"2026-10-01T06:47:07.868185Z","end":"2026-10-01T06:47:07.982172Z","steps":["trace[230933889] 'process raft request' (duration: 113.71056ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:51:17.547831Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12258} {"level":"info","ts":"2026-10-01T06:51:17.629115Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12258,"took":"78.779969ms","hash":550396982,"current-db-size-bytes":43540480,"current-db-size":"44 MB","current-db-size-in-use-bytes":26300416,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-01T06:51:17.629194Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":550396982,"revision":12258,"compact-revision":10241} {"level":"info","ts":"2026-10-01T06:53:39.025338Z","caller":"traceutil/trace.go:171","msg":"trace[1662873893] linearizableReadLoop","detail":"{readStateIndex:15884; appliedIndex:15883; }","duration":"148.598704ms","start":"2026-10-01T06:53:38.876725Z","end":"2026-10-01T06:53:39.025324Z","steps":["trace[1662873893] 'read index received' (duration: 148.526573ms)","trace[1662873893] 'applied index is now lower than readState.Index' (duration: 71.381µs)"],"step_count":2} {"level":"info","ts":"2026-10-01T06:53:39.025382Z","caller":"traceutil/trace.go:171","msg":"trace[287884335] transaction","detail":"{read_only:false; response_revision:15344; number_of_response:1; }","duration":"156.150952ms","start":"2026-10-01T06:53:38.869206Z","end":"2026-10-01T06:53:39.025357Z","steps":["trace[287884335] 'process raft request' (duration: 156.01133ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:53:39.02606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.305926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-10-01T06:53:39.026119Z","caller":"traceutil/trace.go:171","msg":"trace[1594671579] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:15344; }","duration":"149.417039ms","start":"2026-10-01T06:53:38.876694Z","end":"2026-10-01T06:53:39.026112Z","steps":["trace[1594671579] 'agreement among raft nodes before linearized reading' (duration: 148.731747ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:53:48.555977Z","caller":"traceutil/trace.go:171","msg":"trace[1817711229] transaction","detail":"{read_only:false; response_revision:15406; number_of_response:1; }","duration":"455.778117ms","start":"2026-10-01T06:53:48.100169Z","end":"2026-10-01T06:53:48.555947Z","steps":["trace[1817711229] 'process raft request' (duration: 455.620384ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:53:48.556206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T06:53:48.099992Z","time spent":"456.125343ms","remote":"127.0.0.1:45238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-01T06:53:48.624993Z","caller":"traceutil/trace.go:171","msg":"trace[1420469697] transaction","detail":"{read_only:false; response_revision:15407; number_of_response:1; }","duration":"522.563047ms","start":"2026-10-01T06:53:48.102407Z","end":"2026-10-01T06:53:48.62497Z","steps":["trace[1420469697] 'process raft request' (duration: 522.427084ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:53:48.625179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T06:53:48.102377Z","time spent":"522.726129ms","remote":"127.0.0.1:45238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-01T06:53:50.048839Z","caller":"traceutil/trace.go:171","msg":"trace[631750258] transaction","detail":"{read_only:false; response_revision:15418; number_of_response:1; }","duration":"149.369808ms","start":"2026-10-01T06:53:49.899419Z","end":"2026-10-01T06:53:50.048789Z","steps":["trace[631750258] 'process raft request' (duration: 149.038852ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:54:15.9136Z","caller":"traceutil/trace.go:171","msg":"trace[1115193574] transaction","detail":"{read_only:false; response_revision:15745; number_of_response:1; }","duration":"211.648942ms","start":"2026-10-01T06:54:15.701924Z","end":"2026-10-01T06:54:15.913573Z","steps":["trace[1115193574] 'process raft request' (duration: 211.473439ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:54:16.085103Z","caller":"traceutil/trace.go:171","msg":"trace[1930631992] transaction","detail":"{read_only:false; response_revision:15746; number_of_response:1; }","duration":"363.213205ms","start":"2026-10-01T06:54:15.72187Z","end":"2026-10-01T06:54:16.085083Z","steps":["trace[1930631992] 'process raft request' (duration: 362.911061ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:54:16.085234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.248407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-10-01T06:54:16.085261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T06:54:15.721853Z","time spent":"363.313576ms","remote":"127.0.0.1:45238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-01T06:54:16.085335Z","caller":"traceutil/trace.go:171","msg":"trace[241156375] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:15746; }","duration":"255.3847ms","start":"2026-10-01T06:54:15.829917Z","end":"2026-10-01T06:54:16.085302Z","steps":["trace[241156375] 'agreement among raft nodes before linearized reading' (duration: 255.250577ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:54:16.086724Z","caller":"traceutil/trace.go:171","msg":"trace[756109373] linearizableReadLoop","detail":"{readStateIndex:16304; appliedIndex:16302; }","duration":"254.955082ms","start":"2026-10-01T06:54:15.829984Z","end":"2026-10-01T06:54:16.084939Z","steps":["trace[756109373] 'read index received' (duration: 83.385481ms)","trace[756109373] 'applied index is now lower than readState.Index' (duration: 171.568571ms)"],"step_count":2} {"level":"info","ts":"2026-10-01T06:55:44.68904Z","caller":"traceutil/trace.go:171","msg":"trace[98173283] transaction","detail":"{read_only:false; response_revision:16571; number_of_response:1; }","duration":"132.074689ms","start":"2026-10-01T06:55:44.556893Z","end":"2026-10-01T06:55:44.688968Z","steps":["trace[98173283] 'process raft request' (duration: 63.398525ms)","trace[98173283] 'compare' (duration: 68.252766ms)"],"step_count":2} {"level":"info","ts":"2026-10-01T06:55:50.217508Z","caller":"traceutil/trace.go:171","msg":"trace[1906520098] linearizableReadLoop","detail":"{readStateIndex:17179; appliedIndex:17178; }","duration":"178.968047ms","start":"2026-10-01T06:55:50.038514Z","end":"2026-10-01T06:55:50.217482Z","steps":["trace[1906520098] 'read index received' (duration: 150.858114ms)","trace[1906520098] 'applied index is now lower than readState.Index' (duration: 28.108863ms)"],"step_count":2} {"level":"info","ts":"2026-10-01T06:55:50.21764Z","caller":"traceutil/trace.go:171","msg":"trace[2054932832] transaction","detail":"{read_only:false; response_revision:16597; number_of_response:1; }","duration":"219.230001ms","start":"2026-10-01T06:55:49.998397Z","end":"2026-10-01T06:55:50.217627Z","steps":["trace[2054932832] 'process raft request' (duration: 190.921894ms)","trace[2054932832] 'compare' (duration: 28.064623ms)"],"step_count":2} {"level":"warn","ts":"2026-10-01T06:55:50.218353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.811992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secrettemplates/\" range_end:\"/registry/secretgen.carvel.dev/secrettemplates0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-01T06:55:50.218445Z","caller":"traceutil/trace.go:171","msg":"trace[1969798108] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secrettemplates/; range_end:/registry/secretgen.carvel.dev/secrettemplates0; response_count:0; response_revision:16597; }","duration":"179.963484ms","start":"2026-10-01T06:55:50.038462Z","end":"2026-10-01T06:55:50.218425Z","steps":["trace[1969798108] 'agreement among raft nodes before linearized reading' (duration: 179.796431ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T06:55:50.219289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.455258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-wljmb\" ","response":"range_response_count:1 size:22022"} {"level":"info","ts":"2026-10-01T06:55:50.220122Z","caller":"traceutil/trace.go:171","msg":"trace[1162207391] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-wljmb; range_end:; response_count:1; response_revision:16597; }","duration":"174.530834ms","start":"2026-10-01T06:55:50.045571Z","end":"2026-10-01T06:55:50.220102Z","steps":["trace[1162207391] 'agreement among raft nodes before linearized reading' (duration: 172.263597ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:55:51.241916Z","caller":"traceutil/trace.go:171","msg":"trace[1318917736] transaction","detail":"{read_only:false; response_revision:16601; number_of_response:1; }","duration":"193.841872ms","start":"2026-10-01T06:55:51.048046Z","end":"2026-10-01T06:55:51.241888Z","steps":["trace[1318917736] 'process raft request' (duration: 193.526106ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T06:56:17.556355Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14344} {"level":"info","ts":"2026-10-01T06:56:17.643136Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14344,"took":"84.229088ms","hash":3916686957,"current-db-size-bytes":44453888,"current-db-size":"44 MB","current-db-size-in-use-bytes":29859840,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-01T06:56:17.643334Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3916686957,"revision":14344,"compact-revision":12258} {"level":"info","ts":"2026-10-01T07:01:17.5665Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16738} {"level":"info","ts":"2026-10-01T07:01:17.680184Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16738,"took":"110.19405ms","hash":2744720498,"current-db-size-bytes":45842432,"current-db-size":"46 MB","current-db-size-in-use-bytes":31514624,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-01T07:01:17.680247Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2744720498,"revision":16738,"compact-revision":14344} {"level":"info","ts":"2026-10-01T07:02:04.517585Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"3b717bddf98d48e3","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-01T07:02:04.526603Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-01T07:02:04.526737Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"warn","ts":"2026-10-01T07:02:11.250324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.381105ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-01T07:02:11.250396Z","caller":"traceutil/trace.go:171","msg":"trace[1487259726] linearizableReadLoop","detail":"{readStateIndex:20066; appliedIndex:20065; }","duration":"112.205988ms","start":"2026-10-01T07:02:11.13818Z","end":"2026-10-01T07:02:11.250386Z","steps":["trace[1487259726] 'read index received' (duration: 2.64369ms)","trace[1487259726] 'applied index is now lower than readState.Index' (duration: 109.561638ms)"],"step_count":2} {"level":"warn","ts":"2026-10-01T07:02:11.250516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.3369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-29847300-ps478\" ","response":"range_response_count:1 size:6960"} {"level":"info","ts":"2026-10-01T07:02:11.25054Z","caller":"traceutil/trace.go:171","msg":"trace[50354625] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-29847300-ps478; range_end:; response_count:1; response_revision:19393; }","duration":"112.387481ms","start":"2026-10-01T07:02:11.138137Z","end":"2026-10-01T07:02:11.250525Z","steps":["trace[50354625] 'agreement among raft nodes before linearized reading' (duration: 112.273789ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T07:02:11.250805Z","caller":"traceutil/trace.go:171","msg":"trace[1547765410] transaction","detail":"{read_only:false; response_revision:19393; number_of_response:1; }","duration":"207.322224ms","start":"2026-10-01T07:02:11.043397Z","end":"2026-10-01T07:02:11.250719Z","steps":["trace[1547765410] 'process raft request' (duration: 97.482982ms)","trace[1547765410] 'compare' (duration: 109.026409ms)"],"step_count":2} {"level":"info","ts":"2026-10-01T07:02:17.853838Z","caller":"traceutil/trace.go:171","msg":"trace[1448774578] linearizableReadLoop","detail":"{readStateIndex:20105; appliedIndex:20104; }","duration":"229.735314ms","start":"2026-10-01T07:02:17.624078Z","end":"2026-10-01T07:02:17.853813Z","steps":["trace[1448774578] 'read index received' (duration: 229.48663ms)","trace[1448774578] 'applied index is now lower than readState.Index' (duration: 247.574µs)"],"step_count":2} {"level":"warn","ts":"2026-10-01T07:02:17.854129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.0298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-10-01T07:02:17.85417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.552224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1634"} {"level":"info","ts":"2026-10-01T07:02:17.854188Z","caller":"traceutil/trace.go:171","msg":"trace[836480167] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:19431; }","duration":"230.099961ms","start":"2026-10-01T07:02:17.624071Z","end":"2026-10-01T07:02:17.854171Z","steps":["trace[836480167] 'agreement among raft nodes before linearized reading' (duration: 229.890558ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T07:02:17.854224Z","caller":"traceutil/trace.go:171","msg":"trace[575850049] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:19431; }","duration":"118.629766ms","start":"2026-10-01T07:02:17.73558Z","end":"2026-10-01T07:02:17.85421Z","steps":["trace[575850049] 'agreement among raft nodes before linearized reading' (duration: 118.492453ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T07:02:17.854221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.577549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-10-01T07:02:17.854295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.374022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-01T07:02:17.85441Z","caller":"traceutil/trace.go:171","msg":"trace[1858534729] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19431; }","duration":"154.538254ms","start":"2026-10-01T07:02:17.699846Z","end":"2026-10-01T07:02:17.854384Z","steps":["trace[1858534729] 'agreement among raft nodes before linearized reading' (duration: 154.341361ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T07:02:17.853965Z","caller":"traceutil/trace.go:171","msg":"trace[259820634] transaction","detail":"{read_only:false; response_revision:19431; number_of_response:1; }","duration":"230.778ms","start":"2026-10-01T07:02:17.623152Z","end":"2026-10-01T07:02:17.85393Z","steps":["trace[259820634] 'process raft request' (duration: 230.518966ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T07:02:17.854328Z","caller":"traceutil/trace.go:171","msg":"trace[145113505] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:19431; }","duration":"187.724332ms","start":"2026-10-01T07:02:17.66658Z","end":"2026-10-01T07:02:17.854305Z","steps":["trace[145113505] 'agreement among raft nodes before linearized reading' (duration: 187.470948ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T07:02:17.854535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.810016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-s8l98\" ","response":"range_response_count:1 size:20668"} {"level":"info","ts":"2026-10-01T07:02:17.854615Z","caller":"traceutil/trace.go:171","msg":"trace[547109893] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-s8l98; range_end:; response_count:1; response_revision:19431; }","duration":"161.959137ms","start":"2026-10-01T07:02:17.692633Z","end":"2026-10-01T07:02:17.854592Z","steps":["trace[547109893] 'agreement among raft nodes before linearized reading' (duration: 161.638702ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T07:02:18.26055Z","caller":"traceutil/trace.go:171","msg":"trace[1531654186] transaction","detail":"{read_only:false; response_revision:19435; number_of_response:1; }","duration":"219.407726ms","start":"2026-10-01T07:02:18.041121Z","end":"2026-10-01T07:02:18.260528Z","steps":["trace[1531654186] 'process raft request' (duration: 219.282144ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T07:02:18.342847Z","caller":"traceutil/trace.go:171","msg":"trace[1386684024] transaction","detail":"{read_only:false; response_revision:19436; number_of_response:1; }","duration":"268.831771ms","start":"2026-10-01T07:02:18.07399Z","end":"2026-10-01T07:02:18.342822Z","steps":["trace[1386684024] 'process raft request' (duration: 210.196815ms)","trace[1386684024] 'compare' (duration: 58.16439ms)"],"step_count":2} {"level":"info","ts":"2026-10-01T07:02:18.343176Z","caller":"traceutil/trace.go:171","msg":"trace[424867663] linearizableReadLoop","detail":"{readStateIndex:20110; appliedIndex:20108; }","duration":"206.251825ms","start":"2026-10-01T07:02:18.136897Z","end":"2026-10-01T07:02:18.343149Z","steps":["trace[424867663] 'read index received' (duration: 123.591631ms)","trace[424867663] 'applied index is now lower than readState.Index' (duration: 82.658964ms)"],"step_count":2} {"level":"warn","ts":"2026-10-01T07:02:18.343429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.529389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-wljmb\" ","response":"range_response_count:1 size:22022"} {"level":"info","ts":"2026-10-01T07:02:18.343472Z","caller":"traceutil/trace.go:171","msg":"trace[1862422780] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-wljmb; range_end:; response_count:1; response_revision:19437; }","duration":"206.63046ms","start":"2026-10-01T07:02:18.13683Z","end":"2026-10-01T07:02:18.343461Z","steps":["trace[1862422780] 'agreement among raft nodes before linearized reading' (duration: 206.437907ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T07:02:18.724462Z","caller":"traceutil/trace.go:171","msg":"trace[1508171332] linearizableReadLoop","detail":"{readStateIndex:20112; appliedIndex:20111; }","duration":"240.341186ms","start":"2026-10-01T07:02:18.484095Z","end":"2026-10-01T07:02:18.724436Z","steps":["trace[1508171332] 'read index received' (duration: 216.109106ms)","trace[1508171332] 'applied index is now lower than readState.Index' (duration: 24.23044ms)"],"step_count":2} {"level":"info","ts":"2026-10-01T07:02:18.724587Z","caller":"traceutil/trace.go:171","msg":"trace[940381769] transaction","detail":"{read_only:false; response_revision:19438; number_of_response:1; }","duration":"318.445821ms","start":"2026-10-01T07:02:18.406129Z","end":"2026-10-01T07:02:18.724575Z","steps":["trace[940381769] 'process raft request' (duration: 294.1179ms)","trace[940381769] 'compare' (duration: 23.524229ms)"],"step_count":2} {"level":"warn","ts":"2026-10-01T07:02:18.725308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T07:02:18.406112Z","time spent":"318.499212ms","remote":"127.0.0.1:45238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-01T07:02:18.725299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.169709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-10-01T07:02:18.725394Z","caller":"traceutil/trace.go:171","msg":"trace[554486291] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:19438; }","duration":"241.326182ms","start":"2026-10-01T07:02:18.484045Z","end":"2026-10-01T07:02:18.725372Z","steps":["trace[554486291] 'agreement among raft nodes before linearized reading' (duration: 241.087268ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T07:02:19.011299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.012063ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-01T07:02:19.011415Z","caller":"traceutil/trace.go:171","msg":"trace[1267080630] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:19438; }","duration":"125.140575ms","start":"2026-10-01T07:02:18.886259Z","end":"2026-10-01T07:02:19.011399Z","steps":["trace[1267080630] 'range keys from in-memory index tree' (duration: 124.976753ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T07:02:19.011928Z","caller":"traceutil/trace.go:171","msg":"trace[1778870538] linearizableReadLoop","detail":"{readStateIndex:20114; appliedIndex:20112; }","duration":"145.605796ms","start":"2026-10-01T07:02:18.866277Z","end":"2026-10-01T07:02:19.011883Z","steps":["trace[1778870538] 'read index received' (duration: 96.282762ms)","trace[1778870538] 'applied index is now lower than readState.Index' (duration: 49.322264ms)"],"step_count":2} {"level":"warn","ts":"2026-10-01T07:02:19.014433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.119315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-01T07:02:19.014454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.083529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-01T07:02:19.014561Z","caller":"traceutil/trace.go:171","msg":"trace[1985734296] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:19440; }","duration":"148.266718ms","start":"2026-10-01T07:02:18.866247Z","end":"2026-10-01T07:02:19.014513Z","steps":["trace[1985734296] 'agreement among raft nodes before linearized reading' (duration: 148.077645ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T07:02:19.014568Z","caller":"traceutil/trace.go:171","msg":"trace[1919313951] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:19440; }","duration":"122.22517ms","start":"2026-10-01T07:02:18.892302Z","end":"2026-10-01T07:02:19.014527Z","steps":["trace[1919313951] 'agreement among raft nodes before linearized reading' (duration: 122.052408ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T07:02:19.014381Z","caller":"traceutil/trace.go:171","msg":"trace[205432520] transaction","detail":"{read_only:false; response_revision:19439; number_of_response:1; }","duration":"231.825917ms","start":"2026-10-01T07:02:18.782494Z","end":"2026-10-01T07:02:19.01432Z","steps":["trace[205432520] 'process raft request' (duration: 180.049465ms)","trace[205432520] 'compare' (duration: 49.096551ms)"],"step_count":2} {"level":"info","ts":"2026-10-01T07:02:19.018292Z","caller":"traceutil/trace.go:171","msg":"trace[558928880] transaction","detail":"{read_only:false; response_revision:19440; number_of_response:1; }","duration":"203.151887ms","start":"2026-10-01T07:02:18.815074Z","end":"2026-10-01T07:02:19.018225Z","steps":["trace[558928880] 'process raft request' (duration: 196.76079ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T07:06:17.574189Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19011} {"level":"info","ts":"2026-10-01T07:06:17.6934Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19011,"took":"115.32547ms","hash":3306884183,"current-db-size-bytes":48599040,"current-db-size":"49 MB","current-db-size-in-use-bytes":34639872,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-10-01T07:06:17.693659Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3306884183,"revision":19011,"compact-revision":16738} {"level":"info","ts":"2026-10-01T07:08:42.802525Z","caller":"traceutil/trace.go:171","msg":"trace[1211140585] transaction","detail":"{read_only:false; response_revision:22397; number_of_response:1; }","duration":"223.237843ms","start":"2026-10-01T07:08:42.579195Z","end":"2026-10-01T07:08:42.802433Z","steps":["trace[1211140585] 'process raft request' (duration: 188.137666ms)","trace[1211140585] 'compare' (duration: 34.423237ms)"],"step_count":2} {"level":"info","ts":"2026-10-01T07:08:42.837453Z","caller":"traceutil/trace.go:171","msg":"trace[1515842946] linearizableReadLoop","detail":"{readStateIndex:23169; appliedIndex:23167; }","duration":"138.111198ms","start":"2026-10-01T07:08:42.699315Z","end":"2026-10-01T07:08:42.837426Z","steps":["trace[1515842946] 'read index received' (duration: 68.178056ms)","trace[1515842946] 'applied index is now lower than readState.Index' (duration: 69.931642ms)"],"step_count":2} {"level":"warn","ts":"2026-10-01T07:08:42.837808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.484833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-01T07:08:42.837855Z","caller":"traceutil/trace.go:171","msg":"trace[817145603] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22398; }","duration":"138.598025ms","start":"2026-10-01T07:08:42.699246Z","end":"2026-10-01T07:08:42.837844Z","steps":["trace[817145603] 'agreement among raft nodes before linearized reading' (duration: 138.28242ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T07:08:42.838275Z","caller":"traceutil/trace.go:171","msg":"trace[2071152481] transaction","detail":"{read_only:false; response_revision:22398; number_of_response:1; }","duration":"257.139423ms","start":"2026-10-01T07:08:42.581107Z","end":"2026-10-01T07:08:42.838247Z","steps":["trace[2071152481] 'process raft request' (duration: 256.18354ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T07:08:43.092656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.556071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-10-01T07:08:43.09275Z","caller":"traceutil/trace.go:171","msg":"trace[890180798] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:22398; }","duration":"150.740025ms","start":"2026-10-01T07:08:42.941985Z","end":"2026-10-01T07:08:43.092725Z","steps":["trace[890180798] 'range keys from in-memory index tree' (duration: 150.370039ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T07:08:54.031636Z","caller":"traceutil/trace.go:171","msg":"trace[384212454] transaction","detail":"{read_only:false; response_revision:22451; number_of_response:1; }","duration":"136.98119ms","start":"2026-10-01T07:08:53.894628Z","end":"2026-10-01T07:08:54.031609Z","steps":["trace[384212454] 'process raft request' (duration: 136.793757ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T07:08:54.043402Z","caller":"traceutil/trace.go:171","msg":"trace[711930800] transaction","detail":"{read_only:false; response_revision:22452; number_of_response:1; }","duration":"135.913734ms","start":"2026-10-01T07:08:53.907457Z","end":"2026-10-01T07:08:54.043371Z","steps":["trace[711930800] 'process raft request' (duration: 135.757672ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T07:08:59.186137Z","caller":"traceutil/trace.go:171","msg":"trace[1776882629] transaction","detail":"{read_only:false; response_revision:22480; number_of_response:1; }","duration":"126.672157ms","start":"2026-10-01T07:08:59.059439Z","end":"2026-10-01T07:08:59.186111Z","steps":["trace[1776882629] 'process raft request' (duration: 108.652331ms)","trace[1776882629] 'compare' (duration: 17.582069ms)"],"step_count":2} {"level":"info","ts":"2026-10-01T07:08:59.434345Z","caller":"traceutil/trace.go:171","msg":"trace[1910564360] transaction","detail":"{read_only:false; response_revision:22481; number_of_response:1; }","duration":"216.640922ms","start":"2026-10-01T07:08:59.217674Z","end":"2026-10-01T07:08:59.434315Z","steps":["trace[1910564360] 'process raft request' (duration: 192.945953ms)","trace[1910564360] 'compare' (duration: 23.262452ms)"],"step_count":2} {"level":"info","ts":"2026-10-01T07:08:59.434592Z","caller":"traceutil/trace.go:171","msg":"trace[722498901] linearizableReadLoop","detail":"{readStateIndex:23255; appliedIndex:23254; }","duration":"178.448609ms","start":"2026-10-01T07:08:59.25578Z","end":"2026-10-01T07:08:59.434229Z","steps":["trace[722498901] 'read index received' (duration: 154.854352ms)","trace[722498901] 'applied index is now lower than readState.Index' (duration: 23.592487ms)"],"step_count":2} {"level":"warn","ts":"2026-10-01T07:08:59.434944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.918656ms","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:6"} {"level":"info","ts":"2026-10-01T07:08:59.435245Z","caller":"traceutil/trace.go:171","msg":"trace[928137357] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:22481; }","duration":"179.301962ms","start":"2026-10-01T07:08:59.255758Z","end":"2026-10-01T07:08:59.43506Z","steps":["trace[928137357] 'agreement among raft nodes before linearized reading' (duration: 178.840895ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T07:08:59.903754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.788619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-01T07:08:59.903886Z","caller":"traceutil/trace.go:171","msg":"trace[1935709431] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22481; }","duration":"202.946111ms","start":"2026-10-01T07:08:59.700887Z","end":"2026-10-01T07:08:59.903833Z","steps":["trace[1935709431] 'range keys from in-memory index tree' (duration: 202.724878ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T07:09:00.564284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.943854ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-01T07:09:00.564419Z","caller":"traceutil/trace.go:171","msg":"trace[669021892] transaction","detail":"{read_only:false; response_revision:22485; number_of_response:1; }","duration":"370.51833ms","start":"2026-10-01T07:09:00.193887Z","end":"2026-10-01T07:09:00.564405Z","steps":["trace[669021892] 'process raft request' (duration: 179.370443ms)","trace[669021892] 'compare' (duration: 190.778972ms)"],"step_count":2} {"level":"warn","ts":"2026-10-01T07:09:00.564458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T07:09:00.193874Z","time spent":"370.568481ms","remote":"127.0.0.1:45238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-01T07:09:00.564602Z","caller":"traceutil/trace.go:171","msg":"trace[808562687] linearizableReadLoop","detail":"{readStateIndex:23260; appliedIndex:23258; }","duration":"207.749701ms","start":"2026-10-01T07:09:00.356811Z","end":"2026-10-01T07:09:00.56456Z","steps":["trace[808562687] 'read index received' (duration: 16.457553ms)","trace[808562687] 'applied index is now lower than readState.Index' (duration: 191.289858ms)"],"step_count":2} {"level":"warn","ts":"2026-10-01T07:09:00.564707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.898293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-01T07:09:00.564736Z","caller":"traceutil/trace.go:171","msg":"trace[587379888] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:22486; }","duration":"207.986024ms","start":"2026-10-01T07:09:00.356741Z","end":"2026-10-01T07:09:00.564728Z","steps":["trace[587379888] 'agreement among raft nodes before linearized reading' (duration: 207.936813ms)"],"step_count":1} {"level":"info","ts":"2026-10-01T07:09:00.564701Z","caller":"traceutil/trace.go:171","msg":"trace[541464308] transaction","detail":"{read_only:false; response_revision:22486; number_of_response:1; }","duration":"368.392717ms","start":"2026-10-01T07:09:00.196214Z","end":"2026-10-01T07:09:00.564606Z","steps":["trace[541464308] 'process raft request' (duration: 368.152505ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T07:09:00.564898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.335028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-01T07:09:00.564937Z","caller":"traceutil/trace.go:171","msg":"trace[1019362231] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:22486; }","duration":"119.45037ms","start":"2026-10-01T07:09:00.445478Z","end":"2026-10-01T07:09:00.564929Z","steps":["trace[1019362231] 'agreement among raft nodes before linearized reading' (duration: 119.231987ms)"],"step_count":1} {"level":"warn","ts":"2026-10-01T07:09:00.564986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-01T07:09:00.196199Z","time spent":"368.628982ms","remote":"127.0.0.1:45238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-01T07:11:17.581755Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21427} {"level":"info","ts":"2026-10-01T07:11:17.708736Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21427,"took":"122.467691ms","hash":3174917130,"current-db-size-bytes":48599040,"current-db-size":"49 MB","current-db-size-in-use-bytes":27398144,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-10-01T07:11:17.708934Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3174917130,"revision":21427,"compact-revision":19011} {"level":"info","ts":"2026-10-01T07:16:17.58973Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23317} {"level":"info","ts":"2026-10-01T07:16:17.710549Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23317,"took":"117.10756ms","hash":2357473981,"current-db-size-bytes":48599040,"current-db-size":"49 MB","current-db-size-in-use-bytes":24805376,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-10-01T07:16:17.710618Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2357473981,"revision":23317,"compact-revision":21427}