{"level":"warn","ts":"2026-08-19T20:24:06.503997Z","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-19T20:24:06.504095Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.209: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://199.19.213.209:2380","--initial-cluster=instance=https://199.19.213.209:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.209:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.209: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-19T20:24:06.504178Z","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-19T20:24:06.504189Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.209:2380"]} {"level":"info","ts":"2026-08-19T20:24:06.504206Z","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-19T20:24:06.504938Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.209:2379"]} {"level":"info","ts":"2026-08-19T20:24:06.505018Z","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://199.19.213.209:2380"],"listen-peer-urls":["https://199.19.213.209:2380"],"advertise-client-urls":["https://199.19.213.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.209: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-19T20:24:06.510572Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.299245ms"} {"level":"info","ts":"2026-08-19T20:24:06.525195Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9409e054be1d0d72","cluster-id":"ff5f9c0688884e7d"} {"level":"info","ts":"2026-08-19T20:24:06.525318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9409e054be1d0d72 switched to configuration voters=()"} {"level":"info","ts":"2026-08-19T20:24:06.525345Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9409e054be1d0d72 became follower at term 0"} {"level":"info","ts":"2026-08-19T20:24:06.525358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9409e054be1d0d72 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-19T20:24:06.525366Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9409e054be1d0d72 became follower at term 1"} {"level":"info","ts":"2026-08-19T20:24:06.525409Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9409e054be1d0d72 switched to configuration voters=(10667303846975180146)"} {"level":"warn","ts":"2026-08-19T20:24:06.536422Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-19T20:24:06.537641Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-19T20:24:06.538669Z","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-19T20:24:06.540642Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9409e054be1d0d72","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-19T20:24:06.544045Z","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-19T20:24:06.544183Z","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-19T20:24:06.544201Z","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-19T20:24:06.544823Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9409e054be1d0d72","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-19T20:24:06.545472Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9409e054be1d0d72 switched to configuration voters=(10667303846975180146)"} {"level":"info","ts":"2026-08-19T20:24:06.545581Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ff5f9c0688884e7d","local-member-id":"9409e054be1d0d72","added-peer-id":"9409e054be1d0d72","added-peer-peer-urls":["https://199.19.213.209:2380"]} {"level":"info","ts":"2026-08-19T20:24:06.551458Z","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-19T20:24:06.551691Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.209:2380"} {"level":"info","ts":"2026-08-19T20:24:06.551768Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.209:2380"} {"level":"info","ts":"2026-08-19T20:24:06.551792Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9409e054be1d0d72","initial-advertise-peer-urls":["https://199.19.213.209:2380"],"listen-peer-urls":["https://199.19.213.209:2380"],"advertise-client-urls":["https://199.19.213.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-19T20:24:06.55185Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-19T20:24:07.326232Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9409e054be1d0d72 is starting a new election at term 1"} {"level":"info","ts":"2026-08-19T20:24:07.326326Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9409e054be1d0d72 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-19T20:24:07.326358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9409e054be1d0d72 received MsgPreVoteResp from 9409e054be1d0d72 at term 1"} {"level":"info","ts":"2026-08-19T20:24:07.326394Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9409e054be1d0d72 became candidate at term 2"} {"level":"info","ts":"2026-08-19T20:24:07.326406Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9409e054be1d0d72 received MsgVoteResp from 9409e054be1d0d72 at term 2"} {"level":"info","ts":"2026-08-19T20:24:07.326424Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9409e054be1d0d72 became leader at term 2"} {"level":"info","ts":"2026-08-19T20:24:07.326439Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9409e054be1d0d72 elected leader 9409e054be1d0d72 at term 2"} {"level":"info","ts":"2026-08-19T20:24:07.327515Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-19T20:24:07.328407Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-19T20:24:07.328407Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9409e054be1d0d72","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.209:2379]}","request-path":"/0/members/9409e054be1d0d72/attributes","cluster-id":"ff5f9c0688884e7d","publish-timeout":"7s"} {"level":"info","ts":"2026-08-19T20:24:07.328823Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ff5f9c0688884e7d","local-member-id":"9409e054be1d0d72","cluster-version":"3.5"} {"level":"info","ts":"2026-08-19T20:24:07.328954Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-19T20:24:07.329002Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-19T20:24:07.329031Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-19T20:24:07.331805Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-19T20:24:07.332445Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.209:2379"} {"level":"info","ts":"2026-08-19T20:24:07.339546Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-19T20:24:07.339642Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"warn","ts":"2026-08-19T20:24:09.139508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.272548ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-08-19T20:24:09.139732Z","caller":"traceutil/trace.go:171","msg":"trace[225285561] linearizableReadLoop","detail":"{readStateIndex:24; appliedIndex:22; }","duration":"430.547124ms","start":"2026-08-19T20:24:08.709166Z","end":"2026-08-19T20:24:09.139713Z","steps":["trace[225285561] 'read index received' (duration: 172.437878ms)","trace[225285561] 'applied index is now lower than readState.Index' (duration: 258.108186ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T20:24:09.139822Z","caller":"traceutil/trace.go:171","msg":"trace[544961874] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"437.714813ms","start":"2026-08-19T20:24:08.702094Z","end":"2026-08-19T20:24:09.139809Z","steps":["trace[544961874] 'process raft request' (duration: 179.480707ms)","trace[544961874] 'compare' (duration: 257.128307ms)"],"step_count":2} {"level":"warn","ts":"2026-08-19T20:24:09.139883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:24:08.702084Z","time spent":"437.771324ms","remote":"127.0.0.1:58436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-19T20:24:09.139882Z","caller":"traceutil/trace.go:171","msg":"trace[1539361998] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"432.57121ms","start":"2026-08-19T20:24:08.707277Z","end":"2026-08-19T20:24:09.139848Z","steps":["trace[1539361998] 'process raft request' (duration: 432.353677ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:24:09.140229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.328684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-08-19T20:24:09.140263Z","caller":"traceutil/trace.go:171","msg":"trace[1610451653] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:20; }","duration":"434.377235ms","start":"2026-08-19T20:24:08.705874Z","end":"2026-08-19T20:24:09.140252Z","steps":["trace[1610451653] 'agreement among raft nodes before linearized reading' (duration: 434.301464ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:24:09.140299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:24:08.705869Z","time spent":"434.418565ms","remote":"127.0.0.1:57984","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-08-19T20:24:09.140317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:24:08.707269Z","time spent":"432.710502ms","remote":"127.0.0.1:58048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3479,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-19T20:24:09.140343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.142166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-w6m86\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-08-19T20:24:09.140387Z","caller":"traceutil/trace.go:171","msg":"trace[134346843] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-w6m86; range_end:; response_count:1; response_revision:20; }","duration":"438.195567ms","start":"2026-08-19T20:24:08.702176Z","end":"2026-08-19T20:24:09.140371Z","steps":["trace[134346843] 'agreement among raft nodes before linearized reading' (duration: 438.117976ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:24:09.140425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:24:08.702171Z","time spent":"438.247547ms","remote":"127.0.0.1:58132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":885,"request content":"key:\"/registry/certificatesigningrequests/csr-w6m86\" "} {"level":"warn","ts":"2026-08-19T20:24:09.142323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.474001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-08-19T20:24:09.142434Z","caller":"traceutil/trace.go:171","msg":"trace[477973467] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:27; }","duration":"431.615122ms","start":"2026-08-19T20:24:08.710792Z","end":"2026-08-19T20:24:09.142407Z","steps":["trace[477973467] 'agreement among raft nodes before linearized reading' (duration: 431.410041ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:24:09.142532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:24:08.710783Z","time spent":"431.735914ms","remote":"127.0.0.1:57984","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-08-19T20:24:09.142951Z","caller":"traceutil/trace.go:171","msg":"trace[1936159151] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"430.486923ms","start":"2026-08-19T20:24:08.712449Z","end":"2026-08-19T20:24:09.142936Z","steps":["trace[1936159151] 'process raft request' (duration: 429.387894ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:24:09.143052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:24:08.712396Z","time spent":"430.598604ms","remote":"127.0.0.1:58436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":956,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-19T20:24:09.1432Z","caller":"traceutil/trace.go:171","msg":"trace[184187410] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"430.075099ms","start":"2026-08-19T20:24:08.713115Z","end":"2026-08-19T20:24:09.14319Z","steps":["trace[184187410] 'process raft request' (duration: 428.846439ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:24:09.143282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:24:08.713103Z","time spent":"430.119659ms","remote":"127.0.0.1:58436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":947,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-19T20:24:09.143611Z","caller":"traceutil/trace.go:171","msg":"trace[1497140633] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"430.2916ms","start":"2026-08-19T20:24:08.713308Z","end":"2026-08-19T20:24:09.143599Z","steps":["trace[1497140633] 'process raft request' (duration: 428.703707ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:24:09.143675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:24:08.713299Z","time spent":"430.348722ms","remote":"127.0.0.1:58354","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-19T20:24:09.143857Z","caller":"traceutil/trace.go:171","msg":"trace[1698526568] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"429.996089ms","start":"2026-08-19T20:24:08.713851Z","end":"2026-08-19T20:24:09.143847Z","steps":["trace[1698526568] 'process raft request' (duration: 428.220764ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:24:09.144019Z","caller":"traceutil/trace.go:171","msg":"trace[1630599313] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"415.072944ms","start":"2026-08-19T20:24:08.728908Z","end":"2026-08-19T20:24:09.143981Z","steps":["trace[1630599313] 'process raft request' (duration: 413.253418ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:24:09.144146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.456875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-19T20:24:09.144162Z","caller":"traceutil/trace.go:171","msg":"trace[1687836056] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"424.098739ms","start":"2026-08-19T20:24:08.720046Z","end":"2026-08-19T20:24:09.144145Z","steps":["trace[1687836056] 'process raft request' (duration: 422.092722ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:24:09.144177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:24:08.728879Z","time spent":"415.218766ms","remote":"127.0.0.1:58144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-19T20:24:09.144228Z","caller":"traceutil/trace.go:171","msg":"trace[1474174190] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:27; }","duration":"423.603786ms","start":"2026-08-19T20:24:08.720585Z","end":"2026-08-19T20:24:09.144189Z","steps":["trace[1474174190] 'agreement among raft nodes before linearized reading' (duration: 423.454765ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:24:09.144271Z","caller":"traceutil/trace.go:171","msg":"trace[398544838] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"424.463122ms","start":"2026-08-19T20:24:08.7198Z","end":"2026-08-19T20:24:09.144263Z","steps":["trace[398544838] 'process raft request' (duration: 422.311224ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:24:09.144301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:24:08.719787Z","time spent":"424.500702ms","remote":"127.0.0.1:58436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1007,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-19T20:24:09.144305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:24:08.720575Z","time spent":"423.691146ms","remote":"127.0.0.1:57966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" "} {"level":"warn","ts":"2026-08-19T20:24:09.144236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:24:08.720006Z","time spent":"424.19283ms","remote":"127.0.0.1:58436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1007,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-19T20:24:09.144892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:24:08.713842Z","time spent":"430.036629ms","remote":"127.0.0.1:58304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-19T20:24:09.296998Z","caller":"traceutil/trace.go:171","msg":"trace[1667004399] linearizableReadLoop","detail":"{readStateIndex:38; appliedIndex:31; }","duration":"148.54817ms","start":"2026-08-19T20:24:09.148422Z","end":"2026-08-19T20:24:09.29697Z","steps":["trace[1667004399] 'read index received' (duration: 8.655131ms)","trace[1667004399] 'applied index is now lower than readState.Index' (duration: 139.891829ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T20:24:09.297191Z","caller":"traceutil/trace.go:171","msg":"trace[1888683382] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"148.981863ms","start":"2026-08-19T20:24:09.148171Z","end":"2026-08-19T20:24:09.297153Z","steps":["trace[1888683382] 'process raft request' (duration: 148.701021ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:24:09.2972Z","caller":"traceutil/trace.go:171","msg":"trace[1271185580] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"152.944757ms","start":"2026-08-19T20:24:09.144088Z","end":"2026-08-19T20:24:09.297033Z","steps":["trace[1271185580] 'process raft request' (duration: 148.319719ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:24:09.297258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.804292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-19T20:24:09.297308Z","caller":"traceutil/trace.go:171","msg":"trace[1955556609] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:35; }","duration":"148.905624ms","start":"2026-08-19T20:24:09.148384Z","end":"2026-08-19T20:24:09.29729Z","steps":["trace[1955556609] 'agreement among raft nodes before linearized reading' (duration: 148.759822ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:24:09.297471Z","caller":"traceutil/trace.go:171","msg":"trace[1937942693] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"149.530849ms","start":"2026-08-19T20:24:09.147921Z","end":"2026-08-19T20:24:09.297451Z","steps":["trace[1937942693] 'process raft request' (duration: 148.925404ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:24:09.297561Z","caller":"traceutil/trace.go:171","msg":"trace[1191442017] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"148.874432ms","start":"2026-08-19T20:24:09.148677Z","end":"2026-08-19T20:24:09.297552Z","steps":["trace[1191442017] 'process raft request' (duration: 148.260908ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:24:09.297551Z","caller":"traceutil/trace.go:171","msg":"trace[1242444932] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"149.590209ms","start":"2026-08-19T20:24:09.147892Z","end":"2026-08-19T20:24:09.297482Z","steps":["trace[1242444932] 'process raft request' (duration: 148.926474ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:24:09.29763Z","caller":"traceutil/trace.go:171","msg":"trace[551201589] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"149.451267ms","start":"2026-08-19T20:24:09.148172Z","end":"2026-08-19T20:24:09.297623Z","steps":["trace[551201589] 'process raft request' (duration: 148.729422ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:24:09.297736Z","caller":"traceutil/trace.go:171","msg":"trace[98238152] transaction","detail":"{read_only:false; response_revision:30; number_of_response:1; }","duration":"149.986953ms","start":"2026-08-19T20:24:09.147739Z","end":"2026-08-19T20:24:09.297726Z","steps":["trace[98238152] 'process raft request' (duration: 149.021026ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:24:46.622828Z","caller":"traceutil/trace.go:171","msg":"trace[658674646] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:641; }","duration":"289.161945ms","start":"2026-08-19T20:24:46.333645Z","end":"2026-08-19T20:24:46.622807Z","steps":["trace[658674646] 'read index received' (duration: 288.601856ms)","trace[658674646] 'applied index is now lower than readState.Index' (duration: 558.958µs)"],"step_count":2} {"level":"info","ts":"2026-08-19T20:24:46.622967Z","caller":"traceutil/trace.go:171","msg":"trace[889579402] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"373.306722ms","start":"2026-08-19T20:24:46.249598Z","end":"2026-08-19T20:24:46.622905Z","steps":["trace[889579402] 'process raft request' (duration: 372.864387ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:24:46.623093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:24:46.249569Z","time spent":"373.466477ms","remote":"127.0.0.1:57976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036023,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-19T20:24:46.623862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.176588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-19T20:24:46.623166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.459714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-19T20:24:46.623961Z","caller":"traceutil/trace.go:171","msg":"trace[1049009256] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:615; }","duration":"290.341952ms","start":"2026-08-19T20:24:46.333603Z","end":"2026-08-19T20:24:46.623945Z","steps":["trace[1049009256] 'agreement among raft nodes before linearized reading' (duration: 289.407563ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:24:46.623954Z","caller":"traceutil/trace.go:171","msg":"trace[1512486169] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:615; }","duration":"114.312623ms","start":"2026-08-19T20:24:46.509627Z","end":"2026-08-19T20:24:46.623939Z","steps":["trace[1512486169] 'agreement among raft nodes before linearized reading' (duration: 114.210339ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:24:46.623234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.248091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-19T20:24:46.624174Z","caller":"traceutil/trace.go:171","msg":"trace[1606468931] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:615; }","duration":"115.208492ms","start":"2026-08-19T20:24:46.508953Z","end":"2026-08-19T20:24:46.624161Z","steps":["trace[1606468931] 'agreement among raft nodes before linearized reading' (duration: 114.258762ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:24:46.623273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.63156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-19T20:24:46.624444Z","caller":"traceutil/trace.go:171","msg":"trace[1262988846] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:615; }","duration":"290.800987ms","start":"2026-08-19T20:24:46.333632Z","end":"2026-08-19T20:24:46.624433Z","steps":["trace[1262988846] 'agreement among raft nodes before linearized reading' (duration: 289.620319ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:24:46.623276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.204516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-19T20:24:46.624625Z","caller":"traceutil/trace.go:171","msg":"trace[1240914183] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:615; }","duration":"290.58816ms","start":"2026-08-19T20:24:46.334015Z","end":"2026-08-19T20:24:46.624603Z","steps":["trace[1240914183] 'agreement among raft nodes before linearized reading' (duration: 289.193826ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:24:46.623327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.53371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-19T20:24:46.624845Z","caller":"traceutil/trace.go:171","msg":"trace[622790828] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:615; }","duration":"116.023308ms","start":"2026-08-19T20:24:46.508784Z","end":"2026-08-19T20:24:46.624807Z","steps":["trace[622790828] 'agreement among raft nodes before linearized reading' (duration: 114.52227ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:24:46.623361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.505103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-19T20:24:46.625073Z","caller":"traceutil/trace.go:171","msg":"trace[552694139] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:615; }","duration":"160.214777ms","start":"2026-08-19T20:24:46.464847Z","end":"2026-08-19T20:24:46.625062Z","steps":["trace[552694139] 'agreement among raft nodes before linearized reading' (duration: 158.496563ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:24:46.623393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.554784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-19T20:24:46.62537Z","caller":"traceutil/trace.go:171","msg":"trace[1026152402] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:615; }","duration":"160.519977ms","start":"2026-08-19T20:24:46.464815Z","end":"2026-08-19T20:24:46.625335Z","steps":["trace[1026152402] 'agreement among raft nodes before linearized reading' (duration: 158.560495ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:24:46.623429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.545465ms","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-19T20:24:46.626393Z","caller":"traceutil/trace.go:171","msg":"trace[1742561797] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:615; }","duration":"208.500778ms","start":"2026-08-19T20:24:46.417863Z","end":"2026-08-19T20:24:46.626364Z","steps":["trace[1742561797] 'agreement among raft nodes before linearized reading' (duration: 205.545554ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:24:46.623465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.678359ms","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-19T20:24:46.626574Z","caller":"traceutil/trace.go:171","msg":"trace[1386817492] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:615; }","duration":"208.811608ms","start":"2026-08-19T20:24:46.417752Z","end":"2026-08-19T20:24:46.626563Z","steps":["trace[1386817492] 'agreement among raft nodes before linearized reading' (duration: 205.695039ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:24:46.62351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.785532ms","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-19T20:24:46.626687Z","caller":"traceutil/trace.go:171","msg":"trace[1457563733] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:615; }","duration":"208.964613ms","start":"2026-08-19T20:24:46.417685Z","end":"2026-08-19T20:24:46.62665Z","steps":["trace[1457563733] 'agreement among raft nodes before linearized reading' (duration: 205.795582ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:24:46.623543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.619767ms","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-19T20:24:46.626793Z","caller":"traceutil/trace.go:171","msg":"trace[386510036] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:615; }","duration":"232.882492ms","start":"2026-08-19T20:24:46.393904Z","end":"2026-08-19T20:24:46.626786Z","steps":["trace[386510036] 'agreement among raft nodes before linearized reading' (duration: 229.621448ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:24:46.623587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.076191ms","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-19T20:24:46.626948Z","caller":"traceutil/trace.go:171","msg":"trace[1054626604] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:615; }","duration":"233.45865ms","start":"2026-08-19T20:24:46.393483Z","end":"2026-08-19T20:24:46.626942Z","steps":["trace[1054626604] 'agreement among raft nodes before linearized reading' (duration: 230.087402ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:24:46.623622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.411702ms","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-19T20:24:46.627082Z","caller":"traceutil/trace.go:171","msg":"trace[1226935402] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:615; }","duration":"233.884272ms","start":"2026-08-19T20:24:46.39318Z","end":"2026-08-19T20:24:46.627064Z","steps":["trace[1226935402] 'agreement among raft nodes before linearized reading' (duration: 230.424192ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:24:46.623653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.726569ms","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-19T20:24:46.627256Z","caller":"traceutil/trace.go:171","msg":"trace[1296060122] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:615; }","duration":"261.350273ms","start":"2026-08-19T20:24:46.365895Z","end":"2026-08-19T20:24:46.627245Z","steps":["trace[1296060122] 'agreement among raft nodes before linearized reading' (duration: 257.741678ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:24:46.623687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.76515ms","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-19T20:24:46.628391Z","caller":"traceutil/trace.go:171","msg":"trace[389226854] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:615; }","duration":"262.487089ms","start":"2026-08-19T20:24:46.365874Z","end":"2026-08-19T20:24:46.628361Z","steps":["trace[389226854] 'agreement among raft nodes before linearized reading' (duration: 257.79477ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:24:50.165826Z","caller":"traceutil/trace.go:171","msg":"trace[2063625635] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"131.664179ms","start":"2026-08-19T20:24:50.034124Z","end":"2026-08-19T20:24:50.165789Z","steps":["trace[2063625635] 'process raft request' (duration: 129.822053ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:24:50.44532Z","caller":"traceutil/trace.go:171","msg":"trace[298240473] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:667; }","duration":"182.984796ms","start":"2026-08-19T20:24:50.262307Z","end":"2026-08-19T20:24:50.445292Z","steps":["trace[298240473] 'read index received' (duration: 182.7733ms)","trace[298240473] 'applied index is now lower than readState.Index' (duration: 210.666µs)"],"step_count":2} {"level":"info","ts":"2026-08-19T20:24:50.445466Z","caller":"traceutil/trace.go:171","msg":"trace[554204254] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"225.632321ms","start":"2026-08-19T20:24:50.219783Z","end":"2026-08-19T20:24:50.445416Z","steps":["trace[554204254] 'process raft request' (duration: 225.373603ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:24:50.445774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.391889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.209\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-19T20:24:50.445869Z","caller":"traceutil/trace.go:171","msg":"trace[1847065206] range","detail":"{range_begin:/registry/masterleases/199.19.213.209; range_end:; response_count:1; response_revision:641; }","duration":"183.580865ms","start":"2026-08-19T20:24:50.262262Z","end":"2026-08-19T20:24:50.445843Z","steps":["trace[1847065206] 'agreement among raft nodes before linearized reading' (duration: 183.300296ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:24:50.446006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.213233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-hlnck\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-08-19T20:24:50.446169Z","caller":"traceutil/trace.go:171","msg":"trace[1604295627] range","detail":"{range_begin:/registry/pods/kube-system/cilium-hlnck; range_end:; response_count:1; response_revision:641; }","duration":"127.46776ms","start":"2026-08-19T20:24:50.318587Z","end":"2026-08-19T20:24:50.446055Z","steps":["trace[1604295627] 'agreement among raft nodes before linearized reading' (duration: 127.097059ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:24:50.687085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.204468ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"info","ts":"2026-08-19T20:24:50.687396Z","caller":"traceutil/trace.go:171","msg":"trace[1026791295] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"223.933831ms","start":"2026-08-19T20:24:50.463442Z","end":"2026-08-19T20:24:50.687376Z","steps":["trace[1026791295] 'process raft request' (duration: 223.762865ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:24:50.687539Z","caller":"traceutil/trace.go:171","msg":"trace[760928718] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:668; }","duration":"237.175713ms","start":"2026-08-19T20:24:50.45032Z","end":"2026-08-19T20:24:50.687495Z","steps":["trace[760928718] 'read index received' (duration: 66.543732ms)","trace[760928718] 'applied index is now lower than readState.Index' (duration: 170.626961ms)"],"step_count":2} {"level":"warn","ts":"2026-08-19T20:24:50.687719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.375159ms","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-19T20:24:50.687766Z","caller":"traceutil/trace.go:171","msg":"trace[1351721104] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:642; }","duration":"237.460291ms","start":"2026-08-19T20:24:50.450293Z","end":"2026-08-19T20:24:50.687753Z","steps":["trace[1351721104] 'agreement among raft nodes before linearized reading' (duration: 237.335867ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:25:05.071759Z","caller":"traceutil/trace.go:171","msg":"trace[1202092080] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"249.167674ms","start":"2026-08-19T20:25:04.822558Z","end":"2026-08-19T20:25:05.071726Z","steps":["trace[1202092080] 'process raft request' (duration: 209.973422ms)","trace[1202092080] 'compare' (duration: 39.002237ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T20:25:38.250769Z","caller":"traceutil/trace.go:171","msg":"trace[848760271] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"180.617612ms","start":"2026-08-19T20:25:38.0701Z","end":"2026-08-19T20:25:38.250718Z","steps":["trace[848760271] 'process raft request' (duration: 180.371397ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:26:26.321107Z","caller":"traceutil/trace.go:171","msg":"trace[1534641407] transaction","detail":"{read_only:false; response_revision:1880; number_of_response:1; }","duration":"231.113166ms","start":"2026-08-19T20:26:26.089963Z","end":"2026-08-19T20:26:26.321076Z","steps":["trace[1534641407] 'process raft request' (duration: 230.966764ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:26:26.330246Z","caller":"traceutil/trace.go:171","msg":"trace[2130990587] linearizableReadLoop","detail":"{readStateIndex:1956; appliedIndex:1954; }","duration":"152.504458ms","start":"2026-08-19T20:26:26.177719Z","end":"2026-08-19T20:26:26.330223Z","steps":["trace[2130990587] 'read index received' (duration: 143.287075ms)","trace[2130990587] 'applied index is now lower than readState.Index' (duration: 9.216413ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T20:26:26.330289Z","caller":"traceutil/trace.go:171","msg":"trace[443210998] transaction","detail":"{read_only:false; response_revision:1881; number_of_response:1; }","duration":"176.456436ms","start":"2026-08-19T20:26:26.153805Z","end":"2026-08-19T20:26:26.330262Z","steps":["trace[443210998] 'process raft request' (duration: 176.297753ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:26:26.330476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.738641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-19T20:26:26.330797Z","caller":"traceutil/trace.go:171","msg":"trace[151406476] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1881; }","duration":"153.067567ms","start":"2026-08-19T20:26:26.177713Z","end":"2026-08-19T20:26:26.330781Z","steps":["trace[151406476] 'agreement among raft nodes before linearized reading' (duration: 152.63577ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:26:26.33073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.019228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-19T20:26:26.330961Z","caller":"traceutil/trace.go:171","msg":"trace[756560421] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1881; }","duration":"149.261091ms","start":"2026-08-19T20:26:26.181645Z","end":"2026-08-19T20:26:26.330907Z","steps":["trace[756560421] 'agreement among raft nodes before linearized reading' (duration: 148.925017ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:27:00.552699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.117002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-19T20:27:00.552826Z","caller":"traceutil/trace.go:171","msg":"trace[300456805] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:2123; }","duration":"119.337786ms","start":"2026-08-19T20:27:00.433462Z","end":"2026-08-19T20:27:00.5528Z","steps":["trace[300456805] 'count revisions from in-memory index tree' (duration: 119.016072ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:27:00.779711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.424538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-08-19T20:27:00.77982Z","caller":"traceutil/trace.go:171","msg":"trace[329946823] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2125; }","duration":"112.5737ms","start":"2026-08-19T20:27:00.667213Z","end":"2026-08-19T20:27:00.779787Z","steps":["trace[329946823] 'range keys from in-memory index tree' (duration: 112.221446ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:27:00.9723Z","caller":"traceutil/trace.go:171","msg":"trace[1096083524] transaction","detail":"{read_only:false; response_revision:2126; number_of_response:1; }","duration":"120.976285ms","start":"2026-08-19T20:27:00.85129Z","end":"2026-08-19T20:27:00.972267Z","steps":["trace[1096083524] 'process raft request' (duration: 120.804913ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:28:08.424651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.028152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-08-19T20:28:08.424777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.598165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-08-19T20:28:08.424789Z","caller":"traceutil/trace.go:171","msg":"trace[1160583817] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2590; }","duration":"194.159974ms","start":"2026-08-19T20:28:08.230589Z","end":"2026-08-19T20:28:08.424749Z","steps":["trace[1160583817] 'range keys from in-memory index tree' (duration: 193.83259ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:28:08.425721Z","caller":"traceutil/trace.go:171","msg":"trace[1091790792] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2590; }","duration":"190.587875ms","start":"2026-08-19T20:28:08.235118Z","end":"2026-08-19T20:28:08.425706Z","steps":["trace[1091790792] 'range keys from in-memory index tree' (duration: 189.450852ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:28:43.162415Z","caller":"traceutil/trace.go:171","msg":"trace[1140570030] transaction","detail":"{read_only:false; response_revision:2784; number_of_response:1; }","duration":"127.053455ms","start":"2026-08-19T20:28:43.035333Z","end":"2026-08-19T20:28:43.162386Z","steps":["trace[1140570030] 'process raft request' (duration: 126.843493ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:28:43.547651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.373936ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-19T20:28:43.547928Z","caller":"traceutil/trace.go:171","msg":"trace[740503532] linearizableReadLoop","detail":"{readStateIndex:2891; appliedIndex:2889; }","duration":"131.314809ms","start":"2026-08-19T20:28:43.416594Z","end":"2026-08-19T20:28:43.547909Z","steps":["trace[740503532] 'read index received' (duration: 23.87µs)","trace[740503532] 'applied index is now lower than readState.Index' (duration: 131.289609ms)"],"step_count":2} {"level":"warn","ts":"2026-08-19T20:28:43.548276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.679233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-08-19T20:28:43.548258Z","caller":"traceutil/trace.go:171","msg":"trace[1936813100] transaction","detail":"{read_only:false; response_revision:2786; number_of_response:1; }","duration":"379.224924ms","start":"2026-08-19T20:28:43.169004Z","end":"2026-08-19T20:28:43.548229Z","steps":["trace[1936813100] 'process raft request' (duration: 378.760618ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:28:43.548353Z","caller":"traceutil/trace.go:171","msg":"trace[617449469] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2786; }","duration":"131.755225ms","start":"2026-08-19T20:28:43.416555Z","end":"2026-08-19T20:28:43.54831Z","steps":["trace[617449469] 'agreement among raft nodes before linearized reading' (duration: 131.453691ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T20:28:43.54842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:28:43.168977Z","time spent":"379.363316ms","remote":"127.0.0.1:58144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-19T20:28:43.548324Z","caller":"traceutil/trace.go:171","msg":"trace[1951076559] transaction","detail":"{read_only:false; response_revision:2785; number_of_response:1; }","duration":"378.997111ms","start":"2026-08-19T20:28:43.168956Z","end":"2026-08-19T20:28:43.547953Z","steps":["trace[1951076559] 'process raft request' (duration: 157.228871ms)","trace[1951076559] 'compare' (duration: 221.159094ms)"],"step_count":2} {"level":"warn","ts":"2026-08-19T20:28:43.548835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:28:43.168928Z","time spent":"379.641018ms","remote":"127.0.0.1:58144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-19T20:32:29.91681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.248745ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-19T20:32:29.91698Z","caller":"traceutil/trace.go:171","msg":"trace[618172748] transaction","detail":"{read_only:false; response_revision:4751; number_of_response:1; }","duration":"192.830186ms","start":"2026-08-19T20:32:29.724128Z","end":"2026-08-19T20:32:29.916958Z","steps":["trace[618172748] 'process raft request' (duration: 192.775516ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:32:29.917012Z","caller":"traceutil/trace.go:171","msg":"trace[595965529] linearizableReadLoop","detail":"{readStateIndex:4930; appliedIndex:4929; }","duration":"205.603753ms","start":"2026-08-19T20:32:29.711383Z","end":"2026-08-19T20:32:29.916987Z","steps":["trace[595965529] 'read index received' (duration: 18.114934ms)","trace[595965529] 'applied index is now lower than readState.Index' (duration: 187.486099ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T20:32:29.917011Z","caller":"traceutil/trace.go:171","msg":"trace[2057743989] transaction","detail":"{read_only:false; response_revision:4750; number_of_response:1; }","duration":"221.13614ms","start":"2026-08-19T20:32:29.695846Z","end":"2026-08-19T20:32:29.916982Z","steps":["trace[2057743989] 'process raft request' (duration: 33.639941ms)","trace[2057743989] 'compare' (duration: 187.127784ms)"],"step_count":2} {"level":"warn","ts":"2026-08-19T20:32:29.917235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.838716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-08-19T20:32:29.917268Z","caller":"traceutil/trace.go:171","msg":"trace[249703352] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4751; }","duration":"205.913877ms","start":"2026-08-19T20:32:29.711345Z","end":"2026-08-19T20:32:29.917259Z","steps":["trace[249703352] 'agreement among raft nodes before linearized reading' (duration: 205.726925ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:32:32.867705Z","caller":"traceutil/trace.go:171","msg":"trace[1066195441] transaction","detail":"{read_only:false; response_revision:4779; number_of_response:1; }","duration":"145.620767ms","start":"2026-08-19T20:32:32.72205Z","end":"2026-08-19T20:32:32.867671Z","steps":["trace[1066195441] 'process raft request' (duration: 145.465804ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:32:32.870313Z","caller":"traceutil/trace.go:171","msg":"trace[642146608] transaction","detail":"{read_only:false; response_revision:4781; number_of_response:1; }","duration":"147.519195ms","start":"2026-08-19T20:32:32.722774Z","end":"2026-08-19T20:32:32.870294Z","steps":["trace[642146608] 'process raft request' (duration: 147.465744ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:32:32.870371Z","caller":"traceutil/trace.go:171","msg":"trace[1960601495] transaction","detail":"{read_only:false; response_revision:4780; number_of_response:1; }","duration":"148.251904ms","start":"2026-08-19T20:32:32.722098Z","end":"2026-08-19T20:32:32.87035Z","steps":["trace[1960601495] 'process raft request' (duration: 148.056742ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:32:41.905592Z","caller":"traceutil/trace.go:171","msg":"trace[1425549367] transaction","detail":"{read_only:false; response_revision:4918; number_of_response:1; }","duration":"239.125914ms","start":"2026-08-19T20:32:41.666447Z","end":"2026-08-19T20:32:41.905573Z","steps":["trace[1425549367] 'process raft request' (duration: 239.007592ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:32:41.964057Z","caller":"traceutil/trace.go:171","msg":"trace[79008538] transaction","detail":"{read_only:false; response_revision:4919; number_of_response:1; }","duration":"294.410918ms","start":"2026-08-19T20:32:41.669625Z","end":"2026-08-19T20:32:41.964036Z","steps":["trace[79008538] 'process raft request' (duration: 294.033082ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T20:34:07.361505Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2909} {"level":"info","ts":"2026-08-19T20:34:07.495675Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2909,"took":"132.865978ms","hash":822814648,"current-db-size-bytes":54448128,"current-db-size":"54 MB","current-db-size-in-use-bytes":29650944,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-19T20:34:07.495762Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":822814648,"revision":2909,"compact-revision":-1} {"level":"info","ts":"2026-08-19T20:39:07.366213Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5636} {"level":"info","ts":"2026-08-19T20:39:07.436816Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5636,"took":"69.265393ms","hash":319338628,"current-db-size-bytes":54448128,"current-db-size":"54 MB","current-db-size-in-use-bytes":18231296,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-08-19T20:39:07.436878Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":319338628,"revision":5636,"compact-revision":2909}