{"level":"warn","ts":"2026-08-27T20:04:18.921355Z","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-27T20:04:18.921533Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.80: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.80:2380","--initial-cluster=instance=https://162.253.55.80:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.80:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.80: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-27T20:04:18.92173Z","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-27T20:04:18.921742Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.80:2380"]} {"level":"info","ts":"2026-08-27T20:04:18.921767Z","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-27T20:04:18.922566Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.80:2379"]} {"level":"info","ts":"2026-08-27T20:04:18.922646Z","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.80:2380"],"listen-peer-urls":["https://162.253.55.80:2380"],"advertise-client-urls":["https://162.253.55.80:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.80:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.80: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-27T20:04:18.930594Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.353375ms"} {"level":"info","ts":"2026-08-27T20:04:18.944241Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a87e3d9cf178847b","cluster-id":"df2e96c7e71d56b9"} {"level":"info","ts":"2026-08-27T20:04:18.944476Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b switched to configuration voters=()"} {"level":"info","ts":"2026-08-27T20:04:18.944513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b became follower at term 0"} {"level":"info","ts":"2026-08-27T20:04:18.944592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a87e3d9cf178847b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-27T20:04:18.94463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b became follower at term 1"} {"level":"info","ts":"2026-08-27T20:04:18.944748Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b switched to configuration voters=(12141209389712835707)"} {"level":"warn","ts":"2026-08-27T20:04:18.954257Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-27T20:04:18.956025Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-27T20:04:18.95754Z","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-27T20:04:18.96008Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a87e3d9cf178847b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-27T20:04:18.960363Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a87e3d9cf178847b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-27T20:04:18.962129Z","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-27T20:04:18.963485Z","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-27T20:04:18.963999Z","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-27T20:04:18.964435Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b switched to configuration voters=(12141209389712835707)"} {"level":"info","ts":"2026-08-27T20:04:18.964655Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"df2e96c7e71d56b9","local-member-id":"a87e3d9cf178847b","added-peer-id":"a87e3d9cf178847b","added-peer-peer-urls":["https://162.253.55.80:2380"]} {"level":"info","ts":"2026-08-27T20:04:18.965554Z","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-27T20:04:18.965676Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.80:2380"} {"level":"info","ts":"2026-08-27T20:04:18.965742Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.80:2380"} {"level":"info","ts":"2026-08-27T20:04:18.965814Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a87e3d9cf178847b","initial-advertise-peer-urls":["https://162.253.55.80:2380"],"listen-peer-urls":["https://162.253.55.80:2380"],"advertise-client-urls":["https://162.253.55.80:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.80:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-27T20:04:18.965866Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-27T20:04:19.245218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b is starting a new election at term 1"} {"level":"info","ts":"2026-08-27T20:04:19.245293Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b became pre-candidate at term 1"} {"level":"info","ts":"2026-08-27T20:04:19.245429Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b received MsgPreVoteResp from a87e3d9cf178847b at term 1"} {"level":"info","ts":"2026-08-27T20:04:19.245463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b became candidate at term 2"} {"level":"info","ts":"2026-08-27T20:04:19.245535Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b received MsgVoteResp from a87e3d9cf178847b at term 2"} {"level":"info","ts":"2026-08-27T20:04:19.245613Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b became leader at term 2"} {"level":"info","ts":"2026-08-27T20:04:19.245685Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a87e3d9cf178847b elected leader a87e3d9cf178847b at term 2"} {"level":"info","ts":"2026-08-27T20:04:19.247734Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a87e3d9cf178847b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.80:2379]}","request-path":"/0/members/a87e3d9cf178847b/attributes","cluster-id":"df2e96c7e71d56b9","publish-timeout":"7s"} {"level":"info","ts":"2026-08-27T20:04:19.2478Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-27T20:04:19.248024Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-27T20:04:19.248139Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-27T20:04:19.248355Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-27T20:04:19.248411Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-27T20:04:19.24891Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"df2e96c7e71d56b9","local-member-id":"a87e3d9cf178847b","cluster-version":"3.5"} {"level":"info","ts":"2026-08-27T20:04:19.249049Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-27T20:04:19.249087Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-27T20:04:19.25044Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.80:2379"} {"level":"info","ts":"2026-08-27T20:04:19.253466Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-08-27T20:04:22.63554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.453581ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-08-27T20:04:22.635671Z","caller":"traceutil/trace.go:171","msg":"trace[290606273] linearizableReadLoop","detail":"{readStateIndex:117; appliedIndex:116; }","duration":"413.954487ms","start":"2026-08-27T20:04:22.221699Z","end":"2026-08-27T20:04:22.635654Z","steps":["trace[290606273] 'read index received' (duration: 161.830501ms)","trace[290606273] 'applied index is now lower than readState.Index' (duration: 252.122676ms)"],"step_count":2} {"level":"warn","ts":"2026-08-27T20:04:22.635812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.10798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-view\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-27T20:04:22.635844Z","caller":"traceutil/trace.go:171","msg":"trace[1682704046] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-view; range_end:; response_count:0; response_revision:112; }","duration":"414.164891ms","start":"2026-08-27T20:04:22.221668Z","end":"2026-08-27T20:04:22.635833Z","steps":["trace[1682704046] 'agreement among raft nodes before linearized reading' (duration: 414.080179ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:04:22.635888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-27T20:04:22.221658Z","time spent":"414.222253ms","remote":"127.0.0.1:41922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/system:aggregate-to-view\" "} {"level":"info","ts":"2026-08-27T20:04:22.635819Z","caller":"traceutil/trace.go:171","msg":"trace[712524701] transaction","detail":"{read_only:false; response_revision:112; number_of_response:1; }","duration":"415.52893ms","start":"2026-08-27T20:04:22.220215Z","end":"2026-08-27T20:04:22.635744Z","steps":["trace[712524701] 'process raft request' (duration: 163.330053ms)","trace[712524701] 'compare' (duration: 251.305288ms)"],"step_count":2} {"level":"warn","ts":"2026-08-27T20:04:22.635891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.127356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-27T20:04:22.63611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-27T20:04:22.220202Z","time spent":"415.793895ms","remote":"127.0.0.1:41934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-27T20:04:22.636128Z","caller":"traceutil/trace.go:171","msg":"trace[1543883279] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:112; }","duration":"353.398752ms","start":"2026-08-27T20:04:22.282706Z","end":"2026-08-27T20:04:22.636104Z","steps":["trace[1543883279] 'agreement among raft nodes before linearized reading' (duration: 353.086016ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:04:22.636202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-27T20:04:22.28269Z","time spent":"353.497524ms","remote":"127.0.0.1:41640","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-27T20:05:01.474698Z","caller":"traceutil/trace.go:171","msg":"trace[1994914410] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"187.864001ms","start":"2026-08-27T20:05:01.286796Z","end":"2026-08-27T20:05:01.47466Z","steps":["trace[1994914410] 'process raft request' (duration: 187.620627ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:05:01.485095Z","caller":"traceutil/trace.go:171","msg":"trace[1065469137] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"190.709374ms","start":"2026-08-27T20:05:01.294336Z","end":"2026-08-27T20:05:01.485045Z","steps":["trace[1065469137] 'process raft request' (duration: 190.566642ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:05:01.485183Z","caller":"traceutil/trace.go:171","msg":"trace[347001999] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"181.300283ms","start":"2026-08-27T20:05:01.303796Z","end":"2026-08-27T20:05:01.485096Z","steps":["trace[347001999] 'process raft request' (duration: 181.173661ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:05:01.485216Z","caller":"traceutil/trace.go:171","msg":"trace[1301925056] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"159.070809ms","start":"2026-08-27T20:05:01.326133Z","end":"2026-08-27T20:05:01.485204Z","steps":["trace[1301925056] 'process raft request' (duration: 158.940157ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:05:01.485238Z","caller":"traceutil/trace.go:171","msg":"trace[411465679] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"161.044609ms","start":"2026-08-27T20:05:01.324077Z","end":"2026-08-27T20:05:01.485122Z","steps":["trace[411465679] 'process raft request' (duration: 160.940068ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:05:01.485643Z","caller":"traceutil/trace.go:171","msg":"trace[1791467219] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"158.242716ms","start":"2026-08-27T20:05:01.327382Z","end":"2026-08-27T20:05:01.485624Z","steps":["trace[1791467219] 'process raft request' (duration: 157.818589ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:05:01.485091Z","caller":"traceutil/trace.go:171","msg":"trace[451288171] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"195.469106ms","start":"2026-08-27T20:05:01.289557Z","end":"2026-08-27T20:05:01.485026Z","steps":["trace[451288171] 'process raft request' (duration: 195.299973ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:05:01.485494Z","caller":"traceutil/trace.go:171","msg":"trace[127750480] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"158.664303ms","start":"2026-08-27T20:05:01.326816Z","end":"2026-08-27T20:05:01.48548Z","steps":["trace[127750480] 'process raft request' (duration: 158.306187ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:05:01.485926Z","caller":"traceutil/trace.go:171","msg":"trace[12946962] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"129.656787ms","start":"2026-08-27T20:05:01.356229Z","end":"2026-08-27T20:05:01.485885Z","steps":["trace[12946962] 'process raft request' (duration: 129.391883ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:05:01.486035Z","caller":"traceutil/trace.go:171","msg":"trace[1085071185] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"116.577339ms","start":"2026-08-27T20:05:01.369439Z","end":"2026-08-27T20:05:01.486017Z","steps":["trace[1085071185] 'process raft request' (duration: 116.254545ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:05:01.486092Z","caller":"traceutil/trace.go:171","msg":"trace[836223759] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"195.525936ms","start":"2026-08-27T20:05:01.289464Z","end":"2026-08-27T20:05:01.48499Z","steps":["trace[836223759] 'process raft request' (duration: 195.318633ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:05:07.905533Z","caller":"traceutil/trace.go:171","msg":"trace[1100342696] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"135.121851ms","start":"2026-08-27T20:05:07.77038Z","end":"2026-08-27T20:05:07.905502Z","steps":["trace[1100342696] 'process raft request' (duration: 134.415501ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:05:08.514178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.282322ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-27T20:05:08.51451Z","caller":"traceutil/trace.go:171","msg":"trace[1076136899] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"600.896596ms","start":"2026-08-27T20:05:07.913579Z","end":"2026-08-27T20:05:08.514475Z","steps":["trace[1076136899] 'process raft request' (duration: 600.721663ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:05:08.51459Z","caller":"traceutil/trace.go:171","msg":"trace[1048765705] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"531.189805ms","start":"2026-08-27T20:05:07.983382Z","end":"2026-08-27T20:05:08.514572Z","steps":["trace[1048765705] 'process raft request' (duration: 531.025463ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:05:08.514655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-27T20:05:07.983305Z","time spent":"531.321867ms","remote":"127.0.0.1:42052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-27T20:05:08.514682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-27T20:05:07.913547Z","time spent":"601.050428ms","remote":"127.0.0.1:41854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-27T20:05:08.514657Z","caller":"traceutil/trace.go:171","msg":"trace[1955899781] linearizableReadLoop","detail":"{readStateIndex:670; appliedIndex:667; }","duration":"413.80134ms","start":"2026-08-27T20:05:08.100761Z","end":"2026-08-27T20:05:08.514562Z","steps":["trace[1955899781] 'read index received' (duration: 69.832485ms)","trace[1955899781] 'applied index is now lower than readState.Index' (duration: 343.966565ms)"],"step_count":2} {"level":"warn","ts":"2026-08-27T20:05:08.514928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.146034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-27T20:05:08.515018Z","caller":"traceutil/trace.go:171","msg":"trace[1756191986] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:643; }","duration":"414.238296ms","start":"2026-08-27T20:05:08.100753Z","end":"2026-08-27T20:05:08.514992Z","steps":["trace[1756191986] 'agreement among raft nodes before linearized reading' (duration: 413.986822ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:05:08.51505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.94368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-08-27T20:05:08.515079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.860916ms","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-27T20:05:08.515062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-27T20:05:08.100709Z","time spent":"414.345478ms","remote":"127.0.0.1:41626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-27T20:05:08.515118Z","caller":"traceutil/trace.go:171","msg":"trace[1474563238] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:643; }","duration":"224.968717ms","start":"2026-08-27T20:05:08.290138Z","end":"2026-08-27T20:05:08.515107Z","steps":["trace[1474563238] 'agreement among raft nodes before linearized reading' (duration: 224.813075ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:05:08.515118Z","caller":"traceutil/trace.go:171","msg":"trace[360042507] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:643; }","duration":"402.063972ms","start":"2026-08-27T20:05:08.113025Z","end":"2026-08-27T20:05:08.515089Z","steps":["trace[360042507] 'agreement among raft nodes before linearized reading' (duration: 401.871379ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:05:08.515162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-27T20:05:08.113001Z","time spent":"402.153703ms","remote":"127.0.0.1:41854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-27T20:05:08.515286Z","caller":"traceutil/trace.go:171","msg":"trace[941119480] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"663.77314ms","start":"2026-08-27T20:05:07.851134Z","end":"2026-08-27T20:05:08.514907Z","steps":["trace[941119480] 'process raft request' (duration: 124.114263ms)","trace[941119480] 'compare' (duration: 538.47087ms)"],"step_count":2} {"level":"warn","ts":"2026-08-27T20:05:08.515355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-27T20:05:07.851102Z","time spent":"664.220146ms","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-27T20:05:24.283618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.216933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-27T20:05:24.283712Z","caller":"traceutil/trace.go:171","msg":"trace[1365284352] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:807; }","duration":"182.372884ms","start":"2026-08-27T20:05:24.10132Z","end":"2026-08-27T20:05:24.283693Z","steps":["trace[1365284352] 'range keys from in-memory index tree' (duration: 182.136732ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:05:56.949703Z","caller":"traceutil/trace.go:171","msg":"trace[41191144] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"155.800181ms","start":"2026-08-27T20:05:56.793868Z","end":"2026-08-27T20:05:56.949669Z","steps":["trace[41191144] 'process raft request' (duration: 155.610429ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:05:56.96279Z","caller":"traceutil/trace.go:171","msg":"trace[2086636759] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"168.845532ms","start":"2026-08-27T20:05:56.793919Z","end":"2026-08-27T20:05:56.962765Z","steps":["trace[2086636759] 'process raft request' (duration: 168.68573ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:05:56.963027Z","caller":"traceutil/trace.go:171","msg":"trace[1654145242] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"168.988623ms","start":"2026-08-27T20:05:56.794004Z","end":"2026-08-27T20:05:56.962993Z","steps":["trace[1654145242] 'process raft request' (duration: 168.721981ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:06:15.175964Z","caller":"traceutil/trace.go:171","msg":"trace[1320226507] transaction","detail":"{read_only:false; response_revision:1360; number_of_response:1; }","duration":"118.369054ms","start":"2026-08-27T20:06:15.057556Z","end":"2026-08-27T20:06:15.175925Z","steps":["trace[1320226507] 'process raft request' (duration: 111.154562ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:06:15.176799Z","caller":"traceutil/trace.go:171","msg":"trace[480861322] transaction","detail":"{read_only:false; response_revision:1361; number_of_response:1; }","duration":"118.478516ms","start":"2026-08-27T20:06:15.058293Z","end":"2026-08-27T20:06:15.176771Z","steps":["trace[480861322] 'process raft request' (duration: 117.990001ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:06:23.489944Z","caller":"traceutil/trace.go:171","msg":"trace[770697766] transaction","detail":"{read_only:false; response_revision:1489; number_of_response:1; }","duration":"229.416612ms","start":"2026-08-27T20:06:23.260478Z","end":"2026-08-27T20:06:23.489894Z","steps":["trace[770697766] 'process raft request' (duration: 179.618449ms)","trace[770697766] 'compare' (duration: 49.629332ms)"],"step_count":2} {"level":"info","ts":"2026-08-27T20:06:23.494474Z","caller":"traceutil/trace.go:171","msg":"trace[1326313565] transaction","detail":"{read_only:false; response_revision:1490; number_of_response:1; }","duration":"233.088588ms","start":"2026-08-27T20:06:23.26135Z","end":"2026-08-27T20:06:23.494439Z","steps":["trace[1326313565] 'process raft request' (duration: 232.923167ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:06:41.822795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.173235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-27T20:06:41.822889Z","caller":"traceutil/trace.go:171","msg":"trace[154975218] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1802; }","duration":"115.331746ms","start":"2026-08-27T20:06:41.707541Z","end":"2026-08-27T20:06:41.822873Z","steps":["trace[154975218] 'range keys from in-memory index tree' (duration: 115.093863ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:06:41.823171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.351995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-27T20:06:41.823303Z","caller":"traceutil/trace.go:171","msg":"trace[969407971] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1802; }","duration":"115.672009ms","start":"2026-08-27T20:06:41.707607Z","end":"2026-08-27T20:06:41.823279Z","steps":["trace[969407971] 'count revisions from in-memory index tree' (duration: 115.257065ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:06:48.891398Z","caller":"traceutil/trace.go:171","msg":"trace[191092196] transaction","detail":"{read_only:false; response_revision:1905; number_of_response:1; }","duration":"280.136524ms","start":"2026-08-27T20:06:48.611223Z","end":"2026-08-27T20:06:48.89136Z","steps":["trace[191092196] 'process raft request' (duration: 279.904182ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:06:48.985748Z","caller":"traceutil/trace.go:171","msg":"trace[2088881967] transaction","detail":"{read_only:false; response_revision:1906; number_of_response:1; }","duration":"368.85391ms","start":"2026-08-27T20:06:48.616858Z","end":"2026-08-27T20:06:48.985712Z","steps":["trace[2088881967] 'process raft request' (duration: 311.550179ms)","trace[2088881967] 'compare' (duration: 57.052808ms)"],"step_count":2} {"level":"warn","ts":"2026-08-27T20:06:48.985952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-27T20:06:48.616809Z","time spent":"369.022781ms","remote":"127.0.0.1:41854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-27T20:06:49.017991Z","caller":"traceutil/trace.go:171","msg":"trace[1406338013] linearizableReadLoop","detail":"{readStateIndex:1984; appliedIndex:1981; }","duration":"150.379275ms","start":"2026-08-27T20:06:48.867574Z","end":"2026-08-27T20:06:49.017953Z","steps":["trace[1406338013] 'read index received' (duration: 23.469443ms)","trace[1406338013] 'applied index is now lower than readState.Index' (duration: 126.907802ms)"],"step_count":2} {"level":"warn","ts":"2026-08-27T20:06:49.018284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.680008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-45272294-90c4-4cd5-b629-7d96183aca5b\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-08-27T20:06:49.018329Z","caller":"traceutil/trace.go:171","msg":"trace[276587866] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-45272294-90c4-4cd5-b629-7d96183aca5b; range_end:; response_count:1; response_revision:1906; }","duration":"150.750949ms","start":"2026-08-27T20:06:48.867565Z","end":"2026-08-27T20:06:49.018316Z","steps":["trace[276587866] 'agreement among raft nodes before linearized reading' (duration: 150.519937ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:06:49.346026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.263551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-27T20:06:49.346096Z","caller":"traceutil/trace.go:171","msg":"trace[1166927912] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1907; }","duration":"245.380802ms","start":"2026-08-27T20:06:49.100699Z","end":"2026-08-27T20:06:49.346079Z","steps":["trace[1166927912] 'range keys from in-memory index tree' (duration: 245.13851ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:06:49.346144Z","caller":"traceutil/trace.go:171","msg":"trace[540186106] linearizableReadLoop","detail":"{readStateIndex:1986; appliedIndex:1985; }","duration":"106.961529ms","start":"2026-08-27T20:06:49.239144Z","end":"2026-08-27T20:06:49.346105Z","steps":["trace[540186106] 'read index received' (duration: 81.431678ms)","trace[540186106] 'applied index is now lower than readState.Index' (duration: 25.524511ms)"],"step_count":2} {"level":"info","ts":"2026-08-27T20:06:49.34631Z","caller":"traceutil/trace.go:171","msg":"trace[602727943] transaction","detail":"{read_only:false; response_revision:1908; number_of_response:1; }","duration":"203.253981ms","start":"2026-08-27T20:06:49.143039Z","end":"2026-08-27T20:06:49.346293Z","steps":["trace[602727943] 'process raft request' (duration: 177.595929ms)","trace[602727943] 'compare' (duration: 25.306819ms)"],"step_count":2} {"level":"warn","ts":"2026-08-27T20:06:49.346609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.454643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-08-27T20:06:49.346707Z","caller":"traceutil/trace.go:171","msg":"trace[2143444509] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1908; }","duration":"107.577214ms","start":"2026-08-27T20:06:49.239106Z","end":"2026-08-27T20:06:49.346683Z","steps":["trace[2143444509] 'agreement among raft nodes before linearized reading' (duration: 107.337342ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:07:20.159063Z","caller":"traceutil/trace.go:171","msg":"trace[1558616413] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"105.720294ms","start":"2026-08-27T20:07:20.05332Z","end":"2026-08-27T20:07:20.159041Z","steps":["trace[1558616413] 'process raft request' (duration: 105.558953ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:07:20.315266Z","caller":"traceutil/trace.go:171","msg":"trace[898251719] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"260.194643ms","start":"2026-08-27T20:07:20.05503Z","end":"2026-08-27T20:07:20.315224Z","steps":["trace[898251719] 'process raft request' (duration: 242.312531ms)","trace[898251719] 'compare' (duration: 17.551219ms)"],"step_count":2} {"level":"info","ts":"2026-08-27T20:07:20.315688Z","caller":"traceutil/trace.go:171","msg":"trace[174351113] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"193.070949ms","start":"2026-08-27T20:07:20.122581Z","end":"2026-08-27T20:07:20.315652Z","steps":["trace[174351113] 'process raft request' (duration: 192.666795ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:07:20.315886Z","caller":"traceutil/trace.go:171","msg":"trace[1615631876] transaction","detail":"{read_only:false; response_revision:2137; number_of_response:1; }","duration":"101.889651ms","start":"2026-08-27T20:07:20.213973Z","end":"2026-08-27T20:07:20.315862Z","steps":["trace[1615631876] 'process raft request' (duration: 101.360156ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:07:22.323212Z","caller":"traceutil/trace.go:171","msg":"trace[770306389] transaction","detail":"{read_only:false; response_revision:2145; number_of_response:1; }","duration":"139.656689ms","start":"2026-08-27T20:07:22.183533Z","end":"2026-08-27T20:07:22.32319Z","steps":["trace[770306389] 'process raft request' (duration: 139.483358ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:07:22.571041Z","caller":"traceutil/trace.go:171","msg":"trace[1512051541] linearizableReadLoop","detail":"{readStateIndex:2231; appliedIndex:2229; }","duration":"251.765725ms","start":"2026-08-27T20:07:22.319247Z","end":"2026-08-27T20:07:22.571013Z","steps":["trace[1512051541] 'read index received' (duration: 3.782262ms)","trace[1512051541] 'applied index is now lower than readState.Index' (duration: 247.982143ms)"],"step_count":2} {"level":"info","ts":"2026-08-27T20:07:22.571111Z","caller":"traceutil/trace.go:171","msg":"trace[1731152346] transaction","detail":"{read_only:false; response_revision:2146; number_of_response:1; }","duration":"385.429204ms","start":"2026-08-27T20:07:22.185641Z","end":"2026-08-27T20:07:22.57107Z","steps":["trace[1731152346] 'process raft request' (duration: 372.448613ms)","trace[1731152346] 'compare' (duration: 12.543676ms)"],"step_count":2} {"level":"info","ts":"2026-08-27T20:07:22.571161Z","caller":"traceutil/trace.go:171","msg":"trace[1353354389] transaction","detail":"{read_only:false; response_revision:2147; number_of_response:1; }","duration":"249.915619ms","start":"2026-08-27T20:07:22.321228Z","end":"2026-08-27T20:07:22.571143Z","steps":["trace[1353354389] 'process raft request' (duration: 249.731218ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:07:22.571436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-27T20:07:22.185616Z","time spent":"385.600485ms","remote":"127.0.0.1:41854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-27T20:07:22.571459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.192909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-27T20:07:22.571504Z","caller":"traceutil/trace.go:171","msg":"trace[975449876] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2147; }","duration":"252.298469ms","start":"2026-08-27T20:07:22.319197Z","end":"2026-08-27T20:07:22.571495Z","steps":["trace[975449876] 'agreement among raft nodes before linearized reading' (duration: 252.004137ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:07:22.574809Z","caller":"traceutil/trace.go:171","msg":"trace[680606701] transaction","detail":"{read_only:false; response_revision:2148; number_of_response:1; }","duration":"213.70974ms","start":"2026-08-27T20:07:22.361079Z","end":"2026-08-27T20:07:22.574788Z","steps":["trace[680606701] 'process raft request' (duration: 213.573049ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:07:22.574874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.053318ms","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-27T20:07:22.574928Z","caller":"traceutil/trace.go:171","msg":"trace[791042595] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2148; }","duration":"164.118658ms","start":"2026-08-27T20:07:22.410795Z","end":"2026-08-27T20:07:22.574914Z","steps":["trace[791042595] 'agreement among raft nodes before linearized reading' (duration: 163.949127ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:09:15.391146Z","caller":"traceutil/trace.go:171","msg":"trace[1911236009] transaction","detail":"{read_only:false; response_revision:2856; number_of_response:1; }","duration":"168.15032ms","start":"2026-08-27T20:09:15.222974Z","end":"2026-08-27T20:09:15.391124Z","steps":["trace[1911236009] 'process raft request' (duration: 168.016136ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:09:15.401563Z","caller":"traceutil/trace.go:171","msg":"trace[475484577] transaction","detail":"{read_only:false; response_revision:2857; number_of_response:1; }","duration":"175.794884ms","start":"2026-08-27T20:09:15.225752Z","end":"2026-08-27T20:09:15.401547Z","steps":["trace[475484577] 'process raft request' (duration: 175.677341ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:09:15.401691Z","caller":"traceutil/trace.go:171","msg":"trace[1993861233] linearizableReadLoop","detail":"{readStateIndex:2968; appliedIndex:2966; }","duration":"175.617368ms","start":"2026-08-27T20:09:15.225887Z","end":"2026-08-27T20:09:15.401505Z","steps":["trace[1993861233] 'read index received' (duration: 165.04088ms)","trace[1993861233] 'applied index is now lower than readState.Index' (duration: 10.575268ms)"],"step_count":2} {"level":"warn","ts":"2026-08-27T20:09:15.402016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.102272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-27T20:09:15.402158Z","caller":"traceutil/trace.go:171","msg":"trace[1481805389] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2857; }","duration":"176.276286ms","start":"2026-08-27T20:09:15.225854Z","end":"2026-08-27T20:09:15.40213Z","steps":["trace[1481805389] 'agreement among raft nodes before linearized reading' (duration: 175.960558ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:09:15.402066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.753132ms","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-27T20:09:15.402418Z","caller":"traceutil/trace.go:171","msg":"trace[1920588633] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2857; }","duration":"176.128863ms","start":"2026-08-27T20:09:15.226268Z","end":"2026-08-27T20:09:15.402397Z","steps":["trace[1920588633] 'agreement among raft nodes before linearized reading' (duration: 175.66983ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:09:15.751719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.778608ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-27T20:09:15.75194Z","caller":"traceutil/trace.go:171","msg":"trace[566379164] transaction","detail":"{read_only:false; response_revision:2862; number_of_response:1; }","duration":"217.769759ms","start":"2026-08-27T20:09:15.534148Z","end":"2026-08-27T20:09:15.751918Z","steps":["trace[566379164] 'process raft request' (duration: 217.698348ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:09:15.752222Z","caller":"traceutil/trace.go:171","msg":"trace[1796057267] transaction","detail":"{read_only:false; response_revision:2861; number_of_response:1; }","duration":"287.011278ms","start":"2026-08-27T20:09:15.465196Z","end":"2026-08-27T20:09:15.752207Z","steps":["trace[1796057267] 'process raft request' (duration: 122.620094ms)","trace[1796057267] 'compare' (duration: 163.05773ms)"],"step_count":2} {"level":"warn","ts":"2026-08-27T20:09:15.977895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.469268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-27T20:09:15.97801Z","caller":"traceutil/trace.go:171","msg":"trace[1379068302] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:2862; }","duration":"118.661472ms","start":"2026-08-27T20:09:15.859324Z","end":"2026-08-27T20:09:15.977985Z","steps":["trace[1379068302] 'count revisions from in-memory index tree' (duration: 118.350945ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:13:33.470294Z","caller":"traceutil/trace.go:171","msg":"trace[179825807] transaction","detail":"{read_only:false; response_revision:4795; number_of_response:1; }","duration":"104.493866ms","start":"2026-08-27T20:13:33.365779Z","end":"2026-08-27T20:13:33.470272Z","steps":["trace[179825807] 'process raft request' (duration: 76.253018ms)","trace[179825807] 'compare' (duration: 28.117216ms)"],"step_count":2} {"level":"info","ts":"2026-08-27T20:13:33.474539Z","caller":"traceutil/trace.go:171","msg":"trace[686001420] linearizableReadLoop","detail":"{readStateIndex:4984; appliedIndex:4980; }","duration":"102.115994ms","start":"2026-08-27T20:13:33.372415Z","end":"2026-08-27T20:13:33.474531Z","steps":["trace[686001420] 'read index received' (duration: 69.628311ms)","trace[686001420] 'applied index is now lower than readState.Index' (duration: 32.486973ms)"],"step_count":2} {"level":"info","ts":"2026-08-27T20:13:33.474582Z","caller":"traceutil/trace.go:171","msg":"trace[1294120619] transaction","detail":"{read_only:false; response_revision:4796; number_of_response:1; }","duration":"107.361214ms","start":"2026-08-27T20:13:33.367216Z","end":"2026-08-27T20:13:33.474577Z","steps":["trace[1294120619] 'process raft request' (duration: 107.137921ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:13:33.474721Z","caller":"traceutil/trace.go:171","msg":"trace[389442937] transaction","detail":"{read_only:false; response_revision:4797; number_of_response:1; }","duration":"105.647812ms","start":"2026-08-27T20:13:33.369067Z","end":"2026-08-27T20:13:33.474715Z","steps":["trace[389442937] 'process raft request' (duration: 105.323226ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:13:33.474889Z","caller":"traceutil/trace.go:171","msg":"trace[1009660619] transaction","detail":"{read_only:false; response_revision:4798; number_of_response:1; }","duration":"103.468323ms","start":"2026-08-27T20:13:33.371415Z","end":"2026-08-27T20:13:33.474883Z","steps":["trace[1009660619] 'process raft request' (duration: 103.031376ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:13:33.475155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.721763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-08-27T20:13:33.475178Z","caller":"traceutil/trace.go:171","msg":"trace[877338311] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4799; }","duration":"102.758534ms","start":"2026-08-27T20:13:33.372411Z","end":"2026-08-27T20:13:33.475169Z","steps":["trace[877338311] 'agreement among raft nodes before linearized reading' (duration: 102.656792ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:13:33.510776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.9508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:7 size:61057"} {"level":"info","ts":"2026-08-27T20:13:33.510873Z","caller":"traceutil/trace.go:171","msg":"trace[850759015] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:7; response_revision:4800; }","duration":"137.073171ms","start":"2026-08-27T20:13:33.37378Z","end":"2026-08-27T20:13:33.510853Z","steps":["trace[850759015] 'agreement among raft nodes before linearized reading' (duration: 136.703836ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:13:45.39108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.681483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-27T20:13:45.391164Z","caller":"traceutil/trace.go:171","msg":"trace[2065835367] range","detail":"{range_begin:/registry/secretgen.k14s.io/certificates/; range_end:/registry/secretgen.k14s.io/certificates0; response_count:0; response_revision:5034; }","duration":"258.790394ms","start":"2026-08-27T20:13:45.132355Z","end":"2026-08-27T20:13:45.391145Z","steps":["trace[2065835367] 'count revisions from in-memory index tree' (duration: 258.635343ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:13:45.391883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.921099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4d2046e2-9123-4fae-a29f-f9bf117946ee\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-08-27T20:13:45.392011Z","caller":"traceutil/trace.go:171","msg":"trace[846578255] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4d2046e2-9123-4fae-a29f-f9bf117946ee; range_end:; response_count:1; response_revision:5034; }","duration":"200.080391ms","start":"2026-08-27T20:13:45.191901Z","end":"2026-08-27T20:13:45.391982Z","steps":["trace[846578255] 'range keys from in-memory index tree' (duration: 199.262189ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:13:45.485451Z","caller":"traceutil/trace.go:171","msg":"trace[65738286] transaction","detail":"{read_only:false; response_revision:5035; number_of_response:1; }","duration":"139.37481ms","start":"2026-08-27T20:13:45.346058Z","end":"2026-08-27T20:13:45.485433Z","steps":["trace[65738286] 'process raft request' (duration: 139.214398ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:14:00.266875Z","caller":"traceutil/trace.go:171","msg":"trace[1941467723] linearizableReadLoop","detail":"{readStateIndex:5438; appliedIndex:5437; }","duration":"154.231238ms","start":"2026-08-27T20:14:00.11262Z","end":"2026-08-27T20:14:00.266851Z","steps":["trace[1941467723] 'read index received' (duration: 154.056285ms)","trace[1941467723] 'applied index is now lower than readState.Index' (duration: 173.913µs)"],"step_count":2} {"level":"warn","ts":"2026-08-27T20:14:00.267008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.376269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-27T20:14:00.266991Z","caller":"traceutil/trace.go:171","msg":"trace[781488310] transaction","detail":"{read_only:false; response_revision:5238; number_of_response:1; }","duration":"157.628601ms","start":"2026-08-27T20:14:00.10933Z","end":"2026-08-27T20:14:00.266959Z","steps":["trace[781488310] 'process raft request' (duration: 157.356287ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:14:00.267043Z","caller":"traceutil/trace.go:171","msg":"trace[56200701] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5238; }","duration":"154.483841ms","start":"2026-08-27T20:14:00.11255Z","end":"2026-08-27T20:14:00.267034Z","steps":["trace[56200701] 'agreement among raft nodes before linearized reading' (duration: 154.40183ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:14:00.620003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.149919ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-27T20:14:00.620156Z","caller":"traceutil/trace.go:171","msg":"trace[392945929] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5238; }","duration":"158.331761ms","start":"2026-08-27T20:14:00.461804Z","end":"2026-08-27T20:14:00.620136Z","steps":["trace[392945929] 'range keys from in-memory index tree' (duration: 158.127748ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:14:00.620475Z","caller":"traceutil/trace.go:171","msg":"trace[223730638] transaction","detail":"{read_only:false; response_revision:5239; number_of_response:1; }","duration":"492.032482ms","start":"2026-08-27T20:14:00.12841Z","end":"2026-08-27T20:14:00.620443Z","steps":["trace[223730638] 'process raft request' (duration: 462.667589ms)","trace[223730638] 'compare' (duration: 28.647393ms)"],"step_count":2} {"level":"warn","ts":"2026-08-27T20:14:00.62067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-27T20:14:00.128384Z","time spent":"492.169223ms","remote":"127.0.0.1:41854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-27T20:14:00.62088Z","caller":"traceutil/trace.go:171","msg":"trace[411991725] linearizableReadLoop","detail":"{readStateIndex:5439; appliedIndex:5438; }","duration":"349.610808ms","start":"2026-08-27T20:14:00.271247Z","end":"2026-08-27T20:14:00.620858Z","steps":["trace[411991725] 'read index received' (duration: 319.852061ms)","trace[411991725] 'applied index is now lower than readState.Index' (duration: 29.756457ms)"],"step_count":2} {"level":"warn","ts":"2026-08-27T20:14:00.621304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.795801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-27T20:14:00.621354Z","caller":"traceutil/trace.go:171","msg":"trace[1630912109] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5239; }","duration":"350.109625ms","start":"2026-08-27T20:14:00.27123Z","end":"2026-08-27T20:14:00.621339Z","steps":["trace[1630912109] 'agreement among raft nodes before linearized reading' (duration: 349.768291ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:14:00.621405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-27T20:14:00.271215Z","time spent":"350.178376ms","remote":"127.0.0.1:41812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-08-27T20:14:00.62191Z","caller":"traceutil/trace.go:171","msg":"trace[627498009] transaction","detail":"{read_only:false; response_revision:5240; number_of_response:1; }","duration":"227.919415ms","start":"2026-08-27T20:14:00.393948Z","end":"2026-08-27T20:14:00.621867Z","steps":["trace[627498009] 'process raft request' (duration: 226.459606ms)"],"step_count":1} {"level":"warn","ts":"2026-08-27T20:14:00.622227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.562166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-27T20:14:00.622301Z","caller":"traceutil/trace.go:171","msg":"trace[1208973334] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:5240; }","duration":"189.689387ms","start":"2026-08-27T20:14:00.432595Z","end":"2026-08-27T20:14:00.622284Z","steps":["trace[1208973334] 'agreement among raft nodes before linearized reading' (duration: 189.591276ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:14:19.692034Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2882} {"level":"info","ts":"2026-08-27T20:14:19.7777Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2882,"took":"84.032656ms","hash":2280487653,"current-db-size-bytes":52813824,"current-db-size":"53 MB","current-db-size-in-use-bytes":27648000,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-08-27T20:14:19.777874Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2280487653,"revision":2882,"compact-revision":-1} {"level":"info","ts":"2026-08-27T20:17:46.286539Z","caller":"traceutil/trace.go:171","msg":"trace[87817504] transaction","detail":"{read_only:false; response_revision:6858; number_of_response:1; }","duration":"117.190245ms","start":"2026-08-27T20:17:46.169283Z","end":"2026-08-27T20:17:46.286473Z","steps":["trace[87817504] 'process raft request' (duration: 116.919167ms)"],"step_count":1} {"level":"info","ts":"2026-08-27T20:19:19.699075Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5356} {"level":"info","ts":"2026-08-27T20:19:19.848874Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5356,"took":"147.824887ms","hash":1401087947,"current-db-size-bytes":52813824,"current-db-size":"53 MB","current-db-size-in-use-bytes":18952192,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-08-27T20:19:19.849045Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1401087947,"revision":5356,"compact-revision":2882}