{"level":"warn","ts":"2026-10-02T09:03:20.382415Z","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-02T09:03:20.382523Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.20: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.20:2380","--initial-cluster=instance=https://162.253.55.20:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.20:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.20: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-02T09:03:20.382607Z","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-02T09:03:20.382625Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.20:2380"]} {"level":"info","ts":"2026-10-02T09:03:20.382654Z","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-02T09:03:20.383486Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.20:2379"]} {"level":"info","ts":"2026-10-02T09:03:20.383623Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.20:2380"],"listen-peer-urls":["https://162.253.55.20:2380"],"advertise-client-urls":["https://162.253.55.20:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.20:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.20: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-02T09:03:20.387716Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.81903ms"} {"level":"info","ts":"2026-10-02T09:03:20.394396Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"eae99266654eff69","cluster-id":"6d4184aac664e4ac"} {"level":"info","ts":"2026-10-02T09:03:20.394497Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eae99266654eff69 switched to configuration voters=()"} {"level":"info","ts":"2026-10-02T09:03:20.394531Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eae99266654eff69 became follower at term 0"} {"level":"info","ts":"2026-10-02T09:03:20.394545Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft eae99266654eff69 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-02T09:03:20.394568Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eae99266654eff69 became follower at term 1"} {"level":"info","ts":"2026-10-02T09:03:20.394617Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eae99266654eff69 switched to configuration voters=(16927221642932715369)"} {"level":"warn","ts":"2026-10-02T09:03:20.405714Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-02T09:03:20.407149Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-02T09:03:20.408489Z","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-02T09:03:20.410626Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"eae99266654eff69","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-02T09:03:20.410706Z","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-02T09:03:20.410756Z","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-02T09:03:20.410764Z","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-02T09:03:20.410951Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"eae99266654eff69","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-02T09:03:20.416367Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eae99266654eff69 switched to configuration voters=(16927221642932715369)"} {"level":"info","ts":"2026-10-02T09:03:20.41656Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6d4184aac664e4ac","local-member-id":"eae99266654eff69","added-peer-id":"eae99266654eff69","added-peer-peer-urls":["https://162.253.55.20:2380"]} {"level":"info","ts":"2026-10-02T09:03:20.427108Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.20:2380"} {"level":"info","ts":"2026-10-02T09:03:20.427139Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.20:2380"} {"level":"info","ts":"2026-10-02T09:03:20.426988Z","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-02T09:03:20.427525Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"eae99266654eff69","initial-advertise-peer-urls":["https://162.253.55.20:2380"],"listen-peer-urls":["https://162.253.55.20:2380"],"advertise-client-urls":["https://162.253.55.20:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.20:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-02T09:03:20.427549Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-02T09:03:21.394891Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eae99266654eff69 is starting a new election at term 1"} {"level":"info","ts":"2026-10-02T09:03:21.395003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eae99266654eff69 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-02T09:03:21.395042Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eae99266654eff69 received MsgPreVoteResp from eae99266654eff69 at term 1"} {"level":"info","ts":"2026-10-02T09:03:21.395063Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eae99266654eff69 became candidate at term 2"} {"level":"info","ts":"2026-10-02T09:03:21.395074Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eae99266654eff69 received MsgVoteResp from eae99266654eff69 at term 2"} {"level":"info","ts":"2026-10-02T09:03:21.395089Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eae99266654eff69 became leader at term 2"} {"level":"info","ts":"2026-10-02T09:03:21.395103Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: eae99266654eff69 elected leader eae99266654eff69 at term 2"} {"level":"info","ts":"2026-10-02T09:03:21.396446Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-02T09:03:21.397773Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-02T09:03:21.397773Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"eae99266654eff69","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.20:2379]}","request-path":"/0/members/eae99266654eff69/attributes","cluster-id":"6d4184aac664e4ac","publish-timeout":"7s"} {"level":"info","ts":"2026-10-02T09:03:21.397861Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-02T09:03:21.398119Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-02T09:03:21.398198Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-02T09:03:21.400511Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6d4184aac664e4ac","local-member-id":"eae99266654eff69","cluster-version":"3.5"} {"level":"info","ts":"2026-10-02T09:03:21.400746Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-02T09:03:21.400798Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-02T09:03:21.40136Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.20:2379"} {"level":"info","ts":"2026-10-02T09:03:21.402529Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-10-02T09:03:23.288612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.145651ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-10-02T09:03:23.288972Z","caller":"traceutil/trace.go:171","msg":"trace[1825579386] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"369.720122ms","start":"2026-10-02T09:03:22.919227Z","end":"2026-10-02T09:03:23.288947Z","steps":["trace[1825579386] 'process raft request' (duration: 185.454881ms)","trace[1825579386] 'compare' (duration: 183.002278ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T09:03:23.289074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.569435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-10-02T09:03:23.289255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:03:22.919203Z","time spent":"369.838534ms","remote":"127.0.0.1:46110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-02T09:03:23.289204Z","caller":"traceutil/trace.go:171","msg":"trace[615760533] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:3; }","duration":"357.749219ms","start":"2026-10-02T09:03:22.93143Z","end":"2026-10-02T09:03:23.289179Z","steps":["trace[615760533] 'agreement among raft nodes before linearized reading' (duration: 357.448131ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:03:23.289515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:03:22.931419Z","time spent":"357.969835ms","remote":"127.0.0.1:49060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-10-02T09:03:23.28951Z","caller":"traceutil/trace.go:171","msg":"trace[300702856] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"357.310057ms","start":"2026-10-02T09:03:22.931468Z","end":"2026-10-02T09:03:23.288778Z","steps":["trace[300702856] 'read index received' (duration: 55.366924ms)","trace[300702856] 'applied index is now lower than readState.Index' (duration: 301.941723ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T09:03:23.315428Z","caller":"traceutil/trace.go:171","msg":"trace[2052645745] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"327.185302ms","start":"2026-10-02T09:03:22.988215Z","end":"2026-10-02T09:03:23.3154Z","steps":["trace[2052645745] 'process raft request' (duration: 326.974627ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:03:23.31546Z","caller":"traceutil/trace.go:171","msg":"trace[740908652] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"326.349ms","start":"2026-10-02T09:03:22.989083Z","end":"2026-10-02T09:03:23.315432Z","steps":["trace[740908652] 'process raft request' (duration: 326.267818ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:03:23.315516Z","caller":"traceutil/trace.go:171","msg":"trace[938037366] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"326.284488ms","start":"2026-10-02T09:03:22.989195Z","end":"2026-10-02T09:03:23.315479Z","steps":["trace[938037366] 'process raft request' (duration: 326.185186ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:03:23.317301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:03:22.989174Z","time spent":"328.001414ms","remote":"127.0.0.1:49238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-02T09:03:23.315591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:03:22.989066Z","time spent":"326.448072ms","remote":"127.0.0.1:49238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-02T09:03:23.315588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:03:22.988175Z","time spent":"327.338456ms","remote":"127.0.0.1:49238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-02T09:03:23.315657Z","caller":"traceutil/trace.go:171","msg":"trace[705539271] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"326.993547ms","start":"2026-10-02T09:03:22.988652Z","end":"2026-10-02T09:03:23.315646Z","steps":["trace[705539271] 'process raft request' (duration: 326.659008ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:03:23.317947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:03:22.988626Z","time spent":"329.245066ms","remote":"127.0.0.1:49238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-02T09:03:23.315772Z","caller":"traceutil/trace.go:171","msg":"trace[1714234786] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"326.352831ms","start":"2026-10-02T09:03:22.989327Z","end":"2026-10-02T09:03:23.315679Z","steps":["trace[1714234786] 'process raft request' (duration: 326.080683ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:03:23.31811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:03:22.989314Z","time spent":"328.762253ms","remote":"127.0.0.1:49238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-02T09:03:23.316499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.018884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.20\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-02T09:03:23.318239Z","caller":"traceutil/trace.go:171","msg":"trace[56482190] range","detail":"{range_begin:/registry/masterleases/162.253.55.20; range_end:; response_count:0; response_revision:11; }","duration":"316.791191ms","start":"2026-10-02T09:03:23.001429Z","end":"2026-10-02T09:03:23.31822Z","steps":["trace[56482190] 'agreement among raft nodes before linearized reading' (duration: 314.956143ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:03:23.31837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:03:23.001398Z","time spent":"316.925445ms","remote":"127.0.0.1:46076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/162.253.55.20\" "} {"level":"warn","ts":"2026-10-02T09:03:23.316584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.21496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-02T09:03:23.31866Z","caller":"traceutil/trace.go:171","msg":"trace[1512936895] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"345.293954ms","start":"2026-10-02T09:03:22.973323Z","end":"2026-10-02T09:03:23.318616Z","steps":["trace[1512936895] 'agreement among raft nodes before linearized reading' (duration: 343.19848ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:03:23.318708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:03:22.973312Z","time spent":"345.384016ms","remote":"127.0.0.1:46150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-10-02T09:03:23.316555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.18435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-02T09:03:23.319084Z","caller":"traceutil/trace.go:171","msg":"trace[1595961976] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"314.772018ms","start":"2026-10-02T09:03:23.004266Z","end":"2026-10-02T09:03:23.319038Z","steps":["trace[1595961976] 'agreement among raft nodes before linearized reading' (duration: 312.032057ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:03:23.319266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:03:23.00425Z","time spent":"314.937712ms","remote":"127.0.0.1:46128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-10-02T09:03:23.316633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.306393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-02T09:03:23.316736Z","caller":"traceutil/trace.go:171","msg":"trace[2058016533] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"318.543347ms","start":"2026-10-02T09:03:22.998177Z","end":"2026-10-02T09:03:23.31672Z","steps":["trace[2058016533] 'process raft request' (duration: 317.938961ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:03:23.316745Z","caller":"traceutil/trace.go:171","msg":"trace[558273911] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"319.306586ms","start":"2026-10-02T09:03:22.997389Z","end":"2026-10-02T09:03:23.316695Z","steps":["trace[558273911] 'process raft request' (duration: 318.051593ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:03:23.316787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.984418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-02T09:03:23.322336Z","caller":"traceutil/trace.go:171","msg":"trace[1091406864] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"347.578194ms","start":"2026-10-02T09:03:22.974741Z","end":"2026-10-02T09:03:23.322319Z","steps":["trace[1091406864] 'agreement among raft nodes before linearized reading' (duration: 341.954847ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:03:23.322397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:03:22.974734Z","time spent":"347.649277ms","remote":"127.0.0.1:46150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-10-02T09:03:23.321173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:03:22.998152Z","time spent":"322.276554ms","remote":"127.0.0.1:48816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-02T09:03:23.316807Z","caller":"traceutil/trace.go:171","msg":"trace[667130007] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"313.892665ms","start":"2026-10-02T09:03:23.002905Z","end":"2026-10-02T09:03:23.316797Z","steps":["trace[667130007] 'process raft request' (duration: 313.260598ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:03:23.316843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.01742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-02T09:03:23.322846Z","caller":"traceutil/trace.go:171","msg":"trace[932258553] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"268.021357ms","start":"2026-10-02T09:03:23.054805Z","end":"2026-10-02T09:03:23.322826Z","steps":["trace[932258553] 'agreement among raft nodes before linearized reading' (duration: 261.951639ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:03:23.316672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.864985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-02T09:03:23.32301Z","caller":"traceutil/trace.go:171","msg":"trace[1503963271] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"348.249432ms","start":"2026-10-02T09:03:22.974751Z","end":"2026-10-02T09:03:23.323001Z","steps":["trace[1503963271] 'agreement among raft nodes before linearized reading' (duration: 341.898676ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:03:23.32304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:03:22.97472Z","time spent":"348.308763ms","remote":"127.0.0.1:46150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-10-02T09:03:23.319578Z","caller":"traceutil/trace.go:171","msg":"trace[1774258280] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"333.305702ms","start":"2026-10-02T09:03:22.98626Z","end":"2026-10-02T09:03:23.319566Z","steps":["trace[1774258280] 'agreement among raft nodes before linearized reading' (duration: 330.354435ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:03:23.321506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:03:22.997374Z","time spent":"323.240339ms","remote":"127.0.0.1:48906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-02T09:03:23.323122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:03:22.986237Z","time spent":"336.842354ms","remote":"127.0.0.1:46150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-10-02T09:03:23.323913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:03:23.002887Z","time spent":"319.870021ms","remote":"127.0.0.1:49134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-02T09:03:31.602839Z","caller":"traceutil/trace.go:171","msg":"trace[220644095] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"169.064813ms","start":"2026-10-02T09:03:31.433737Z","end":"2026-10-02T09:03:31.602802Z","steps":["trace[220644095] 'process raft request' (duration: 101.83597ms)","trace[220644095] 'compare' (duration: 67.052218ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T09:03:31.61138Z","caller":"traceutil/trace.go:171","msg":"trace[1304888209] linearizableReadLoop","detail":"{readStateIndex:335; appliedIndex:332; }","duration":"158.67145ms","start":"2026-10-02T09:03:31.452681Z","end":"2026-10-02T09:03:31.611352Z","steps":["trace[1304888209] 'read index received' (duration: 83.192331ms)","trace[1304888209] 'applied index is now lower than readState.Index' (duration: 75.477889ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T09:03:31.61153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.833934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-10-02T09:03:31.611564Z","caller":"traceutil/trace.go:171","msg":"trace[2116287542] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:324; }","duration":"158.944417ms","start":"2026-10-02T09:03:31.452605Z","end":"2026-10-02T09:03:31.61155Z","steps":["trace[2116287542] 'agreement among raft nodes before linearized reading' (duration: 158.865355ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:03:31.611498Z","caller":"traceutil/trace.go:171","msg":"trace[415128433] transaction","detail":"{read_only:false; response_revision:324; number_of_response:1; }","duration":"175.45043ms","start":"2026-10-02T09:03:31.436019Z","end":"2026-10-02T09:03:31.61147Z","steps":["trace[415128433] 'process raft request' (duration: 175.287116ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:03:31.611525Z","caller":"traceutil/trace.go:171","msg":"trace[1681075629] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"176.803886ms","start":"2026-10-02T09:03:31.434698Z","end":"2026-10-02T09:03:31.611502Z","steps":["trace[1681075629] 'process raft request' (duration: 176.487738ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:03:31.611692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.70949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-10-02T09:03:31.612317Z","caller":"traceutil/trace.go:171","msg":"trace[1156225180] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:324; }","duration":"109.379838ms","start":"2026-10-02T09:03:31.502895Z","end":"2026-10-02T09:03:31.612274Z","steps":["trace[1156225180] 'agreement among raft nodes before linearized reading' (duration: 108.707301ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:03:58.072505Z","caller":"traceutil/trace.go:171","msg":"trace[201945811] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"100.102084ms","start":"2026-10-02T09:03:57.972369Z","end":"2026-10-02T09:03:58.072471Z","steps":["trace[201945811] 'process raft request' (duration: 99.686193ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:04:00.246923Z","caller":"traceutil/trace.go:171","msg":"trace[152866660] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"131.593171ms","start":"2026-10-02T09:04:00.115294Z","end":"2026-10-02T09:04:00.246887Z","steps":["trace[152866660] 'process raft request' (duration: 126.714531ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:04:00.249015Z","caller":"traceutil/trace.go:171","msg":"trace[1824266654] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"132.720591ms","start":"2026-10-02T09:04:00.116271Z","end":"2026-10-02T09:04:00.248992Z","steps":["trace[1824266654] 'process raft request' (duration: 132.141675ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:04:00.249069Z","caller":"traceutil/trace.go:171","msg":"trace[646691349] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"131.92177ms","start":"2026-10-02T09:04:00.11714Z","end":"2026-10-02T09:04:00.249062Z","steps":["trace[646691349] 'process raft request' (duration: 131.54999ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:04:00.249207Z","caller":"traceutil/trace.go:171","msg":"trace[962948899] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"132.828484ms","start":"2026-10-02T09:04:00.11637Z","end":"2026-10-02T09:04:00.249199Z","steps":["trace[962948899] 'process raft request' (duration: 132.165417ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:04:00.249319Z","caller":"traceutil/trace.go:171","msg":"trace[2093283682] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"132.829434ms","start":"2026-10-02T09:04:00.116478Z","end":"2026-10-02T09:04:00.249308Z","steps":["trace[2093283682] 'process raft request' (duration: 132.119525ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:04:00.249329Z","caller":"traceutil/trace.go:171","msg":"trace[762354688] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"129.561597ms","start":"2026-10-02T09:04:00.119758Z","end":"2026-10-02T09:04:00.24932Z","steps":["trace[762354688] 'process raft request' (duration: 129.046404ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:04:00.249928Z","caller":"traceutil/trace.go:171","msg":"trace[1444045815] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"118.651557ms","start":"2026-10-02T09:04:00.131269Z","end":"2026-10-02T09:04:00.24992Z","steps":["trace[1444045815] 'process raft request' (duration: 118.505414ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:04:00.249015Z","caller":"traceutil/trace.go:171","msg":"trace[1415712556] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"129.103415ms","start":"2026-10-02T09:04:00.119898Z","end":"2026-10-02T09:04:00.249001Z","steps":["trace[1415712556] 'process raft request' (duration: 128.983542ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:04:00.250018Z","caller":"traceutil/trace.go:171","msg":"trace[394733605] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"124.460812ms","start":"2026-10-02T09:04:00.125549Z","end":"2026-10-02T09:04:00.25001Z","steps":["trace[394733605] 'process raft request' (duration: 123.365743ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:04:00.460093Z","caller":"traceutil/trace.go:171","msg":"trace[1510073165] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"135.749591ms","start":"2026-10-02T09:04:00.324307Z","end":"2026-10-02T09:04:00.460057Z","steps":["trace[1510073165] 'process raft request' (duration: 117.361003ms)","trace[1510073165] 'compare' (duration: 18.07744ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T09:04:00.460395Z","caller":"traceutil/trace.go:171","msg":"trace[340744174] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"124.468262ms","start":"2026-10-02T09:04:00.335899Z","end":"2026-10-02T09:04:00.460367Z","steps":["trace[340744174] 'process raft request' (duration: 124.193175ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:04:00.46033Z","caller":"traceutil/trace.go:171","msg":"trace[1794623899] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"132.051583ms","start":"2026-10-02T09:04:00.32824Z","end":"2026-10-02T09:04:00.460292Z","steps":["trace[1794623899] 'process raft request' (duration: 131.739275ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:04:00.460493Z","caller":"traceutil/trace.go:171","msg":"trace[1326831133] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"101.595175ms","start":"2026-10-02T09:04:00.358885Z","end":"2026-10-02T09:04:00.46048Z","steps":["trace[1326831133] 'process raft request' (duration: 101.349419ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:04:01.236628Z","caller":"traceutil/trace.go:171","msg":"trace[1737237616] linearizableReadLoop","detail":"{readStateIndex:577; appliedIndex:576; }","duration":"113.677337ms","start":"2026-10-02T09:04:01.122923Z","end":"2026-10-02T09:04:01.2366Z","steps":["trace[1737237616] 'read index received' (duration: 65.401116ms)","trace[1737237616] 'applied index is now lower than readState.Index' (duration: 48.275071ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T09:04:01.236757Z","caller":"traceutil/trace.go:171","msg":"trace[2018274906] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"129.749403ms","start":"2026-10-02T09:04:01.106994Z","end":"2026-10-02T09:04:01.236744Z","steps":["trace[2018274906] 'process raft request' (duration: 81.747939ms)","trace[2018274906] 'compare' (duration: 47.451269ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T09:04:01.237291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.943165ms","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-02T09:04:01.237344Z","caller":"traceutil/trace.go:171","msg":"trace[1260602002] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:557; }","duration":"131.407537ms","start":"2026-10-02T09:04:01.10592Z","end":"2026-10-02T09:04:01.237328Z","steps":["trace[1260602002] 'agreement among raft nodes before linearized reading' (duration: 131.269514ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:04:01.23759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.406677ms","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-02T09:04:01.237628Z","caller":"traceutil/trace.go:171","msg":"trace[1397888273] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:557; }","duration":"131.458489ms","start":"2026-10-02T09:04:01.10616Z","end":"2026-10-02T09:04:01.237618Z","steps":["trace[1397888273] 'agreement among raft nodes before linearized reading' (duration: 131.396067ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:04:01.237743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.829669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T09:04:01.237778Z","caller":"traceutil/trace.go:171","msg":"trace[788990209] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:557; }","duration":"177.892511ms","start":"2026-10-02T09:04:01.059876Z","end":"2026-10-02T09:04:01.237768Z","steps":["trace[788990209] 'agreement among raft nodes before linearized reading' (duration: 177.83831ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:04:01.248362Z","caller":"traceutil/trace.go:171","msg":"trace[371476365] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"101.890303ms","start":"2026-10-02T09:04:01.146447Z","end":"2026-10-02T09:04:01.248338Z","steps":["trace[371476365] 'process raft request' (duration: 101.556014ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:04:01.249414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.206615ms","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-02T09:04:01.249464Z","caller":"traceutil/trace.go:171","msg":"trace[1982879660] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:558; }","duration":"107.301097ms","start":"2026-10-02T09:04:01.142152Z","end":"2026-10-02T09:04:01.249453Z","steps":["trace[1982879660] 'agreement among raft nodes before linearized reading' (duration: 107.197804ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:04:01.249566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.895563ms","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-02T09:04:01.249585Z","caller":"traceutil/trace.go:171","msg":"trace[1955417416] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:558; }","duration":"107.926084ms","start":"2026-10-02T09:04:01.141652Z","end":"2026-10-02T09:04:01.249578Z","steps":["trace[1955417416] 'agreement among raft nodes before linearized reading' (duration: 107.889083ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:04:01.249781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.137099ms","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-02T09:04:01.249807Z","caller":"traceutil/trace.go:171","msg":"trace[404685103] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:558; }","duration":"108.199181ms","start":"2026-10-02T09:04:01.141601Z","end":"2026-10-02T09:04:01.2498Z","steps":["trace[404685103] 'agreement among raft nodes before linearized reading' (duration: 108.14554ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:04:01.641719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.889371ms","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-02T09:04:01.641805Z","caller":"traceutil/trace.go:171","msg":"trace[2000901703] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:558; }","duration":"279.001524ms","start":"2026-10-02T09:04:01.362783Z","end":"2026-10-02T09:04:01.641785Z","steps":["trace[2000901703] 'range keys from in-memory index tree' (duration: 278.8442ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:04:01.641754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.985044ms","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-02T09:04:01.641912Z","caller":"traceutil/trace.go:171","msg":"trace[2045760443] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:558; }","duration":"279.23137ms","start":"2026-10-02T09:04:01.362651Z","end":"2026-10-02T09:04:01.641882Z","steps":["trace[2045760443] 'range keys from in-memory index tree' (duration: 278.703147ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:04:01.642351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.454696ms","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-02T09:04:01.642422Z","caller":"traceutil/trace.go:171","msg":"trace[917853659] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:558; }","duration":"279.539228ms","start":"2026-10-02T09:04:01.362871Z","end":"2026-10-02T09:04:01.64241Z","steps":["trace[917853659] 'count revisions from in-memory index tree' (duration: 279.380314ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:04:01.64251Z","caller":"traceutil/trace.go:171","msg":"trace[502917273] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"264.808718ms","start":"2026-10-02T09:04:01.377691Z","end":"2026-10-02T09:04:01.642499Z","steps":["trace[502917273] 'process raft request' (duration: 252.899562ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:04:01.642756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.436791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T09:04:01.642829Z","caller":"traceutil/trace.go:171","msg":"trace[1396389628] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:559; }","duration":"231.546625ms","start":"2026-10-02T09:04:01.411266Z","end":"2026-10-02T09:04:01.642813Z","steps":["trace[1396389628] 'agreement among raft nodes before linearized reading' (duration: 231.328649ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:04:01.64255Z","caller":"traceutil/trace.go:171","msg":"trace[1458350306] linearizableReadLoop","detail":"{readStateIndex:579; appliedIndex:578; }","duration":"231.207865ms","start":"2026-10-02T09:04:01.411279Z","end":"2026-10-02T09:04:01.642487Z","steps":["trace[1458350306] 'read index received' (duration: 219.263788ms)","trace[1458350306] 'applied index is now lower than readState.Index' (duration: 11.942007ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T09:04:01.649561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.126899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T09:04:01.64964Z","caller":"traceutil/trace.go:171","msg":"trace[1559311067] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:560; }","duration":"238.271343ms","start":"2026-10-02T09:04:01.411353Z","end":"2026-10-02T09:04:01.649624Z","steps":["trace[1559311067] 'agreement among raft nodes before linearized reading' (duration: 238.111608ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:04:01.651091Z","caller":"traceutil/trace.go:171","msg":"trace[958427014] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"184.403343ms","start":"2026-10-02T09:04:01.466673Z","end":"2026-10-02T09:04:01.651077Z","steps":["trace[958427014] 'process raft request' (duration: 181.847055ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:04:01.651824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.976809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T09:04:01.652077Z","caller":"traceutil/trace.go:171","msg":"trace[660832002] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:560; }","duration":"240.244675ms","start":"2026-10-02T09:04:01.41182Z","end":"2026-10-02T09:04:01.652065Z","steps":["trace[660832002] 'agreement among raft nodes before linearized reading' (duration: 239.968828ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:04:06.37839Z","caller":"traceutil/trace.go:171","msg":"trace[1438954180] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"183.331003ms","start":"2026-10-02T09:04:06.195032Z","end":"2026-10-02T09:04:06.378363Z","steps":["trace[1438954180] 'process raft request' (duration: 182.756198ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:04:06.940169Z","caller":"traceutil/trace.go:171","msg":"trace[1798670453] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"413.167001ms","start":"2026-10-02T09:04:06.526959Z","end":"2026-10-02T09:04:06.940126Z","steps":["trace[1798670453] 'read index received' (duration: 412.208325ms)","trace[1798670453] 'applied index is now lower than readState.Index' (duration: 957.656µs)"],"step_count":2} {"level":"info","ts":"2026-10-02T09:04:06.940472Z","caller":"traceutil/trace.go:171","msg":"trace[1001519827] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"486.12136ms","start":"2026-10-02T09:04:06.454262Z","end":"2026-10-02T09:04:06.940384Z","steps":["trace[1001519827] 'process raft request' (duration: 485.634977ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:04:06.940599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.619128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T09:04:06.940645Z","caller":"traceutil/trace.go:171","msg":"trace[1928874434] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:592; }","duration":"394.69863ms","start":"2026-10-02T09:04:06.545931Z","end":"2026-10-02T09:04:06.940629Z","steps":["trace[1928874434] 'agreement among raft nodes before linearized reading' (duration: 394.601438ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:04:06.940632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.648744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-10-02T09:04:06.940662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:04:06.454239Z","time spent":"486.334236ms","remote":"127.0.0.1:49000","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-02T09:04:06.940681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:04:06.545919Z","time spent":"394.753811ms","remote":"127.0.0.1:46062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-02T09:04:06.940698Z","caller":"traceutil/trace.go:171","msg":"trace[577256839] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:592; }","duration":"413.753016ms","start":"2026-10-02T09:04:06.526925Z","end":"2026-10-02T09:04:06.940678Z","steps":["trace[577256839] 'agreement among raft nodes before linearized reading' (duration: 413.419458ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:04:06.940734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:04:06.526914Z","time spent":"413.812338ms","remote":"127.0.0.1:48918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-02T09:04:06.941003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.67733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-02T09:04:06.941034Z","caller":"traceutil/trace.go:171","msg":"trace[284824297] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:592; }","duration":"356.788223ms","start":"2026-10-02T09:04:06.584235Z","end":"2026-10-02T09:04:06.941023Z","steps":["trace[284824297] 'agreement among raft nodes before linearized reading' (duration: 356.648299ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:04:06.941058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:04:06.584206Z","time spent":"356.845494ms","remote":"127.0.0.1:48918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-02T09:04:06.941099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.827213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-02T09:04:06.941132Z","caller":"traceutil/trace.go:171","msg":"trace[605671674] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:592; }","duration":"356.876945ms","start":"2026-10-02T09:04:06.584244Z","end":"2026-10-02T09:04:06.941121Z","steps":["trace[605671674] 'agreement among raft nodes before linearized reading' (duration: 356.765472ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:04:06.941157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:04:06.58423Z","time spent":"356.920696ms","remote":"127.0.0.1:48918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-10-02T09:04:08.213572Z","caller":"traceutil/trace.go:171","msg":"trace[1072392771] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"104.364935ms","start":"2026-10-02T09:04:08.109182Z","end":"2026-10-02T09:04:08.213547Z","steps":["trace[1072392771] 'process raft request' (duration: 103.919564ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:04:23.644568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.322498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T09:04:23.644698Z","caller":"traceutil/trace.go:171","msg":"trace[2118959294] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:759; }","duration":"103.523243ms","start":"2026-10-02T09:04:23.541152Z","end":"2026-10-02T09:04:23.644675Z","steps":["trace[2118959294] 'range keys from in-memory index tree' (duration: 103.213805ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:05:12.476501Z","caller":"traceutil/trace.go:171","msg":"trace[100833821] transaction","detail":"{read_only:false; response_revision:1314; number_of_response:1; }","duration":"105.759119ms","start":"2026-10-02T09:05:12.370683Z","end":"2026-10-02T09:05:12.476442Z","steps":["trace[100833821] 'process raft request' (duration: 105.451891ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:05:47.672763Z","caller":"traceutil/trace.go:171","msg":"trace[1657632087] linearizableReadLoop","detail":"{readStateIndex:1933; appliedIndex:1932; }","duration":"114.382506ms","start":"2026-10-02T09:05:47.558353Z","end":"2026-10-02T09:05:47.672735Z","steps":["trace[1657632087] 'read index received' (duration: 114.15607ms)","trace[1657632087] 'applied index is now lower than readState.Index' (duration: 225.116µs)"],"step_count":2} {"level":"info","ts":"2026-10-02T09:05:47.672916Z","caller":"traceutil/trace.go:171","msg":"trace[978279591] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"118.569692ms","start":"2026-10-02T09:05:47.55432Z","end":"2026-10-02T09:05:47.672889Z","steps":["trace[978279591] 'process raft request' (duration: 118.239653ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:05:47.672986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.600801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T09:05:47.673041Z","caller":"traceutil/trace.go:171","msg":"trace[419603952] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1864; }","duration":"114.697724ms","start":"2026-10-02T09:05:47.558325Z","end":"2026-10-02T09:05:47.673023Z","steps":["trace[419603952] 'agreement among raft nodes before linearized reading' (duration: 114.565171ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:06:02.30479Z","caller":"traceutil/trace.go:171","msg":"trace[1663325494] transaction","detail":"{read_only:false; response_revision:1995; number_of_response:1; }","duration":"230.962744ms","start":"2026-10-02T09:06:02.0738Z","end":"2026-10-02T09:06:02.304763Z","steps":["trace[1663325494] 'process raft request' (duration: 230.77252ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:06:02.320727Z","caller":"traceutil/trace.go:171","msg":"trace[1498831684] transaction","detail":"{read_only:false; response_revision:1996; number_of_response:1; }","duration":"155.577526ms","start":"2026-10-02T09:06:02.165111Z","end":"2026-10-02T09:06:02.320688Z","steps":["trace[1498831684] 'process raft request' (duration: 154.474668ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:06:02.69239Z","caller":"traceutil/trace.go:171","msg":"trace[769455885] transaction","detail":"{read_only:false; response_revision:1998; number_of_response:1; }","duration":"132.366874ms","start":"2026-10-02T09:06:02.559999Z","end":"2026-10-02T09:06:02.692366Z","steps":["trace[769455885] 'process raft request' (duration: 132.20846ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:06:02.694557Z","caller":"traceutil/trace.go:171","msg":"trace[1515309024] transaction","detail":"{read_only:false; response_revision:1999; number_of_response:1; }","duration":"101.008962ms","start":"2026-10-02T09:06:02.593519Z","end":"2026-10-02T09:06:02.694528Z","steps":["trace[1515309024] 'process raft request' (duration: 100.854558ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:06:15.226628Z","caller":"traceutil/trace.go:171","msg":"trace[1908292935] transaction","detail":"{read_only:false; response_revision:2068; number_of_response:1; }","duration":"473.621303ms","start":"2026-10-02T09:06:14.752981Z","end":"2026-10-02T09:06:15.226602Z","steps":["trace[1908292935] 'process raft request' (duration: 473.461089ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:06:15.226811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:06:14.752963Z","time spent":"473.763377ms","remote":"127.0.0.1:48918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-02T09:06:15.265865Z","caller":"traceutil/trace.go:171","msg":"trace[1772289881] transaction","detail":"{read_only:false; response_revision:2069; number_of_response:1; }","duration":"500.993606ms","start":"2026-10-02T09:06:14.764796Z","end":"2026-10-02T09:06:15.265789Z","steps":["trace[1772289881] 'process raft request' (duration: 488.646709ms)","trace[1772289881] 'compare' (duration: 11.945927ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T09:06:15.266041Z","caller":"traceutil/trace.go:171","msg":"trace[995045] linearizableReadLoop","detail":"{readStateIndex:2144; appliedIndex:2141; }","duration":"482.275855ms","start":"2026-10-02T09:06:14.783743Z","end":"2026-10-02T09:06:15.266019Z","steps":["trace[995045] 'read index received' (duration: 442.780751ms)","trace[995045] 'applied index is now lower than readState.Index' (duration: 39.494134ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T09:06:15.266227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:06:14.764762Z","time spent":"501.221302ms","remote":"127.0.0.1:48918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-02T09:06:15.266241Z","caller":"traceutil/trace.go:171","msg":"trace[1197949636] transaction","detail":"{read_only:false; response_revision:2071; number_of_response:1; }","duration":"470.40592ms","start":"2026-10-02T09:06:14.795809Z","end":"2026-10-02T09:06:15.266215Z","steps":["trace[1197949636] 'process raft request' (duration: 470.106423ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:06:15.266441Z","caller":"traceutil/trace.go:171","msg":"trace[762186909] transaction","detail":"{read_only:false; response_revision:2070; number_of_response:1; }","duration":"500.587675ms","start":"2026-10-02T09:06:14.765815Z","end":"2026-10-02T09:06:15.266403Z","steps":["trace[762186909] 'process raft request' (duration: 499.699122ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:06:15.266557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.8182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"warn","ts":"2026-10-02T09:06:15.266594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:06:14.765802Z","time spent":"500.688808ms","remote":"127.0.0.1:48830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12385,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-02T09:06:15.266592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.733357ms","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-02T09:06:15.266618Z","caller":"traceutil/trace.go:171","msg":"trace[261949743] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2071; }","duration":"482.928912ms","start":"2026-10-02T09:06:14.783673Z","end":"2026-10-02T09:06:15.266602Z","steps":["trace[261949743] 'agreement among raft nodes before linearized reading' (duration: 482.692586ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:06:15.266689Z","caller":"traceutil/trace.go:171","msg":"trace[1521707772] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2071; }","duration":"107.84154ms","start":"2026-10-02T09:06:15.158799Z","end":"2026-10-02T09:06:15.266641Z","steps":["trace[1521707772] 'agreement among raft nodes before linearized reading' (duration: 107.620295ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:06:15.266724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:06:14.783632Z","time spent":"483.075136ms","remote":"127.0.0.1:48802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":1876,"request content":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-10-02T09:06:15.26707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.923807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.20\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-10-02T09:06:15.266366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:06:14.79579Z","time spent":"470.511554ms","remote":"127.0.0.1:46120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":831,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-02T09:06:15.267259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.636989ms","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-02T09:06:15.267333Z","caller":"traceutil/trace.go:171","msg":"trace[1846552892] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2071; }","duration":"357.03044ms","start":"2026-10-02T09:06:14.910288Z","end":"2026-10-02T09:06:15.267318Z","steps":["trace[1846552892] 'agreement among raft nodes before linearized reading' (duration: 356.478336ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:06:15.267373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:06:14.910277Z","time spent":"357.083301ms","remote":"127.0.0.1:48918","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":"info","ts":"2026-10-02T09:06:15.267315Z","caller":"traceutil/trace.go:171","msg":"trace[2003505015] range","detail":"{range_begin:/registry/masterleases/162.253.55.20; range_end:; response_count:1; response_revision:2071; }","duration":"468.098961ms","start":"2026-10-02T09:06:14.799081Z","end":"2026-10-02T09:06:15.26718Z","steps":["trace[2003505015] 'agreement among raft nodes before linearized reading' (duration: 467.316611ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:06:15.269197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:06:14.799074Z","time spent":"470.076382ms","remote":"127.0.0.1:46076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/162.253.55.20\" "} {"level":"info","ts":"2026-10-02T09:06:17.34096Z","caller":"traceutil/trace.go:171","msg":"trace[1921042895] transaction","detail":"{read_only:false; response_revision:2084; number_of_response:1; }","duration":"107.611455ms","start":"2026-10-02T09:06:17.233316Z","end":"2026-10-02T09:06:17.340928Z","steps":["trace[1921042895] 'process raft request' (duration: 107.42738ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:06:17.508375Z","caller":"traceutil/trace.go:171","msg":"trace[1169583143] transaction","detail":"{read_only:false; response_revision:2085; number_of_response:1; }","duration":"233.438459ms","start":"2026-10-02T09:06:17.274907Z","end":"2026-10-02T09:06:17.508346Z","steps":["trace[1169583143] 'process raft request' (duration: 233.192183ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:06:17.508528Z","caller":"traceutil/trace.go:171","msg":"trace[1616880397] linearizableReadLoop","detail":"{readStateIndex:2160; appliedIndex:2158; }","duration":"226.662096ms","start":"2026-10-02T09:06:17.28185Z","end":"2026-10-02T09:06:17.508512Z","steps":["trace[1616880397] 'read index received' (duration: 58.868453ms)","trace[1616880397] 'applied index is now lower than readState.Index' (duration: 167.792633ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T09:06:17.508634Z","caller":"traceutil/trace.go:171","msg":"trace[1533078946] transaction","detail":"{read_only:false; response_revision:2086; number_of_response:1; }","duration":"180.698483ms","start":"2026-10-02T09:06:17.327928Z","end":"2026-10-02T09:06:17.508626Z","steps":["trace[1533078946] 'process raft request' (duration: 180.340394ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:06:17.508879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.079376ms","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-02T09:06:17.508913Z","caller":"traceutil/trace.go:171","msg":"trace[687687839] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2086; }","duration":"227.162078ms","start":"2026-10-02T09:06:17.281743Z","end":"2026-10-02T09:06:17.508905Z","steps":["trace[687687839] 'agreement among raft nodes before linearized reading' (duration: 226.971353ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:06:17.509084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.28241ms","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-02T09:06:17.509136Z","caller":"traceutil/trace.go:171","msg":"trace[799245285] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2086; }","duration":"225.358331ms","start":"2026-10-02T09:06:17.283764Z","end":"2026-10-02T09:06:17.509122Z","steps":["trace[799245285] 'agreement among raft nodes before linearized reading' (duration: 225.213657ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:06:24.550554Z","caller":"traceutil/trace.go:171","msg":"trace[1606351154] transaction","detail":"{read_only:false; response_revision:2123; number_of_response:1; }","duration":"160.901275ms","start":"2026-10-02T09:06:24.389624Z","end":"2026-10-02T09:06:24.550525Z","steps":["trace[1606351154] 'process raft request' (duration: 160.72102ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:06:24.880392Z","caller":"traceutil/trace.go:171","msg":"trace[450804980] linearizableReadLoop","detail":"{readStateIndex:2200; appliedIndex:2198; }","duration":"337.625588ms","start":"2026-10-02T09:06:24.542727Z","end":"2026-10-02T09:06:24.880352Z","steps":["trace[450804980] 'read index received' (duration: 7.616556ms)","trace[450804980] 'applied index is now lower than readState.Index' (duration: 330.007102ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T09:06:24.880449Z","caller":"traceutil/trace.go:171","msg":"trace[1016338185] transaction","detail":"{read_only:false; response_revision:2124; number_of_response:1; }","duration":"478.907087ms","start":"2026-10-02T09:06:24.401494Z","end":"2026-10-02T09:06:24.880401Z","steps":["trace[1016338185] 'process raft request' (duration: 441.427552ms)","trace[1016338185] 'compare' (duration: 37.184728ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T09:06:24.880493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.747192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T09:06:24.880568Z","caller":"traceutil/trace.go:171","msg":"trace[1550348537] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2124; }","duration":"337.925086ms","start":"2026-10-02T09:06:24.542621Z","end":"2026-10-02T09:06:24.880546Z","steps":["trace[1550348537] 'agreement among raft nodes before linearized reading' (duration: 337.792333ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:06:24.880624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:06:24.542587Z","time spent":"338.025769ms","remote":"127.0.0.1:46058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-02T09:06:24.880717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:06:24.401478Z","time spent":"479.058711ms","remote":"127.0.0.1:48918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-02T09:06:24.880747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.633786ms","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-02T09:06:24.881059Z","caller":"traceutil/trace.go:171","msg":"trace[1344742390] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2124; }","duration":"314.976165ms","start":"2026-10-02T09:06:24.56606Z","end":"2026-10-02T09:06:24.881037Z","steps":["trace[1344742390] 'agreement among raft nodes before linearized reading' (duration: 314.483832ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:06:24.881132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:06:24.566037Z","time spent":"315.074038ms","remote":"127.0.0.1:41958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-10-02T09:08:02.11341Z","caller":"traceutil/trace.go:171","msg":"trace[1843126679] transaction","detail":"{read_only:false; response_revision:2738; number_of_response:1; }","duration":"210.112043ms","start":"2026-10-02T09:08:01.903264Z","end":"2026-10-02T09:08:02.113376Z","steps":["trace[1843126679] 'process raft request' (duration: 209.939958ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:08:02.165533Z","caller":"traceutil/trace.go:171","msg":"trace[1701826828] transaction","detail":"{read_only:false; response_revision:2739; number_of_response:1; }","duration":"108.470337ms","start":"2026-10-02T09:08:02.057015Z","end":"2026-10-02T09:08:02.165485Z","steps":["trace[1701826828] 'process raft request' (duration: 108.269782ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:08:33.606715Z","caller":"traceutil/trace.go:171","msg":"trace[1443126759] transaction","detail":"{read_only:false; response_revision:2915; number_of_response:1; }","duration":"374.470931ms","start":"2026-10-02T09:08:33.232159Z","end":"2026-10-02T09:08:33.60663Z","steps":["trace[1443126759] 'process raft request' (duration: 374.287726ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:08:33.607083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:08:33.232125Z","time spent":"374.864532ms","remote":"127.0.0.1:48816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-02T09:08:33.611075Z","caller":"traceutil/trace.go:171","msg":"trace[1880745042] transaction","detail":"{read_only:false; response_revision:2917; number_of_response:1; }","duration":"198.022856ms","start":"2026-10-02T09:08:33.413032Z","end":"2026-10-02T09:08:33.611055Z","steps":["trace[1880745042] 'process raft request' (duration: 197.959794ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:08:33.611578Z","caller":"traceutil/trace.go:171","msg":"trace[749654148] transaction","detail":"{read_only:false; response_revision:2916; number_of_response:1; }","duration":"371.829051ms","start":"2026-10-02T09:08:33.239736Z","end":"2026-10-02T09:08:33.611565Z","steps":["trace[749654148] 'process raft request' (duration: 370.944487ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:08:33.611798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:08:33.239703Z","time spent":"371.992095ms","remote":"127.0.0.1:48918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":513,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-02T09:08:38.848408Z","caller":"traceutil/trace.go:171","msg":"trace[1109104867] transaction","detail":"{read_only:false; response_revision:2942; number_of_response:1; }","duration":"129.889397ms","start":"2026-10-02T09:08:38.718485Z","end":"2026-10-02T09:08:38.848374Z","steps":["trace[1109104867] 'process raft request' (duration: 129.674561ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:08:38.988786Z","caller":"traceutil/trace.go:171","msg":"trace[802553782] linearizableReadLoop","detail":"{readStateIndex:3049; appliedIndex:3047; }","duration":"229.629635ms","start":"2026-10-02T09:08:38.759118Z","end":"2026-10-02T09:08:38.988747Z","steps":["trace[802553782] 'read index received' (duration: 89.090807ms)","trace[802553782] 'applied index is now lower than readState.Index' (duration: 140.537178ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T09:08:38.988921Z","caller":"traceutil/trace.go:171","msg":"trace[897320260] transaction","detail":"{read_only:false; response_revision:2943; number_of_response:1; }","duration":"267.621571ms","start":"2026-10-02T09:08:38.721253Z","end":"2026-10-02T09:08:38.988875Z","steps":["trace[897320260] 'process raft request' (duration: 255.729006ms)","trace[897320260] 'compare' (duration: 11.507795ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T09:08:38.989098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.958454ms","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-02T09:08:38.989145Z","caller":"traceutil/trace.go:171","msg":"trace[1606406562] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2943; }","duration":"230.061237ms","start":"2026-10-02T09:08:38.759069Z","end":"2026-10-02T09:08:38.989131Z","steps":["trace[1606406562] 'agreement among raft nodes before linearized reading' (duration: 229.854541ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:10:10.151309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.63645ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-10-02T09:10:10.285674Z","caller":"traceutil/trace.go:171","msg":"trace[342101500] transaction","detail":"{read_only:false; response_revision:3419; number_of_response:1; }","duration":"106.9629ms","start":"2026-10-02T09:10:10.178659Z","end":"2026-10-02T09:10:10.285622Z","steps":["trace[342101500] 'process raft request' (duration: 106.680053ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:13:21.438205Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2852} {"level":"info","ts":"2026-10-02T09:13:21.513595Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2852,"took":"74.101325ms","hash":180025831,"current-db-size-bytes":49774592,"current-db-size":"50 MB","current-db-size-in-use-bytes":25014272,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-10-02T09:13:21.513652Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":180025831,"revision":2852,"compact-revision":-1} {"level":"info","ts":"2026-10-02T09:13:27.697771Z","caller":"traceutil/trace.go:171","msg":"trace[1105508739] transaction","detail":"{read_only:false; response_revision:5094; number_of_response:1; }","duration":"114.671183ms","start":"2026-10-02T09:13:27.583079Z","end":"2026-10-02T09:13:27.697751Z","steps":["trace[1105508739] 'process raft request' (duration: 114.534119ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:13:36.828348Z","caller":"traceutil/trace.go:171","msg":"trace[1723975266] linearizableReadLoop","detail":"{readStateIndex:5460; appliedIndex:5459; }","duration":"314.431746ms","start":"2026-10-02T09:13:36.513875Z","end":"2026-10-02T09:13:36.828307Z","steps":["trace[1723975266] 'read index received' (duration: 314.305882ms)","trace[1723975266] 'applied index is now lower than readState.Index' (duration: 123.764µs)"],"step_count":2} {"level":"info","ts":"2026-10-02T09:13:36.828502Z","caller":"traceutil/trace.go:171","msg":"trace[1663794] transaction","detail":"{read_only:false; response_revision:5265; number_of_response:1; }","duration":"335.742166ms","start":"2026-10-02T09:13:36.492649Z","end":"2026-10-02T09:13:36.828391Z","steps":["trace[1663794] 'process raft request' (duration: 335.459128ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:13:36.828678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:13:36.49263Z","time spent":"335.964132ms","remote":"127.0.0.1:48918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-02T09:13:36.828705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.779785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1429e1e7-aab3-4a5b-8d59-d37d7e64d7c5\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-10-02T09:13:36.828815Z","caller":"traceutil/trace.go:171","msg":"trace[788453646] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1429e1e7-aab3-4a5b-8d59-d37d7e64d7c5; range_end:; response_count:1; response_revision:5265; }","duration":"314.922138ms","start":"2026-10-02T09:13:36.513867Z","end":"2026-10-02T09:13:36.82879Z","steps":["trace[788453646] 'agreement among raft nodes before linearized reading' (duration: 314.567559ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:13:36.828864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:13:36.513806Z","time spent":"315.051532ms","remote":"127.0.0.1:48830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3668,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1429e1e7-aab3-4a5b-8d59-d37d7e64d7c5\" "} {"level":"warn","ts":"2026-10-02T09:13:36.873652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.52814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T09:13:36.873811Z","caller":"traceutil/trace.go:171","msg":"trace[1146788152] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5266; }","duration":"332.744926ms","start":"2026-10-02T09:13:36.541028Z","end":"2026-10-02T09:13:36.873772Z","steps":["trace[1146788152] 'agreement among raft nodes before linearized reading' (duration: 332.356545ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:13:36.873868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T09:13:36.541009Z","time spent":"332.847008ms","remote":"127.0.0.1:46058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-02T09:13:37.421708Z","caller":"traceutil/trace.go:171","msg":"trace[1418092010] transaction","detail":"{read_only:false; response_revision:5272; number_of_response:1; }","duration":"112.320439ms","start":"2026-10-02T09:13:37.309339Z","end":"2026-10-02T09:13:37.421659Z","steps":["trace[1418092010] 'process raft request' (duration: 111.993851ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:13:52.477322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.236025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-10-02T09:13:52.477439Z","caller":"traceutil/trace.go:171","msg":"trace[1257848009] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5463; }","duration":"158.372347ms","start":"2026-10-02T09:13:52.319041Z","end":"2026-10-02T09:13:52.477413Z","steps":["trace[1257848009] 'range keys from in-memory index tree' (duration: 158.053432ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T09:13:52.478164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.712212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16547"} {"level":"info","ts":"2026-10-02T09:13:52.478235Z","caller":"traceutil/trace.go:171","msg":"trace[1507823769] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5463; }","duration":"195.840195ms","start":"2026-10-02T09:13:52.282375Z","end":"2026-10-02T09:13:52.478215Z","steps":["trace[1507823769] 'range keys from in-memory index tree' (duration: 194.713215ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:13:52.60895Z","caller":"traceutil/trace.go:171","msg":"trace[1540823856] transaction","detail":"{read_only:false; response_revision:5465; number_of_response:1; }","duration":"106.123418ms","start":"2026-10-02T09:13:52.502769Z","end":"2026-10-02T09:13:52.608892Z","steps":["trace[1540823856] 'process raft request' (duration: 89.040044ms)","trace[1540823856] 'compare' (duration: 16.759238ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T09:13:52.844263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.322094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone-nodes\" ","response":"range_response_count:1 size:1265"} {"level":"info","ts":"2026-10-02T09:13:52.8444Z","caller":"traceutil/trace.go:171","msg":"trace[1087410258] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone-nodes; range_end:; response_count:1; response_revision:5465; }","duration":"132.547728ms","start":"2026-10-02T09:13:52.711821Z","end":"2026-10-02T09:13:52.844369Z","steps":["trace[1087410258] 'range keys from in-memory index tree' (duration: 132.068489ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:18:21.446409Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":4910} {"level":"info","ts":"2026-10-02T09:18:21.509437Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":4910,"took":"61.074945ms","hash":3320168572,"current-db-size-bytes":49774592,"current-db-size":"50 MB","current-db-size-in-use-bytes":33472512,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-10-02T09:18:21.509537Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3320168572,"revision":4910,"compact-revision":2852} {"level":"info","ts":"2026-10-02T09:21:44.064537Z","caller":"traceutil/trace.go:171","msg":"trace[1174604529] transaction","detail":"{read_only:false; response_revision:8403; number_of_response:1; }","duration":"115.639768ms","start":"2026-10-02T09:21:43.948871Z","end":"2026-10-02T09:21:44.064511Z","steps":["trace[1174604529] 'process raft request' (duration: 115.483674ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:21:44.099072Z","caller":"traceutil/trace.go:171","msg":"trace[1430626928] linearizableReadLoop","detail":"{readStateIndex:8712; appliedIndex:8710; }","duration":"138.120089ms","start":"2026-10-02T09:21:43.960927Z","end":"2026-10-02T09:21:44.099047Z","steps":["trace[1430626928] 'read index received' (duration: 103.406337ms)","trace[1430626928] 'applied index is now lower than readState.Index' (duration: 34.712862ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T09:21:44.099178Z","caller":"traceutil/trace.go:171","msg":"trace[234362995] transaction","detail":"{read_only:false; response_revision:8404; number_of_response:1; }","duration":"150.189515ms","start":"2026-10-02T09:21:43.948952Z","end":"2026-10-02T09:21:44.099141Z","steps":["trace[234362995] 'process raft request' (duration: 121.659605ms)","trace[234362995] 'compare' (duration: 28.348696ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T09:21:44.099463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.481797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/openstack/keystone-openstack-keystone-fernet-rotate\" ","response":"range_response_count:1 size:683"} {"level":"warn","ts":"2026-10-02T09:21:44.099534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.974565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/openstack/keystone-openstack-keystone-domain-manage\" ","response":"range_response_count:1 size:692"} {"level":"info","ts":"2026-10-02T09:21:44.100207Z","caller":"traceutil/trace.go:171","msg":"trace[160623217] range","detail":"{range_begin:/registry/roles/openstack/keystone-openstack-keystone-fernet-rotate; range_end:; response_count:1; response_revision:8404; }","duration":"138.706123ms","start":"2026-10-02T09:21:43.960898Z","end":"2026-10-02T09:21:44.099604Z","steps":["trace[160623217] 'agreement among raft nodes before linearized reading' (duration: 138.329774ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T09:21:44.1005Z","caller":"traceutil/trace.go:171","msg":"trace[616330788] range","detail":"{range_begin:/registry/roles/openstack/keystone-openstack-keystone-domain-manage; range_end:; response_count:1; response_revision:8404; }","duration":"127.111229ms","start":"2026-10-02T09:21:43.972501Z","end":"2026-10-02T09:21:44.099612Z","steps":["trace[616330788] 'agreement among raft nodes before linearized reading' (duration: 126.74853ms)"],"step_count":1}