{"level":"warn","ts":"2026-08-31T07:18:38.937986Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-31T07:18:38.938102Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.69: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.69:2380","--initial-cluster=instance=https://162.253.55.69:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.69:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.69: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-08-31T07:18:38.938194Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-31T07:18:38.938217Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.69:2380"]} {"level":"info","ts":"2026-08-31T07:18:38.938247Z","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-08-31T07:18:38.939394Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.69:2379"]} {"level":"info","ts":"2026-08-31T07:18:38.939549Z","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.69:2380"],"listen-peer-urls":["https://162.253.55.69:2380"],"advertise-client-urls":["https://162.253.55.69:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.69:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.69: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-08-31T07:18:38.950932Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"10.943826ms"} {"level":"info","ts":"2026-08-31T07:18:38.962224Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"905ccde8a677f143","cluster-id":"6fd07fe3af558460"} {"level":"info","ts":"2026-08-31T07:18:38.962317Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 switched to configuration voters=()"} {"level":"info","ts":"2026-08-31T07:18:38.962339Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 became follower at term 0"} {"level":"info","ts":"2026-08-31T07:18:38.962353Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 905ccde8a677f143 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-31T07:18:38.962367Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 became follower at term 1"} {"level":"info","ts":"2026-08-31T07:18:38.962837Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 switched to configuration voters=(10402415638427988291)"} {"level":"warn","ts":"2026-08-31T07:18:38.971436Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-31T07:18:38.972838Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-31T07:18:38.974341Z","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-08-31T07:18:38.976425Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"905ccde8a677f143","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-31T07:18:38.97667Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"905ccde8a677f143","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-31T07:18:38.976682Z","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-08-31T07:18:38.976836Z","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-08-31T07:18:38.976907Z","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-08-31T07:18:38.977596Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 switched to configuration voters=(10402415638427988291)"} {"level":"info","ts":"2026-08-31T07:18:38.977752Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6fd07fe3af558460","local-member-id":"905ccde8a677f143","added-peer-id":"905ccde8a677f143","added-peer-peer-urls":["https://162.253.55.69:2380"]} {"level":"info","ts":"2026-08-31T07:18:38.982286Z","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-08-31T07:18:38.982468Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.69:2380"} {"level":"info","ts":"2026-08-31T07:18:38.982531Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.69:2380"} {"level":"info","ts":"2026-08-31T07:18:38.98311Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"905ccde8a677f143","initial-advertise-peer-urls":["https://162.253.55.69:2380"],"listen-peer-urls":["https://162.253.55.69:2380"],"advertise-client-urls":["https://162.253.55.69:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.69:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-31T07:18:38.983149Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-31T07:18:39.26347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 is starting a new election at term 1"} {"level":"info","ts":"2026-08-31T07:18:39.26354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-31T07:18:39.26367Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 received MsgPreVoteResp from 905ccde8a677f143 at term 1"} {"level":"info","ts":"2026-08-31T07:18:39.263701Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 became candidate at term 2"} {"level":"info","ts":"2026-08-31T07:18:39.263793Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 received MsgVoteResp from 905ccde8a677f143 at term 2"} {"level":"info","ts":"2026-08-31T07:18:39.263957Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 became leader at term 2"} {"level":"info","ts":"2026-08-31T07:18:39.263981Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 905ccde8a677f143 elected leader 905ccde8a677f143 at term 2"} {"level":"info","ts":"2026-08-31T07:18:39.265139Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"905ccde8a677f143","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.69:2379]}","request-path":"/0/members/905ccde8a677f143/attributes","cluster-id":"6fd07fe3af558460","publish-timeout":"7s"} {"level":"info","ts":"2026-08-31T07:18:39.265187Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-31T07:18:39.265651Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-31T07:18:39.266165Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-31T07:18:39.268788Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-31T07:18:39.269017Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-31T07:18:39.269083Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-31T07:18:39.269269Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6fd07fe3af558460","local-member-id":"905ccde8a677f143","cluster-version":"3.5"} {"level":"info","ts":"2026-08-31T07:18:39.269438Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-31T07:18:39.269482Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-31T07:18:39.269692Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.69:2379"} {"level":"info","ts":"2026-08-31T07:18:41.025325Z","caller":"traceutil/trace.go:171","msg":"trace[530315744] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"263.685059ms","start":"2026-08-31T07:18:40.761616Z","end":"2026-08-31T07:18:41.025301Z","steps":["trace[530315744] 'process raft request' (duration: 263.361247ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:18:41.025281Z","caller":"traceutil/trace.go:171","msg":"trace[1801175183] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"262.488035ms","start":"2026-08-31T07:18:40.762771Z","end":"2026-08-31T07:18:41.025259Z","steps":["trace[1801175183] 'read index received' (duration: 262.197474ms)","trace[1801175183] 'applied index is now lower than readState.Index' (duration: 289.621µs)"],"step_count":2} {"level":"warn","ts":"2026-08-31T07:18:41.027468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.626494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-31T07:18:41.027655Z","caller":"traceutil/trace.go:171","msg":"trace[505094585] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:2; }","duration":"264.826201ms","start":"2026-08-31T07:18:40.762743Z","end":"2026-08-31T07:18:41.027569Z","steps":["trace[505094585] 'agreement among raft nodes before linearized reading' (duration: 262.682022ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:18:41.360737Z","caller":"traceutil/trace.go:171","msg":"trace[881035101] linearizableReadLoop","detail":"{readStateIndex:13; appliedIndex:5; }","duration":"335.311203ms","start":"2026-08-31T07:18:41.025402Z","end":"2026-08-31T07:18:41.360714Z","steps":["trace[881035101] 'read index received' (duration: 334.853105ms)","trace[881035101] 'applied index is now lower than readState.Index' (duration: 455.648µs)"],"step_count":2} {"level":"info","ts":"2026-08-31T07:18:41.361139Z","caller":"traceutil/trace.go:171","msg":"trace[1423352196] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"494.854412ms","start":"2026-08-31T07:18:40.866271Z","end":"2026-08-31T07:18:41.361125Z","steps":["trace[1423352196] 'process raft request' (duration: 494.412536ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:18:41.361581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.831758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-31T07:18:41.361712Z","caller":"traceutil/trace.go:171","msg":"trace[1578479546] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"528.026847ms","start":"2026-08-31T07:18:40.833673Z","end":"2026-08-31T07:18:41.3617Z","steps":["trace[1578479546] 'process raft request' (duration: 526.614505ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:18:41.361831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.502148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-31T07:18:41.361921Z","caller":"traceutil/trace.go:171","msg":"trace[1834921056] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"446.580821ms","start":"2026-08-31T07:18:40.915296Z","end":"2026-08-31T07:18:41.361877Z","steps":["trace[1834921056] 'agreement among raft nodes before linearized reading' (duration: 446.455727ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:18:41.362035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:18:40.915279Z","time spent":"446.743298ms","remote":"127.0.0.1:34902","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-08-31T07:18:41.362089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.302938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-31T07:18:41.362157Z","caller":"traceutil/trace.go:171","msg":"trace[2063292813] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"524.388542ms","start":"2026-08-31T07:18:40.837752Z","end":"2026-08-31T07:18:41.36214Z","steps":["trace[2063292813] 'agreement among raft nodes before linearized reading' (duration: 524.258417ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:18:41.362125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:18:40.83366Z","time spent":"528.148512ms","remote":"127.0.0.1:35234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-31T07:18:41.362206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:18:40.837747Z","time spent":"524.447234ms","remote":"127.0.0.1:34902","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-08-31T07:18:41.36236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.798128ms","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-08-31T07:18:41.362409Z","caller":"traceutil/trace.go:171","msg":"trace[752087999] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"527.863401ms","start":"2026-08-31T07:18:40.83453Z","end":"2026-08-31T07:18:41.362394Z","steps":["trace[752087999] 'agreement among raft nodes before linearized reading' (duration: 527.796768ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:18:41.362447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:18:40.834518Z","time spent":"527.917252ms","remote":"127.0.0.1:34884","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-08-31T07:18:41.362667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.393043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.69\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-31T07:18:41.362717Z","caller":"traceutil/trace.go:171","msg":"trace[1296592599] range","detail":"{range_begin:/registry/masterleases/162.253.55.69; range_end:; response_count:0; response_revision:10; }","duration":"527.456065ms","start":"2026-08-31T07:18:40.83525Z","end":"2026-08-31T07:18:41.362706Z","steps":["trace[1296592599] 'agreement among raft nodes before linearized reading' (duration: 527.382992ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:18:41.362754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:18:40.835231Z","time spent":"527.513918ms","remote":"127.0.0.1:34818","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.69\" "} {"level":"info","ts":"2026-08-31T07:18:41.361715Z","caller":"traceutil/trace.go:171","msg":"trace[1812802766] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"522.257131ms","start":"2026-08-31T07:18:40.839426Z","end":"2026-08-31T07:18:41.361683Z","steps":["trace[1812802766] 'process raft request' (duration: 521.105588ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:18:41.362832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.164788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-31T07:18:41.362996Z","caller":"traceutil/trace.go:171","msg":"trace[320966751] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"544.363075ms","start":"2026-08-31T07:18:40.818618Z","end":"2026-08-31T07:18:41.362981Z","steps":["trace[320966751] 'agreement among raft nodes before linearized reading' (duration: 544.146397ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:18:41.363064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:18:40.818602Z","time spent":"544.448469ms","remote":"127.0.0.1:34902","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-08-31T07:18:41.362708Z","caller":"traceutil/trace.go:171","msg":"trace[610064457] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"524.659801ms","start":"2026-08-31T07:18:40.838019Z","end":"2026-08-31T07:18:41.362678Z","steps":["trace[610064457] 'process raft request' (duration: 522.435899ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:18:41.363092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"591.157059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-31T07:18:41.362985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:18:40.839419Z","time spent":"523.440966ms","remote":"127.0.0.1:35292","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-08-31T07:18:41.361657Z","caller":"traceutil/trace.go:171","msg":"trace[1069610465] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"522.813682ms","start":"2026-08-31T07:18:40.838828Z","end":"2026-08-31T07:18:41.361642Z","steps":["trace[1069610465] 'process raft request' (duration: 521.68075ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:18:41.363687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:18:40.838822Z","time spent":"524.788916ms","remote":"127.0.0.1:35292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-31T07:18:41.361621Z","caller":"traceutil/trace.go:171","msg":"trace[1222644697] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"523.172335ms","start":"2026-08-31T07:18:40.83837Z","end":"2026-08-31T07:18:41.361542Z","steps":["trace[1222644697] 'process raft request' (duration: 522.119096ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:18:41.36387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:18:40.838361Z","time spent":"525.48277ms","remote":"127.0.0.1:35292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-31T07:18:41.361726Z","caller":"traceutil/trace.go:171","msg":"trace[264767897] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"543.046167ms","start":"2026-08-31T07:18:40.818663Z","end":"2026-08-31T07:18:41.361709Z","steps":["trace[264767897] 'agreement among raft nodes before linearized reading' (duration: 542.812329ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:18:41.364022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:18:40.81864Z","time spent":"545.373903ms","remote":"127.0.0.1:34902","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-08-31T07:18:41.361558Z","caller":"traceutil/trace.go:171","msg":"trace[733313592] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"514.704831ms","start":"2026-08-31T07:18:40.846077Z","end":"2026-08-31T07:18:41.360782Z","steps":["trace[733313592] 'process raft request' (duration: 514.497304ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:18:41.364106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:18:40.84605Z","time spent":"518.036834ms","remote":"127.0.0.1:34974","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-08-31T07:18:41.361752Z","caller":"traceutil/trace.go:171","msg":"trace[347196728] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"522.270102ms","start":"2026-08-31T07:18:40.839471Z","end":"2026-08-31T07:18:41.361741Z","steps":["trace[347196728] 'process raft request' (duration: 521.083088ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:18:41.364251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:18:40.839467Z","time spent":"524.762054ms","remote":"127.0.0.1:35292","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-08-31T07:18:41.363199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:18:40.838012Z","time spent":"525.165189ms","remote":"127.0.0.1:35292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-31T07:18:41.364476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:18:40.86626Z","time spent":"494.910443ms","remote":"127.0.0.1:35054","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-08-31T07:18:41.364514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.134266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-31T07:18:41.364607Z","caller":"traceutil/trace.go:171","msg":"trace[1242230888] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:0; response_revision:10; }","duration":"332.225408ms","start":"2026-08-31T07:18:41.032331Z","end":"2026-08-31T07:18:41.364556Z","steps":["trace[1242230888] 'agreement among raft nodes before linearized reading' (duration: 329.862052ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:18:41.364665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:18:41.032313Z","time spent":"332.342943ms","remote":"127.0.0.1:34864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":0,"response size":27,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"info","ts":"2026-08-31T07:18:41.364995Z","caller":"traceutil/trace.go:171","msg":"trace[2094493996] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:10; }","duration":"591.358166ms","start":"2026-08-31T07:18:40.771875Z","end":"2026-08-31T07:18:41.363233Z","steps":["trace[2094493996] 'agreement among raft nodes before linearized reading' (duration: 591.167509ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:18:41.365005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.646982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-31T07:18:41.365052Z","caller":"traceutil/trace.go:171","msg":"trace[1827657553] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"472.766517ms","start":"2026-08-31T07:18:40.892271Z","end":"2026-08-31T07:18:41.365038Z","steps":["trace[1827657553] 'agreement among raft nodes before linearized reading' (duration: 472.681353ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:18:41.36508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:18:40.892254Z","time spent":"472.819399ms","remote":"127.0.0.1:34902","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-08-31T07:18:41.365053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:18:40.771829Z","time spent":"593.209445ms","remote":"127.0.0.1:35194","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-08-31T07:19:18.879286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.569373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-31T07:19:18.879363Z","caller":"traceutil/trace.go:171","msg":"trace[685405570] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:587; }","duration":"147.686336ms","start":"2026-08-31T07:19:18.731664Z","end":"2026-08-31T07:19:18.879351Z","steps":["trace[685405570] 'range keys from in-memory index tree' (duration: 147.514782ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:19:18.879297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.576433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-31T07:19:18.879419Z","caller":"traceutil/trace.go:171","msg":"trace[1501109119] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:587; }","duration":"147.728938ms","start":"2026-08-31T07:19:18.731677Z","end":"2026-08-31T07:19:18.879406Z","steps":["trace[1501109119] 'count revisions from in-memory index tree' (duration: 147.538352ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:19:18.879548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.459899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-31T07:19:18.879566Z","caller":"traceutil/trace.go:171","msg":"trace[272334611] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:587; }","duration":"147.490771ms","start":"2026-08-31T07:19:18.732071Z","end":"2026-08-31T07:19:18.879561Z","steps":["trace[272334611] 'range keys from in-memory index tree' (duration: 147.397938ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:19:18.879745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.397368ms","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-08-31T07:19:18.879762Z","caller":"traceutil/trace.go:171","msg":"trace[21953311] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:587; }","duration":"120.42494ms","start":"2026-08-31T07:19:18.759332Z","end":"2026-08-31T07:19:18.879757Z","steps":["trace[21953311] 'count revisions from in-memory index tree' (duration: 120.378638ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:19:18.879806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.329629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:570096"} {"level":"info","ts":"2026-08-31T07:19:18.879839Z","caller":"traceutil/trace.go:171","msg":"trace[101157579] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:587; }","duration":"206.392661ms","start":"2026-08-31T07:19:18.673441Z","end":"2026-08-31T07:19:18.879834Z","steps":["trace[101157579] 'range keys from in-memory index tree' (duration: 206.096883ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:19:18.879846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.567433ms","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-08-31T07:19:18.879862Z","caller":"traceutil/trace.go:171","msg":"trace[400499020] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:587; }","duration":"120.594273ms","start":"2026-08-31T07:19:18.759262Z","end":"2026-08-31T07:19:18.879856Z","steps":["trace[400499020] 'range keys from in-memory index tree' (duration: 120.46279ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:19:18.880015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.84314ms","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-08-31T07:19:18.880037Z","caller":"traceutil/trace.go:171","msg":"trace[200724526] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:587; }","duration":"198.873361ms","start":"2026-08-31T07:19:18.681157Z","end":"2026-08-31T07:19:18.880031Z","steps":["trace[200724526] 'range keys from in-memory index tree' (duration: 198.809809ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:19:18.880151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.777238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-31T07:19:18.880171Z","caller":"traceutil/trace.go:171","msg":"trace[942844799] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:587; }","duration":"198.806069ms","start":"2026-08-31T07:19:18.681361Z","end":"2026-08-31T07:19:18.880167Z","steps":["trace[942844799] 'count revisions from in-memory index tree' (duration: 198.730617ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:19:18.880247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.640324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-31T07:19:18.880266Z","caller":"traceutil/trace.go:171","msg":"trace[1050259699] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:587; }","duration":"195.696796ms","start":"2026-08-31T07:19:18.684562Z","end":"2026-08-31T07:19:18.880258Z","steps":["trace[1050259699] 'range keys from in-memory index tree' (duration: 195.588302ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:19:18.880348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.62688ms","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-08-31T07:19:18.88038Z","caller":"traceutil/trace.go:171","msg":"trace[1115183552] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:587; }","duration":"181.660191ms","start":"2026-08-31T07:19:18.698715Z","end":"2026-08-31T07:19:18.880375Z","steps":["trace[1115183552] 'range keys from in-memory index tree' (duration: 181.548088ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:19:18.880463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.59411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-31T07:19:18.88048Z","caller":"traceutil/trace.go:171","msg":"trace[1972530355] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:587; }","duration":"181.629871ms","start":"2026-08-31T07:19:18.698843Z","end":"2026-08-31T07:19:18.880472Z","steps":["trace[1972530355] 'count revisions from in-memory index tree' (duration: 181.553659ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:19:18.880554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.22541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-31T07:19:18.880568Z","caller":"traceutil/trace.go:171","msg":"trace[1001814898] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:587; }","duration":"181.261492ms","start":"2026-08-31T07:19:18.699302Z","end":"2026-08-31T07:19:18.880564Z","steps":["trace[1001814898] 'range keys from in-memory index tree' (duration: 181.184509ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:19:18.880668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.162918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-31T07:19:18.880698Z","caller":"traceutil/trace.go:171","msg":"trace[1816184381] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:587; }","duration":"166.20261ms","start":"2026-08-31T07:19:18.71449Z","end":"2026-08-31T07:19:18.880693Z","steps":["trace[1816184381] 'count revisions from in-memory index tree' (duration: 166.139388ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:19:18.881123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.694623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-31T07:19:18.881208Z","caller":"traceutil/trace.go:171","msg":"trace[1422504253] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:587; }","duration":"166.811146ms","start":"2026-08-31T07:19:18.71438Z","end":"2026-08-31T07:19:18.881191Z","steps":["trace[1422504253] 'range keys from in-memory index tree' (duration: 166.530428ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:19:18.881328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.181579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-31T07:19:18.881412Z","caller":"traceutil/trace.go:171","msg":"trace[1659934487] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:587; }","duration":"166.288992ms","start":"2026-08-31T07:19:18.715087Z","end":"2026-08-31T07:19:18.881376Z","steps":["trace[1659934487] 'range keys from in-memory index tree' (duration: 166.148239ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:19:19.452245Z","caller":"traceutil/trace.go:171","msg":"trace[1609387015] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"222.896416ms","start":"2026-08-31T07:19:19.229326Z","end":"2026-08-31T07:19:19.452222Z","steps":["trace[1609387015] 'read index received' (duration: 222.728111ms)","trace[1609387015] 'applied index is now lower than readState.Index' (duration: 167.165µs)"],"step_count":2} {"level":"info","ts":"2026-08-31T07:19:19.452301Z","caller":"traceutil/trace.go:171","msg":"trace[1280510867] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"353.917621ms","start":"2026-08-31T07:19:19.098354Z","end":"2026-08-31T07:19:19.452272Z","steps":["trace[1280510867] 'process raft request' (duration: 353.712096ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:19:19.452532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.150602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-31T07:19:19.452631Z","caller":"traceutil/trace.go:171","msg":"trace[1100550518] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:593; }","duration":"223.247105ms","start":"2026-08-31T07:19:19.229318Z","end":"2026-08-31T07:19:19.452565Z","steps":["trace[1100550518] 'agreement among raft nodes before linearized reading' (duration: 223.05253ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:19:19.452772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:19:19.098331Z","time spent":"354.054295ms","remote":"127.0.0.1:34846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-31T07:19:20.583626Z","caller":"traceutil/trace.go:171","msg":"trace[27945238] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"110.694325ms","start":"2026-08-31T07:19:20.472878Z","end":"2026-08-31T07:19:20.583573Z","steps":["trace[27945238] 'process raft request' (duration: 88.072432ms)","trace[27945238] 'compare' (duration: 22.435289ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T07:19:21.64012Z","caller":"traceutil/trace.go:171","msg":"trace[221017199] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"150.722467ms","start":"2026-08-31T07:19:21.489359Z","end":"2026-08-31T07:19:21.640082Z","steps":["trace[221017199] 'process raft request' (duration: 129.554025ms)","trace[221017199] 'compare' (duration: 20.933276ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T07:19:21.910548Z","caller":"traceutil/trace.go:171","msg":"trace[1523919035] linearizableReadLoop","detail":"{readStateIndex:634; appliedIndex:633; }","duration":"156.928169ms","start":"2026-08-31T07:19:21.753601Z","end":"2026-08-31T07:19:21.910529Z","steps":["trace[1523919035] 'read index received' (duration: 75.120277ms)","trace[1523919035] 'applied index is now lower than readState.Index' (duration: 81.807212ms)"],"step_count":2} {"level":"warn","ts":"2026-08-31T07:19:21.910912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.285898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-31T07:19:21.91099Z","caller":"traceutil/trace.go:171","msg":"trace[1635554937] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:614; }","duration":"157.407491ms","start":"2026-08-31T07:19:21.753563Z","end":"2026-08-31T07:19:21.91097Z","steps":["trace[1635554937] 'agreement among raft nodes before linearized reading' (duration: 157.149884ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:19:21.911245Z","caller":"traceutil/trace.go:171","msg":"trace[2014686875] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"183.240285ms","start":"2026-08-31T07:19:21.727994Z","end":"2026-08-31T07:19:21.911234Z","steps":["trace[2014686875] 'process raft request' (duration: 100.873018ms)","trace[2014686875] 'compare' (duration: 81.418692ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T07:19:22.125046Z","caller":"traceutil/trace.go:171","msg":"trace[169294802] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"195.136142ms","start":"2026-08-31T07:19:21.929886Z","end":"2026-08-31T07:19:22.125022Z","steps":["trace[169294802] 'process raft request' (duration: 195.08348ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:19:22.125071Z","caller":"traceutil/trace.go:171","msg":"trace[175118690] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"195.342826ms","start":"2026-08-31T07:19:21.929703Z","end":"2026-08-31T07:19:22.125046Z","steps":["trace[175118690] 'process raft request' (duration: 108.342537ms)","trace[175118690] 'compare' (duration: 86.793124ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T07:19:22.130061Z","caller":"traceutil/trace.go:171","msg":"trace[1506454763] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:635; }","duration":"108.460005ms","start":"2026-08-31T07:19:22.021583Z","end":"2026-08-31T07:19:22.130043Z","steps":["trace[1506454763] 'read index received' (duration: 16.473287ms)","trace[1506454763] 'applied index is now lower than readState.Index' (duration: 91.985948ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T07:19:22.130347Z","caller":"traceutil/trace.go:171","msg":"trace[1421216307] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"115.257161ms","start":"2026-08-31T07:19:22.015067Z","end":"2026-08-31T07:19:22.130324Z","steps":["trace[1421216307] 'process raft request' (duration: 114.832529ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:19:22.13131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.703487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"info","ts":"2026-08-31T07:19:22.131368Z","caller":"traceutil/trace.go:171","msg":"trace[863025469] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:618; }","duration":"109.788109ms","start":"2026-08-31T07:19:22.021564Z","end":"2026-08-31T07:19:22.131352Z","steps":["trace[863025469] 'agreement among raft nodes before linearized reading' (duration: 108.541917ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:19:22.914679Z","caller":"traceutil/trace.go:171","msg":"trace[1591340335] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:641; }","duration":"120.072185ms","start":"2026-08-31T07:19:22.794574Z","end":"2026-08-31T07:19:22.914646Z","steps":["trace[1591340335] 'read index received' (duration: 119.87296ms)","trace[1591340335] 'applied index is now lower than readState.Index' (duration: 198.445µs)"],"step_count":2} {"level":"info","ts":"2026-08-31T07:19:22.91471Z","caller":"traceutil/trace.go:171","msg":"trace[540842847] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"126.678376ms","start":"2026-08-31T07:19:22.788003Z","end":"2026-08-31T07:19:22.914681Z","steps":["trace[540842847] 'process raft request' (duration: 126.504302ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:19:22.914814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.218738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-31T07:19:22.914861Z","caller":"traceutil/trace.go:171","msg":"trace[575078102] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:621; }","duration":"120.325201ms","start":"2026-08-31T07:19:22.794528Z","end":"2026-08-31T07:19:22.914853Z","steps":["trace[575078102] 'agreement among raft nodes before linearized reading' (duration: 120.230979ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:19:22.914966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.655404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-31T07:19:22.915034Z","caller":"traceutil/trace.go:171","msg":"trace[1300088134] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:621; }","duration":"119.779607ms","start":"2026-08-31T07:19:22.795215Z","end":"2026-08-31T07:19:22.914994Z","steps":["trace[1300088134] 'agreement among raft nodes before linearized reading' (duration: 119.643693ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:19:22.915353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.442313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-31T07:19:22.915374Z","caller":"traceutil/trace.go:171","msg":"trace[1030960113] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:621; }","duration":"118.482253ms","start":"2026-08-31T07:19:22.796887Z","end":"2026-08-31T07:19:22.91537Z","steps":["trace[1030960113] 'agreement among raft nodes before linearized reading' (duration: 118.450422ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:19:24.333488Z","caller":"traceutil/trace.go:171","msg":"trace[795552515] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"101.605118ms","start":"2026-08-31T07:19:24.231847Z","end":"2026-08-31T07:19:24.333452Z","steps":["trace[795552515] 'marshal mvccpb.KeyValue' {req_type:put; key:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; req_size:815; } (duration: 91.621254ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:19:27.038934Z","caller":"traceutil/trace.go:171","msg":"trace[1800762511] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"109.34098ms","start":"2026-08-31T07:19:26.929568Z","end":"2026-08-31T07:19:27.038909Z","steps":["trace[1800762511] 'process raft request' (duration: 108.771277ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:19:28.428304Z","caller":"traceutil/trace.go:171","msg":"trace[1364656944] linearizableReadLoop","detail":"{readStateIndex:677; appliedIndex:676; }","duration":"356.675533ms","start":"2026-08-31T07:19:28.071602Z","end":"2026-08-31T07:19:28.428278Z","steps":["trace[1364656944] 'read index received' (duration: 356.55914ms)","trace[1364656944] 'applied index is now lower than readState.Index' (duration: 115.293µs)"],"step_count":2} {"level":"info","ts":"2026-08-31T07:19:28.42839Z","caller":"traceutil/trace.go:171","msg":"trace[565188914] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"597.642211ms","start":"2026-08-31T07:19:27.830711Z","end":"2026-08-31T07:19:28.428353Z","steps":["trace[565188914] 'process raft request' (duration: 597.416795ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:19:28.428544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:19:27.830694Z","time spent":"597.772324ms","remote":"127.0.0.1:35032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-31T07:19:28.428552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.930689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-31T07:19:28.42875Z","caller":"traceutil/trace.go:171","msg":"trace[1097394644] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:655; }","duration":"357.139685ms","start":"2026-08-31T07:19:28.071575Z","end":"2026-08-31T07:19:28.428715Z","steps":["trace[1097394644] 'agreement among raft nodes before linearized reading' (duration: 356.850698ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:19:28.428824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:19:28.071561Z","time spent":"357.235327ms","remote":"127.0.0.1:35058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-31T07:19:28.428885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.749087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-31T07:19:28.429016Z","caller":"traceutil/trace.go:171","msg":"trace[1848755768] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:655; }","duration":"199.916781ms","start":"2026-08-31T07:19:28.229067Z","end":"2026-08-31T07:19:28.428984Z","steps":["trace[1848755768] 'agreement among raft nodes before linearized reading' (duration: 199.483271ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:19:28.42945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.565897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-31T07:19:28.429599Z","caller":"traceutil/trace.go:171","msg":"trace[1303698655] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:655; }","duration":"225.757731ms","start":"2026-08-31T07:19:28.203812Z","end":"2026-08-31T07:19:28.42957Z","steps":["trace[1303698655] 'agreement among raft nodes before linearized reading' (duration: 224.649223ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:19:28.617891Z","caller":"traceutil/trace.go:171","msg":"trace[2087398060] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"181.628237ms","start":"2026-08-31T07:19:28.436231Z","end":"2026-08-31T07:19:28.61786Z","steps":["trace[2087398060] 'process raft request' (duration: 86.00186ms)","trace[2087398060] 'compare' (duration: 95.473474ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T07:19:29.07256Z","caller":"traceutil/trace.go:171","msg":"trace[352414827] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"636.08391ms","start":"2026-08-31T07:19:28.436437Z","end":"2026-08-31T07:19:29.072521Z","steps":["trace[352414827] 'process raft request' (duration: 561.191056ms)","trace[352414827] 'compare' (duration: 74.635478ms)"],"step_count":2} {"level":"warn","ts":"2026-08-31T07:19:29.072975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:19:28.436403Z","time spent":"636.436518ms","remote":"127.0.0.1:35058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-31T07:19:29.073163Z","caller":"traceutil/trace.go:171","msg":"trace[1898889092] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"636.381687ms","start":"2026-08-31T07:19:28.436563Z","end":"2026-08-31T07:19:29.072945Z","steps":["trace[1898889092] 'process raft request' (duration: 635.898585ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:19:29.07322Z","caller":"traceutil/trace.go:171","msg":"trace[44012446] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"624.239017ms","start":"2026-08-31T07:19:28.448957Z","end":"2026-08-31T07:19:29.073196Z","steps":["trace[44012446] 'process raft request' (duration: 623.875928ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:19:29.073238Z","caller":"traceutil/trace.go:171","msg":"trace[1321970106] linearizableReadLoop","detail":"{readStateIndex:680; appliedIndex:677; }","duration":"633.308022ms","start":"2026-08-31T07:19:28.439851Z","end":"2026-08-31T07:19:29.073159Z","steps":["trace[1321970106] 'read index received' (duration: 82.402241ms)","trace[1321970106] 'applied index is now lower than readState.Index' (duration: 550.88285ms)"],"step_count":2} {"level":"warn","ts":"2026-08-31T07:19:29.073383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:19:28.448941Z","time spent":"624.32999ms","remote":"127.0.0.1:34976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-31T07:19:29.073384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:19:28.436534Z","time spent":"636.730815ms","remote":"127.0.0.1:35058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-31T07:19:29.073449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"633.600129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-08-31T07:19:29.073503Z","caller":"traceutil/trace.go:171","msg":"trace[33201373] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:659; }","duration":"633.689502ms","start":"2026-08-31T07:19:28.439799Z","end":"2026-08-31T07:19:29.073488Z","steps":["trace[33201373] 'agreement among raft nodes before linearized reading' (duration: 633.517537ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:19:29.073498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.175562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-31T07:19:29.073549Z","caller":"traceutil/trace.go:171","msg":"trace[1204326999] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:659; }","duration":"386.280985ms","start":"2026-08-31T07:19:28.687251Z","end":"2026-08-31T07:19:29.073532Z","steps":["trace[1204326999] 'agreement among raft nodes before linearized reading' (duration: 386.199193ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:19:29.073541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:19:28.439787Z","time spent":"633.743613ms","remote":"127.0.0.1:34998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-08-31T07:19:29.073598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:19:28.687221Z","time spent":"386.367556ms","remote":"127.0.0.1:34796","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-08-31T07:19:29.615195Z","caller":"traceutil/trace.go:171","msg":"trace[706636831] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"492.660004ms","start":"2026-08-31T07:19:29.122509Z","end":"2026-08-31T07:19:29.615169Z","steps":["trace[706636831] 'process raft request' (duration: 403.306278ms)","trace[706636831] 'compare' (duration: 89.227813ms)"],"step_count":2} {"level":"warn","ts":"2026-08-31T07:19:29.615836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:19:29.122479Z","time spent":"493.28764ms","remote":"127.0.0.1:34880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-31T07:19:30.090696Z","caller":"traceutil/trace.go:171","msg":"trace[213760837] linearizableReadLoop","detail":"{readStateIndex:687; appliedIndex:682; }","duration":"842.881162ms","start":"2026-08-31T07:19:29.247792Z","end":"2026-08-31T07:19:30.090673Z","steps":["trace[213760837] 'read index received' (duration: 278.035757ms)","trace[213760837] 'applied index is now lower than readState.Index' (duration: 564.844435ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T07:19:30.090913Z","caller":"traceutil/trace.go:171","msg":"trace[699256407] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"967.824544ms","start":"2026-08-31T07:19:29.123074Z","end":"2026-08-31T07:19:30.090898Z","steps":["trace[699256407] 'process raft request' (duration: 872.530756ms)","trace[699256407] 'compare' (duration: 94.382897ms)"],"step_count":2} {"level":"warn","ts":"2026-08-31T07:19:30.091111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:19:29.123053Z","time spent":"967.985729ms","remote":"127.0.0.1:34880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-31T07:19:30.091353Z","caller":"traceutil/trace.go:171","msg":"trace[499535252] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"968.027269ms","start":"2026-08-31T07:19:29.123299Z","end":"2026-08-31T07:19:30.091326Z","steps":["trace[499535252] 'process raft request' (duration: 967.134758ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:19:30.091355Z","caller":"traceutil/trace.go:171","msg":"trace[641995630] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"966.535102ms","start":"2026-08-31T07:19:29.124784Z","end":"2026-08-31T07:19:30.091319Z","steps":["trace[641995630] 'process raft request' (duration: 965.838516ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:19:30.091423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.01875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-31T07:19:30.091483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:19:29.123258Z","time spent":"968.155444ms","remote":"127.0.0.1:35058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-31T07:19:30.091492Z","caller":"traceutil/trace.go:171","msg":"trace[223452411] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:665; }","duration":"404.140184ms","start":"2026-08-31T07:19:29.687333Z","end":"2026-08-31T07:19:30.091473Z","steps":["trace[223452411] 'agreement among raft nodes before linearized reading' (duration: 404.035661ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:19:30.091525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:19:29.12477Z","time spent":"966.659607ms","remote":"127.0.0.1:34976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-31T07:19:30.091544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:19:29.687308Z","time spent":"404.224525ms","remote":"127.0.0.1:34784","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-08-31T07:19:30.091676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"843.823416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-31T07:19:30.09183Z","caller":"traceutil/trace.go:171","msg":"trace[1999152246] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:665; }","duration":"844.055832ms","start":"2026-08-31T07:19:29.247737Z","end":"2026-08-31T07:19:30.091793Z","steps":["trace[1999152246] 'agreement among raft nodes before linearized reading' (duration: 843.549639ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:19:30.091887Z","caller":"traceutil/trace.go:171","msg":"trace[1368501532] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"967.783343ms","start":"2026-08-31T07:19:29.124088Z","end":"2026-08-31T07:19:30.091871Z","steps":["trace[1368501532] 'process raft request' (duration: 966.475581ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:19:30.092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:19:29.12407Z","time spent":"967.887075ms","remote":"127.0.0.1:35032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-31T07:19:30.091939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:19:29.247719Z","time spent":"844.205435ms","remote":"127.0.0.1:35058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-31T07:19:31.188782Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17384915280747591886,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-31T07:19:31.469863Z","caller":"traceutil/trace.go:171","msg":"trace[612622731] linearizableReadLoop","detail":"{readStateIndex:689; appliedIndex:688; }","duration":"782.053121ms","start":"2026-08-31T07:19:30.687786Z","end":"2026-08-31T07:19:31.469839Z","steps":["trace[612622731] 'read index received' (duration: 781.868556ms)","trace[612622731] 'applied index is now lower than readState.Index' (duration: 183.275µs)"],"step_count":2} {"level":"info","ts":"2026-08-31T07:19:31.469927Z","caller":"traceutil/trace.go:171","msg":"trace[1213525814] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"841.81095ms","start":"2026-08-31T07:19:30.628084Z","end":"2026-08-31T07:19:31.469895Z","steps":["trace[1213525814] 'process raft request' (duration: 841.593945ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:19:31.470043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"782.235246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-31T07:19:31.470125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.969557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-31T07:19:31.470181Z","caller":"traceutil/trace.go:171","msg":"trace[2005079929] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:667; }","duration":"392.085449ms","start":"2026-08-31T07:19:31.078085Z","end":"2026-08-31T07:19:31.47017Z","steps":["trace[2005079929] 'agreement among raft nodes before linearized reading' (duration: 391.891425ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:19:31.470179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.907155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-08-31T07:19:31.470227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:19:31.078063Z","time spent":"392.155841ms","remote":"127.0.0.1:35058","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":"info","ts":"2026-08-31T07:19:31.470264Z","caller":"traceutil/trace.go:171","msg":"trace[265586876] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:667; }","duration":"392.078809ms","start":"2026-08-31T07:19:31.078167Z","end":"2026-08-31T07:19:31.470246Z","steps":["trace[265586876] 'agreement among raft nodes before linearized reading' (duration: 391.876344ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:19:31.47031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:19:31.078114Z","time spent":"392.188532ms","remote":"127.0.0.1:35058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-31T07:19:31.470171Z","caller":"traceutil/trace.go:171","msg":"trace[1287380362] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:667; }","duration":"782.402929ms","start":"2026-08-31T07:19:30.687721Z","end":"2026-08-31T07:19:31.470124Z","steps":["trace[1287380362] 'agreement among raft nodes before linearized reading' (duration: 782.215855ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:19:31.470426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:19:30.687689Z","time spent":"782.689356ms","remote":"127.0.0.1:34784","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-08-31T07:19:31.470082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:19:30.628056Z","time spent":"841.938022ms","remote":"127.0.0.1:35058","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-08-31T07:19:31.779375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.200631ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-31T07:19:31.77957Z","caller":"traceutil/trace.go:171","msg":"trace[1116067949] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"304.355522ms","start":"2026-08-31T07:19:31.475181Z","end":"2026-08-31T07:19:31.779537Z","steps":["trace[1116067949] 'process raft request' (duration: 304.28971ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:19:31.779611Z","caller":"traceutil/trace.go:171","msg":"trace[69370125] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"305.08846ms","start":"2026-08-31T07:19:31.47449Z","end":"2026-08-31T07:19:31.779579Z","steps":["trace[69370125] 'process raft request' (duration: 131.412658ms)","trace[69370125] 'compare' (duration: 173.059667ms)"],"step_count":2} {"level":"warn","ts":"2026-08-31T07:19:31.779654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:19:31.475168Z","time spent":"304.444053ms","remote":"127.0.0.1:35058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-31T07:19:31.779765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:19:31.474471Z","time spent":"305.205742ms","remote":"127.0.0.1:35058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-31T07:19:48.041248Z","caller":"traceutil/trace.go:171","msg":"trace[196837748] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"175.697003ms","start":"2026-08-31T07:19:47.86553Z","end":"2026-08-31T07:19:48.041227Z","steps":["trace[196837748] 'process raft request' (duration: 175.516238ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:19:48.057725Z","caller":"traceutil/trace.go:171","msg":"trace[920803873] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"189.461922ms","start":"2026-08-31T07:19:47.868233Z","end":"2026-08-31T07:19:48.057695Z","steps":["trace[920803873] 'process raft request' (duration: 187.653473ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:20:18.215556Z","caller":"traceutil/trace.go:171","msg":"trace[577654826] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"105.14137ms","start":"2026-08-31T07:20:18.110379Z","end":"2026-08-31T07:20:18.215521Z","steps":["trace[577654826] 'process raft request' (duration: 38.547723ms)","trace[577654826] 'compare' (duration: 66.402553ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T07:20:18.247443Z","caller":"traceutil/trace.go:171","msg":"trace[1837646006] transaction","detail":"{read_only:false; response_revision:1180; number_of_response:1; }","duration":"136.262442ms","start":"2026-08-31T07:20:18.111155Z","end":"2026-08-31T07:20:18.247417Z","steps":["trace[1837646006] 'process raft request' (duration: 136.072549ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:20:18.247645Z","caller":"traceutil/trace.go:171","msg":"trace[700753009] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"135.270643ms","start":"2026-08-31T07:20:18.11234Z","end":"2026-08-31T07:20:18.24761Z","steps":["trace[700753009] 'process raft request' (duration: 135.019218ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:20:18.921285Z","caller":"traceutil/trace.go:171","msg":"trace[1372706683] transaction","detail":"{read_only:false; response_revision:1187; number_of_response:1; }","duration":"156.305408ms","start":"2026-08-31T07:20:18.764948Z","end":"2026-08-31T07:20:18.921254Z","steps":["trace[1372706683] 'process raft request' (duration: 156.126674ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:21:13.390062Z","caller":"traceutil/trace.go:171","msg":"trace[694384090] linearizableReadLoop","detail":"{readStateIndex:1965; appliedIndex:1964; }","duration":"125.645406ms","start":"2026-08-31T07:21:13.264389Z","end":"2026-08-31T07:21:13.390035Z","steps":["trace[694384090] 'read index received' (duration: 125.450133ms)","trace[694384090] 'applied index is now lower than readState.Index' (duration: 193.703µs)"],"step_count":2} {"level":"info","ts":"2026-08-31T07:21:13.390182Z","caller":"traceutil/trace.go:171","msg":"trace[1180301771] transaction","detail":"{read_only:false; response_revision:1894; number_of_response:1; }","duration":"175.17255ms","start":"2026-08-31T07:21:13.214985Z","end":"2026-08-31T07:21:13.390158Z","steps":["trace[1180301771] 'process raft request' (duration: 174.875566ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:21:13.390294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.88032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-188f1e8e-c500-4d85-901c-87c33399566e\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-08-31T07:21:13.390364Z","caller":"traceutil/trace.go:171","msg":"trace[1716864669] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-188f1e8e-c500-4d85-901c-87c33399566e; range_end:; response_count:1; response_revision:1894; }","duration":"125.978223ms","start":"2026-08-31T07:21:13.264347Z","end":"2026-08-31T07:21:13.390325Z","steps":["trace[1716864669] 'agreement among raft nodes before linearized reading' (duration: 125.80371ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:21:13.786016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.39168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-31T07:21:13.78612Z","caller":"traceutil/trace.go:171","msg":"trace[989630225] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:1894; }","duration":"195.576973ms","start":"2026-08-31T07:21:13.590518Z","end":"2026-08-31T07:21:13.786095Z","steps":["trace[989630225] 'count revisions from in-memory index tree' (duration: 195.285117ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:21:14.350352Z","caller":"traceutil/trace.go:171","msg":"trace[1098191615] linearizableReadLoop","detail":"{readStateIndex:1966; appliedIndex:1965; }","duration":"261.998734ms","start":"2026-08-31T07:21:14.088333Z","end":"2026-08-31T07:21:14.350331Z","steps":["trace[1098191615] 'read index received' (duration: 261.948864ms)","trace[1098191615] 'applied index is now lower than readState.Index' (duration: 48.86µs)"],"step_count":2} {"level":"info","ts":"2026-08-31T07:21:14.3505Z","caller":"traceutil/trace.go:171","msg":"trace[904368017] transaction","detail":"{read_only:false; response_revision:1895; number_of_response:1; }","duration":"361.722508ms","start":"2026-08-31T07:21:13.988726Z","end":"2026-08-31T07:21:14.350449Z","steps":["trace[904368017] 'process raft request' (duration: 361.464894ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:21:14.350627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.272738ms","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-08-31T07:21:14.350672Z","caller":"traceutil/trace.go:171","msg":"trace[1793539374] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1895; }","duration":"262.39294ms","start":"2026-08-31T07:21:14.088266Z","end":"2026-08-31T07:21:14.350659Z","steps":["trace[1793539374] 'agreement among raft nodes before linearized reading' (duration: 262.177077ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:21:14.350718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:21:13.988704Z","time spent":"361.90194ms","remote":"127.0.0.1:34976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3728,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-31T07:21:14.374822Z","caller":"traceutil/trace.go:171","msg":"trace[759514089] transaction","detail":"{read_only:false; response_revision:1896; number_of_response:1; }","duration":"225.454648ms","start":"2026-08-31T07:21:14.149332Z","end":"2026-08-31T07:21:14.374786Z","steps":["trace[759514089] 'process raft request' (duration: 225.03639ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:21:14.37543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.655109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-31T07:21:14.375512Z","caller":"traceutil/trace.go:171","msg":"trace[152644135] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1897; }","duration":"261.901192ms","start":"2026-08-31T07:21:14.113593Z","end":"2026-08-31T07:21:14.375494Z","steps":["trace[152644135] 'agreement among raft nodes before linearized reading' (duration: 261.545137ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:21:14.375642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.370495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-31T07:21:14.375709Z","caller":"traceutil/trace.go:171","msg":"trace[135485033] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1897; }","duration":"230.524057ms","start":"2026-08-31T07:21:14.145167Z","end":"2026-08-31T07:21:14.375691Z","steps":["trace[135485033] 'agreement among raft nodes before linearized reading' (duration: 230.360185ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:21:20.802699Z","caller":"traceutil/trace.go:171","msg":"trace[565189919] transaction","detail":"{read_only:false; response_revision:1963; number_of_response:1; }","duration":"120.249605ms","start":"2026-08-31T07:21:20.682399Z","end":"2026-08-31T07:21:20.802649Z","steps":["trace[565189919] 'process raft request' (duration: 119.970299ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:21:26.899386Z","caller":"traceutil/trace.go:171","msg":"trace[1176222628] linearizableReadLoop","detail":"{readStateIndex:2083; appliedIndex:2082; }","duration":"212.387106ms","start":"2026-08-31T07:21:26.686974Z","end":"2026-08-31T07:21:26.899361Z","steps":["trace[1176222628] 'read index received' (duration: 212.130152ms)","trace[1176222628] 'applied index is now lower than readState.Index' (duration: 255.844µs)"],"step_count":2} {"level":"info","ts":"2026-08-31T07:21:26.899498Z","caller":"traceutil/trace.go:171","msg":"trace[531418005] transaction","detail":"{read_only:false; response_revision:2009; number_of_response:1; }","duration":"339.710359ms","start":"2026-08-31T07:21:26.55976Z","end":"2026-08-31T07:21:26.89947Z","steps":["trace[531418005] 'process raft request' (duration: 339.441186ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:21:26.899646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:21:26.559743Z","time spent":"339.825261ms","remote":"127.0.0.1:35058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-31T07:21:26.90016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.579919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-31T07:21:26.900217Z","caller":"traceutil/trace.go:171","msg":"trace[1137730899] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2009; }","duration":"213.264148ms","start":"2026-08-31T07:21:26.686935Z","end":"2026-08-31T07:21:26.900199Z","steps":["trace[1137730899] 'agreement among raft nodes before linearized reading' (duration: 212.584328ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:21:42.599136Z","caller":"traceutil/trace.go:171","msg":"trace[1632154849] transaction","detail":"{read_only:false; response_revision:2100; number_of_response:1; }","duration":"118.719905ms","start":"2026-08-31T07:21:42.480397Z","end":"2026-08-31T07:21:42.599117Z","steps":["trace[1632154849] 'process raft request' (duration: 118.608424ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:21:42.599203Z","caller":"traceutil/trace.go:171","msg":"trace[1557073845] linearizableReadLoop","detail":"{readStateIndex:2177; appliedIndex:2177; }","duration":"109.428715ms","start":"2026-08-31T07:21:42.489742Z","end":"2026-08-31T07:21:42.599171Z","steps":["trace[1557073845] 'read index received' (duration: 109.395575ms)","trace[1557073845] 'applied index is now lower than readState.Index' (duration: 31.3µs)"],"step_count":2} {"level":"warn","ts":"2026-08-31T07:21:42.599506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.7418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.69\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-08-31T07:21:42.599553Z","caller":"traceutil/trace.go:171","msg":"trace[2147193187] range","detail":"{range_begin:/registry/masterleases/162.253.55.69; range_end:; response_count:1; response_revision:2100; }","duration":"109.831311ms","start":"2026-08-31T07:21:42.489709Z","end":"2026-08-31T07:21:42.59954Z","steps":["trace[2147193187] 'agreement among raft nodes before linearized reading' (duration: 109.615788ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:21:42.615732Z","caller":"traceutil/trace.go:171","msg":"trace[310339099] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"125.981974ms","start":"2026-08-31T07:21:42.489737Z","end":"2026-08-31T07:21:42.615719Z","steps":["trace[310339099] 'process raft request' (duration: 125.70423ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:21:42.615823Z","caller":"traceutil/trace.go:171","msg":"trace[332643591] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"104.40318ms","start":"2026-08-31T07:21:42.511412Z","end":"2026-08-31T07:21:42.615815Z","steps":["trace[332643591] 'process raft request' (duration: 104.101656ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:21:48.156005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.082753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-31T07:21:48.156091Z","caller":"traceutil/trace.go:171","msg":"trace[920286004] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:2132; }","duration":"159.216685ms","start":"2026-08-31T07:21:47.996855Z","end":"2026-08-31T07:21:48.156072Z","steps":["trace[920286004] 'count revisions from in-memory index tree' (duration: 158.996552ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:21:48.981291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.487209ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-31T07:21:48.981548Z","caller":"traceutil/trace.go:171","msg":"trace[357070925] linearizableReadLoop","detail":"{readStateIndex:2215; appliedIndex:2214; }","duration":"231.295419ms","start":"2026-08-31T07:21:48.750227Z","end":"2026-08-31T07:21:48.981523Z","steps":["trace[357070925] 'read index received' (duration: 87.384204ms)","trace[357070925] 'applied index is now lower than readState.Index' (duration: 143.909305ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T07:21:48.981776Z","caller":"traceutil/trace.go:171","msg":"trace[745396042] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"269.338037ms","start":"2026-08-31T07:21:48.71233Z","end":"2026-08-31T07:21:48.981668Z","steps":["trace[745396042] 'process raft request' (duration: 125.33451ms)","trace[745396042] 'compare' (duration: 143.363107ms)"],"step_count":2} {"level":"warn","ts":"2026-08-31T07:21:48.981771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.552024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-31T07:21:48.981828Z","caller":"traceutil/trace.go:171","msg":"trace[1021239441] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:2137; }","duration":"231.629045ms","start":"2026-08-31T07:21:48.750179Z","end":"2026-08-31T07:21:48.981808Z","steps":["trace[1021239441] 'agreement among raft nodes before linearized reading' (duration: 231.534064ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:21:48.981915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.002125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1986"} {"level":"info","ts":"2026-08-31T07:21:48.982005Z","caller":"traceutil/trace.go:171","msg":"trace[588667758] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:2137; }","duration":"127.131347ms","start":"2026-08-31T07:21:48.854849Z","end":"2026-08-31T07:21:48.981981Z","steps":["trace[588667758] 'agreement among raft nodes before linearized reading' (duration: 126.870473ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:21:49.612952Z","caller":"traceutil/trace.go:171","msg":"trace[1544729119] transaction","detail":"{read_only:false; response_revision:2139; number_of_response:1; }","duration":"496.581097ms","start":"2026-08-31T07:21:49.116339Z","end":"2026-08-31T07:21:49.61292Z","steps":["trace[1544729119] 'process raft request' (duration: 496.162621ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:21:49.613315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:21:49.116314Z","time spent":"496.713009ms","remote":"127.0.0.1:35058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-31T07:21:49.863566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.866147ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-31T07:21:49.863717Z","caller":"traceutil/trace.go:171","msg":"trace[29931882] linearizableReadLoop","detail":"{readStateIndex:2221; appliedIndex:2218; }","duration":"170.359878ms","start":"2026-08-31T07:21:49.693344Z","end":"2026-08-31T07:21:49.863704Z","steps":["trace[29931882] 'read index received' (duration: 46.72µs)","trace[29931882] 'applied index is now lower than readState.Index' (duration: 170.312438ms)"],"step_count":2} {"level":"warn","ts":"2026-08-31T07:21:49.863836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.494971ms","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-08-31T07:21:49.863862Z","caller":"traceutil/trace.go:171","msg":"trace[344749559] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2142; }","duration":"170.546971ms","start":"2026-08-31T07:21:49.693307Z","end":"2026-08-31T07:21:49.863854Z","steps":["trace[344749559] 'agreement among raft nodes before linearized reading' (duration: 170.435539ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:21:49.864179Z","caller":"traceutil/trace.go:171","msg":"trace[2127616738] transaction","detail":"{read_only:false; response_revision:2140; number_of_response:1; }","duration":"747.773849ms","start":"2026-08-31T07:21:49.116393Z","end":"2026-08-31T07:21:49.864167Z","steps":["trace[2127616738] 'process raft request' (duration: 541.243572ms)","trace[2127616738] 'compare' (duration: 205.624044ms)"],"step_count":2} {"level":"warn","ts":"2026-08-31T07:21:49.864245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:21:49.116375Z","time spent":"747.84366ms","remote":"127.0.0.1:35058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-31T07:21:49.86434Z","caller":"traceutil/trace.go:171","msg":"trace[695763030] transaction","detail":"{read_only:false; response_revision:2142; number_of_response:1; }","duration":"345.223333ms","start":"2026-08-31T07:21:49.519083Z","end":"2026-08-31T07:21:49.864306Z","steps":["trace[695763030] 'process raft request' (duration: 344.586903ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:21:49.864354Z","caller":"traceutil/trace.go:171","msg":"trace[330384600] transaction","detail":"{read_only:false; response_revision:2141; number_of_response:1; }","duration":"747.607757ms","start":"2026-08-31T07:21:49.116734Z","end":"2026-08-31T07:21:49.864342Z","steps":["trace[330384600] 'process raft request' (duration: 746.897706ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:21:49.864442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:21:49.116725Z","time spent":"747.671628ms","remote":"127.0.0.1:35058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-31T07:21:49.864466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:21:49.519063Z","time spent":"345.333985ms","remote":"127.0.0.1:35058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-31T07:23:10.110933Z","caller":"traceutil/trace.go:171","msg":"trace[1196033591] transaction","detail":"{read_only:false; response_revision:2668; number_of_response:1; }","duration":"110.64056ms","start":"2026-08-31T07:23:10.000268Z","end":"2026-08-31T07:23:10.110908Z","steps":["trace[1196033591] 'process raft request' (duration: 110.457415ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:23:39.77532Z","caller":"traceutil/trace.go:171","msg":"trace[334666261] linearizableReadLoop","detail":"{readStateIndex:2938; appliedIndex:2937; }","duration":"196.008171ms","start":"2026-08-31T07:23:39.579288Z","end":"2026-08-31T07:23:39.775296Z","steps":["trace[334666261] 'read index received' (duration: 195.729305ms)","trace[334666261] 'applied index is now lower than readState.Index' (duration: 277.996µs)"],"step_count":2} {"level":"info","ts":"2026-08-31T07:23:39.775527Z","caller":"traceutil/trace.go:171","msg":"trace[922508713] transaction","detail":"{read_only:false; response_revision:2834; number_of_response:1; }","duration":"207.773795ms","start":"2026-08-31T07:23:39.567569Z","end":"2026-08-31T07:23:39.775343Z","steps":["trace[922508713] 'process raft request' (duration: 207.55294ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:23:39.775557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.240996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-08-31T07:23:39.775732Z","caller":"traceutil/trace.go:171","msg":"trace[450128825] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2834; }","duration":"196.487821ms","start":"2026-08-31T07:23:39.579227Z","end":"2026-08-31T07:23:39.775715Z","steps":["trace[450128825] 'agreement among raft nodes before linearized reading' (duration: 196.162034ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:23:45.425191Z","caller":"traceutil/trace.go:171","msg":"trace[1535370559] transaction","detail":"{read_only:false; response_revision:2865; number_of_response:1; }","duration":"193.84474ms","start":"2026-08-31T07:23:45.231283Z","end":"2026-08-31T07:23:45.425128Z","steps":["trace[1535370559] 'process raft request' (duration: 97.211121ms)","trace[1535370559] 'compare' (duration: 96.410504ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T07:24:46.768222Z","caller":"traceutil/trace.go:171","msg":"trace[1968506467] transaction","detail":"{read_only:false; response_revision:3184; number_of_response:1; }","duration":"107.740056ms","start":"2026-08-31T07:24:46.660437Z","end":"2026-08-31T07:24:46.768177Z","steps":["trace[1968506467] 'process raft request' (duration: 107.526342ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:28:29.43912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.857146ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-31T07:28:29.43923Z","caller":"traceutil/trace.go:171","msg":"trace[289081577] linearizableReadLoop","detail":"{readStateIndex:5225; appliedIndex:5224; }","duration":"183.196071ms","start":"2026-08-31T07:28:29.25602Z","end":"2026-08-31T07:28:29.439216Z","steps":["trace[289081577] 'read index received' (duration: 27.6µs)","trace[289081577] 'applied index is now lower than readState.Index' (duration: 183.167481ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T07:28:29.439291Z","caller":"traceutil/trace.go:171","msg":"trace[33507144] transaction","detail":"{read_only:false; response_revision:5033; number_of_response:1; }","duration":"220.059731ms","start":"2026-08-31T07:28:29.219223Z","end":"2026-08-31T07:28:29.439283Z","steps":["trace[33507144] 'process raft request' (duration: 28.991742ms)","trace[33507144] 'compare' (duration: 190.699163ms)"],"step_count":2} {"level":"warn","ts":"2026-08-31T07:28:29.439423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.096699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-31T07:28:29.439472Z","caller":"traceutil/trace.go:171","msg":"trace[1184385707] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:5033; }","duration":"116.182141ms","start":"2026-08-31T07:28:29.323276Z","end":"2026-08-31T07:28:29.439458Z","steps":["trace[1184385707] 'agreement among raft nodes before linearized reading' (duration: 116.069179ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:28:29.439705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.685919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-08-31T07:28:29.439727Z","caller":"traceutil/trace.go:171","msg":"trace[412628387] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5033; }","duration":"183.73355ms","start":"2026-08-31T07:28:29.255986Z","end":"2026-08-31T07:28:29.43972Z","steps":["trace[412628387] 'agreement among raft nodes before linearized reading' (duration: 183.672239ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:28:29.613622Z","caller":"traceutil/trace.go:171","msg":"trace[637464611] transaction","detail":"{read_only:false; response_revision:5034; number_of_response:1; }","duration":"169.062222ms","start":"2026-08-31T07:28:29.444507Z","end":"2026-08-31T07:28:29.61357Z","steps":["trace[637464611] 'process raft request' (duration: 137.491978ms)","trace[637464611] 'compare' (duration: 31.174587ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T07:28:34.568869Z","caller":"traceutil/trace.go:171","msg":"trace[1168844733] transaction","detail":"{read_only:false; response_revision:5133; number_of_response:1; }","duration":"117.498819ms","start":"2026-08-31T07:28:34.451346Z","end":"2026-08-31T07:28:34.568844Z","steps":["trace[1168844733] 'process raft request' (duration: 86.936122ms)","trace[1168844733] 'compare' (duration: 30.14535ms)"],"step_count":2} {"level":"warn","ts":"2026-08-31T07:28:34.816759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.649862ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-31T07:28:34.816905Z","caller":"traceutil/trace.go:171","msg":"trace[626755262] linearizableReadLoop","detail":"{readStateIndex:5330; appliedIndex:5329; }","duration":"128.612669ms","start":"2026-08-31T07:28:34.688271Z","end":"2026-08-31T07:28:34.816884Z","steps":["trace[626755262] 'read index received' (duration: 18.619352ms)","trace[626755262] 'applied index is now lower than readState.Index' (duration: 109.991827ms)"],"step_count":2} {"level":"warn","ts":"2026-08-31T07:28:34.816984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.712271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-31T07:28:34.817025Z","caller":"traceutil/trace.go:171","msg":"trace[1555947739] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5136; }","duration":"128.788002ms","start":"2026-08-31T07:28:34.688224Z","end":"2026-08-31T07:28:34.817012Z","steps":["trace[1555947739] 'agreement among raft nodes before linearized reading' (duration: 128.715091ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:28:34.817219Z","caller":"traceutil/trace.go:171","msg":"trace[1777757193] transaction","detail":"{read_only:false; response_revision:5136; number_of_response:1; }","duration":"140.690845ms","start":"2026-08-31T07:28:34.676478Z","end":"2026-08-31T07:28:34.817169Z","steps":["trace[1777757193] 'process raft request' (duration: 30.358272ms)","trace[1777757193] 'compare' (duration: 109.50392ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T07:28:35.323459Z","caller":"traceutil/trace.go:171","msg":"trace[917714082] transaction","detail":"{read_only:false; response_revision:5139; number_of_response:1; }","duration":"236.548582ms","start":"2026-08-31T07:28:35.086879Z","end":"2026-08-31T07:28:35.323428Z","steps":["trace[917714082] 'process raft request' (duration: 205.366665ms)","trace[917714082] 'compare' (duration: 30.939423ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T07:28:35.323782Z","caller":"traceutil/trace.go:171","msg":"trace[1204769579] linearizableReadLoop","detail":"{readStateIndex:5334; appliedIndex:5332; }","duration":"236.325289ms","start":"2026-08-31T07:28:35.087408Z","end":"2026-08-31T07:28:35.323733Z","steps":["trace[1204769579] 'read index received' (duration: 204.846047ms)","trace[1204769579] 'applied index is now lower than readState.Index' (duration: 31.476362ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T07:28:35.323874Z","caller":"traceutil/trace.go:171","msg":"trace[257907067] transaction","detail":"{read_only:false; response_revision:5140; number_of_response:1; }","duration":"236.634664ms","start":"2026-08-31T07:28:35.087222Z","end":"2026-08-31T07:28:35.323857Z","steps":["trace[257907067] 'process raft request' (duration: 236.134676ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:28:35.324067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.639733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7d704277-1c3b-4edc-9609-d71fa16889d7\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-08-31T07:28:35.324126Z","caller":"traceutil/trace.go:171","msg":"trace[851572919] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7d704277-1c3b-4edc-9609-d71fa16889d7; range_end:; response_count:1; response_revision:5140; }","duration":"236.756986ms","start":"2026-08-31T07:28:35.087352Z","end":"2026-08-31T07:28:35.324109Z","steps":["trace[851572919] 'agreement among raft nodes before linearized reading' (duration: 236.542412ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:28:39.359235Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2832} {"level":"info","ts":"2026-08-31T07:28:39.468253Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2832,"took":"108.118943ms","hash":344211365,"current-db-size-bytes":52383744,"current-db-size":"52 MB","current-db-size-in-use-bytes":26939392,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-08-31T07:28:39.468293Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":344211365,"revision":2832,"compact-revision":-1} {"level":"info","ts":"2026-08-31T07:28:40.273812Z","caller":"traceutil/trace.go:171","msg":"trace[1078742657] linearizableReadLoop","detail":"{readStateIndex:5408; appliedIndex:5406; }","duration":"117.991903ms","start":"2026-08-31T07:28:40.155797Z","end":"2026-08-31T07:28:40.273789Z","steps":["trace[1078742657] 'read index received' (duration: 48.116199ms)","trace[1078742657] 'applied index is now lower than readState.Index' (duration: 69.874954ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T07:28:40.274041Z","caller":"traceutil/trace.go:171","msg":"trace[1269137449] transaction","detail":"{read_only:false; response_revision:5212; number_of_response:1; }","duration":"119.470477ms","start":"2026-08-31T07:28:40.154562Z","end":"2026-08-31T07:28:40.274032Z","steps":["trace[1269137449] 'process raft request' (duration: 117.631617ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:28:40.274243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.43079ms","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-08-31T07:28:40.274272Z","caller":"traceutil/trace.go:171","msg":"trace[328833737] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5212; }","duration":"118.488102ms","start":"2026-08-31T07:28:40.155778Z","end":"2026-08-31T07:28:40.274266Z","steps":["trace[328833737] 'agreement among raft nodes before linearized reading' (duration: 118.386291ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:28:40.423863Z","caller":"traceutil/trace.go:171","msg":"trace[1531020112] transaction","detail":"{read_only:false; response_revision:5215; number_of_response:1; }","duration":"136.070997ms","start":"2026-08-31T07:28:40.287764Z","end":"2026-08-31T07:28:40.423835Z","steps":["trace[1531020112] 'process raft request' (duration: 97.884378ms)","trace[1531020112] 'compare' (duration: 37.810233ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T07:28:40.424323Z","caller":"traceutil/trace.go:171","msg":"trace[1010121978] transaction","detail":"{read_only:false; response_revision:5216; number_of_response:1; }","duration":"135.832473ms","start":"2026-08-31T07:28:40.288468Z","end":"2026-08-31T07:28:40.4243Z","steps":["trace[1010121978] 'process raft request' (duration: 135.204802ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:28:40.42464Z","caller":"traceutil/trace.go:171","msg":"trace[11475386] transaction","detail":"{read_only:false; response_revision:5217; number_of_response:1; }","duration":"125.320433ms","start":"2026-08-31T07:28:40.298912Z","end":"2026-08-31T07:28:40.424232Z","steps":["trace[11475386] 'process raft request' (duration: 125.097669ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:28:40.461546Z","caller":"traceutil/trace.go:171","msg":"trace[390171976] transaction","detail":"{read_only:false; response_revision:5218; number_of_response:1; }","duration":"130.526317ms","start":"2026-08-31T07:28:40.330999Z","end":"2026-08-31T07:28:40.461525Z","steps":["trace[390171976] 'process raft request' (duration: 130.313354ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:28:52.323381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.78345ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-31T07:28:52.323563Z","caller":"traceutil/trace.go:171","msg":"trace[1180343430] transaction","detail":"{read_only:false; response_revision:5355; number_of_response:1; }","duration":"532.632927ms","start":"2026-08-31T07:28:51.790915Z","end":"2026-08-31T07:28:52.323548Z","steps":["trace[1180343430] 'process raft request' (duration: 54.605492ms)","trace[1180343430] 'compare' (duration: 477.452155ms)"],"step_count":2} {"level":"warn","ts":"2026-08-31T07:28:52.323621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:28:51.790888Z","time spent":"532.702489ms","remote":"127.0.0.1:35058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-31T07:28:52.323501Z","caller":"traceutil/trace.go:171","msg":"trace[2070596781] linearizableReadLoop","detail":"{readStateIndex:5555; appliedIndex:5554; }","duration":"233.577323ms","start":"2026-08-31T07:28:52.089907Z","end":"2026-08-31T07:28:52.323484Z","steps":["trace[2070596781] 'read index received' (duration: 37.67µs)","trace[2070596781] 'applied index is now lower than readState.Index' (duration: 233.538193ms)"],"step_count":2} {"level":"warn","ts":"2026-08-31T07:28:52.323918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.996511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-31T07:28:52.323972Z","caller":"traceutil/trace.go:171","msg":"trace[179494101] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5355; }","duration":"234.092933ms","start":"2026-08-31T07:28:52.089866Z","end":"2026-08-31T07:28:52.323959Z","steps":["trace[179494101] 'agreement among raft nodes before linearized reading' (duration: 233.94181ms)"],"step_count":1} {"level":"warn","ts":"2026-08-31T07:28:52.324066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.599841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:13289"} {"level":"info","ts":"2026-08-31T07:28:52.324105Z","caller":"traceutil/trace.go:171","msg":"trace[228182704] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5355; }","duration":"109.693283ms","start":"2026-08-31T07:28:52.214394Z","end":"2026-08-31T07:28:52.324087Z","steps":["trace[228182704] 'agreement among raft nodes before linearized reading' (duration: 109.562401ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:31:39.444916Z","caller":"traceutil/trace.go:171","msg":"trace[664199086] transaction","detail":"{read_only:false; response_revision:6479; number_of_response:1; }","duration":"168.740094ms","start":"2026-08-31T07:31:39.27615Z","end":"2026-08-31T07:31:39.44489Z","steps":["trace[664199086] 'process raft request' (duration: 168.60684ms)"],"step_count":1} {"level":"info","ts":"2026-08-31T07:32:40.991339Z","caller":"traceutil/trace.go:171","msg":"trace[52863561] transaction","detail":"{read_only:false; response_revision:6975; number_of_response:1; }","duration":"129.41233ms","start":"2026-08-31T07:32:40.861894Z","end":"2026-08-31T07:32:40.991306Z","steps":["trace[52863561] 'process raft request' (duration: 107.433152ms)","trace[52863561] 'compare' (duration: 21.869165ms)"],"step_count":2} {"level":"info","ts":"2026-08-31T07:33:39.381098Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5193} {"level":"info","ts":"2026-08-31T07:33:39.495543Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5193,"took":"112.991512ms","hash":1826926873,"current-db-size-bytes":52383744,"current-db-size":"52 MB","current-db-size-in-use-bytes":19202048,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-08-31T07:33:39.495626Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1826926873,"revision":5193,"compact-revision":2832}