{"level":"warn","ts":"2026-08-17T10:17:36.566334Z","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-17T10:17:36.566431Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.237: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.237:2380","--initial-cluster=instance=https://199.19.213.237:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.237:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.237: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-17T10:17:36.566498Z","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-17T10:17:36.566506Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.237:2380"]} {"level":"info","ts":"2026-08-17T10:17:36.566529Z","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-17T10:17:36.567229Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.237:2379"]} {"level":"info","ts":"2026-08-17T10:17:36.56732Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.237:2380"],"listen-peer-urls":["https://199.19.213.237:2380"],"advertise-client-urls":["https://199.19.213.237:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.237:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.237: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-17T10:17:36.569547Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.000728ms"} {"level":"info","ts":"2026-08-17T10:17:36.574603Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c51d7a9ea5537d6e","cluster-id":"bea7a5ea8f053dc3"} {"level":"info","ts":"2026-08-17T10:17:36.574765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e switched to configuration voters=()"} {"level":"info","ts":"2026-08-17T10:17:36.574812Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e became follower at term 0"} {"level":"info","ts":"2026-08-17T10:17:36.57484Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c51d7a9ea5537d6e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-17T10:17:36.57486Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e became follower at term 1"} {"level":"info","ts":"2026-08-17T10:17:36.574921Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e switched to configuration voters=(14203643621593546094)"} {"level":"warn","ts":"2026-08-17T10:17:36.581498Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-17T10:17:36.583866Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-17T10:17:36.585198Z","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-17T10:17:36.588138Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c51d7a9ea5537d6e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-17T10:17:36.588742Z","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-17T10:17:36.588761Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c51d7a9ea5537d6e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-17T10:17:36.588919Z","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-17T10:17:36.588937Z","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-17T10:17:36.589245Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e switched to configuration voters=(14203643621593546094)"} {"level":"info","ts":"2026-08-17T10:17:36.589684Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"bea7a5ea8f053dc3","local-member-id":"c51d7a9ea5537d6e","added-peer-id":"c51d7a9ea5537d6e","added-peer-peer-urls":["https://199.19.213.237:2380"]} {"level":"info","ts":"2026-08-17T10:17:36.593257Z","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-17T10:17:36.593426Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.237:2380"} {"level":"info","ts":"2026-08-17T10:17:36.593477Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.237:2380"} {"level":"info","ts":"2026-08-17T10:17:36.593493Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c51d7a9ea5537d6e","initial-advertise-peer-urls":["https://199.19.213.237:2380"],"listen-peer-urls":["https://199.19.213.237:2380"],"advertise-client-urls":["https://199.19.213.237:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.237:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-17T10:17:36.593518Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-17T10:17:36.976303Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e is starting a new election at term 1"} {"level":"info","ts":"2026-08-17T10:17:36.976394Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e became pre-candidate at term 1"} {"level":"info","ts":"2026-08-17T10:17:36.976428Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e received MsgPreVoteResp from c51d7a9ea5537d6e at term 1"} {"level":"info","ts":"2026-08-17T10:17:36.97645Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e became candidate at term 2"} {"level":"info","ts":"2026-08-17T10:17:36.976461Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e received MsgVoteResp from c51d7a9ea5537d6e at term 2"} {"level":"info","ts":"2026-08-17T10:17:36.976478Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e became leader at term 2"} {"level":"info","ts":"2026-08-17T10:17:36.976499Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c51d7a9ea5537d6e elected leader c51d7a9ea5537d6e at term 2"} {"level":"info","ts":"2026-08-17T10:17:36.978433Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c51d7a9ea5537d6e","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.237:2379]}","request-path":"/0/members/c51d7a9ea5537d6e/attributes","cluster-id":"bea7a5ea8f053dc3","publish-timeout":"7s"} {"level":"info","ts":"2026-08-17T10:17:36.985631Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-17T10:17:36.985687Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-17T10:17:36.985775Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-17T10:17:36.986052Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-17T10:17:36.986088Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-17T10:17:36.987898Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.237:2379"} {"level":"info","ts":"2026-08-17T10:17:36.988869Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-17T10:17:36.99722Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"bea7a5ea8f053dc3","local-member-id":"c51d7a9ea5537d6e","cluster-version":"3.5"} {"level":"info","ts":"2026-08-17T10:17:36.99737Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-17T10:17:36.997409Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-17T10:17:52.307487Z","caller":"traceutil/trace.go:171","msg":"trace[2024116543] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"200.115164ms","start":"2026-08-17T10:17:52.107295Z","end":"2026-08-17T10:17:52.307411Z","steps":["trace[2024116543] 'process raft request' (duration: 199.399056ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:17:52.442638Z","caller":"traceutil/trace.go:171","msg":"trace[1866277092] linearizableReadLoop","detail":"{readStateIndex:427; appliedIndex:426; }","duration":"110.413825ms","start":"2026-08-17T10:17:52.332191Z","end":"2026-08-17T10:17:52.442604Z","steps":["trace[1866277092] 'read index received' (duration: 110.236571ms)","trace[1866277092] 'applied index is now lower than readState.Index' (duration: 175.894µs)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:17:52.442692Z","caller":"traceutil/trace.go:171","msg":"trace[1831505080] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"125.069622ms","start":"2026-08-17T10:17:52.317583Z","end":"2026-08-17T10:17:52.442653Z","steps":["trace[1831505080] 'process raft request' (duration: 124.813606ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:17:52.442892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.589649ms","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-17T10:17:52.442958Z","caller":"traceutil/trace.go:171","msg":"trace[7628993] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:412; }","duration":"110.791835ms","start":"2026-08-17T10:17:52.332156Z","end":"2026-08-17T10:17:52.442948Z","steps":["trace[7628993] 'agreement among raft nodes before linearized reading' (duration: 110.578319ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:18:19.381743Z","caller":"traceutil/trace.go:171","msg":"trace[1378931179] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"146.247489ms","start":"2026-08-17T10:18:19.23547Z","end":"2026-08-17T10:18:19.381718Z","steps":["trace[1378931179] 'process raft request' (duration: 146.075085ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:18:19.628525Z","caller":"traceutil/trace.go:171","msg":"trace[979490725] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"319.924978ms","start":"2026-08-17T10:18:19.308571Z","end":"2026-08-17T10:18:19.628496Z","steps":["trace[979490725] 'process raft request' (duration: 319.285222ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:19.629215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:19.308536Z","time spent":"320.071311ms","remote":"127.0.0.1:38506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-17T10:18:19.700549Z","caller":"traceutil/trace.go:171","msg":"trace[1349962253] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"190.1118ms","start":"2026-08-17T10:18:19.510397Z","end":"2026-08-17T10:18:19.700509Z","steps":["trace[1349962253] 'process raft request' (duration: 168.144223ms)","trace[1349962253] 'compare' (duration: 21.6639ms)"],"step_count":2} {"level":"warn","ts":"2026-08-17T10:18:20.16993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.547619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-17T10:18:20.170093Z","caller":"traceutil/trace.go:171","msg":"trace[812215699] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:636; }","duration":"294.722613ms","start":"2026-08-17T10:18:19.875345Z","end":"2026-08-17T10:18:20.170068Z","steps":["trace[812215699] 'range keys from in-memory index tree' (duration: 294.386215ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:20.170175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.090791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-17T10:18:20.170299Z","caller":"traceutil/trace.go:171","msg":"trace[351979530] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:636; }","duration":"161.278927ms","start":"2026-08-17T10:18:20.008989Z","end":"2026-08-17T10:18:20.170268Z","steps":["trace[351979530] 'range keys from in-memory index tree' (duration: 160.811315ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:18:21.453962Z","caller":"traceutil/trace.go:171","msg":"trace[1594802343] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"113.183153ms","start":"2026-08-17T10:18:21.340735Z","end":"2026-08-17T10:18:21.453919Z","steps":["trace[1594802343] 'process raft request' (duration: 73.595997ms)","trace[1594802343] 'compare' (duration: 39.404632ms)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:19:51.607379Z","caller":"traceutil/trace.go:171","msg":"trace[297721118] linearizableReadLoop","detail":"{readStateIndex:1954; appliedIndex:1953; }","duration":"255.748962ms","start":"2026-08-17T10:19:51.351606Z","end":"2026-08-17T10:19:51.607355Z","steps":["trace[297721118] 'read index received' (duration: 255.600528ms)","trace[297721118] 'applied index is now lower than readState.Index' (duration: 147.414µs)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:19:51.607471Z","caller":"traceutil/trace.go:171","msg":"trace[1361838764] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"258.234443ms","start":"2026-08-17T10:19:51.349198Z","end":"2026-08-17T10:19:51.607432Z","steps":["trace[1361838764] 'process raft request' (duration: 257.966645ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:19:51.607591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.965617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-17T10:19:51.607635Z","caller":"traceutil/trace.go:171","msg":"trace[1788802826] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1883; }","duration":"256.057318ms","start":"2026-08-17T10:19:51.351568Z","end":"2026-08-17T10:19:51.607625Z","steps":["trace[1788802826] 'agreement among raft nodes before linearized reading' (duration: 255.912695ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:19:52.122742Z","caller":"traceutil/trace.go:171","msg":"trace[1717893894] transaction","detail":"{read_only:false; response_revision:1887; number_of_response:1; }","duration":"170.678145ms","start":"2026-08-17T10:19:51.95203Z","end":"2026-08-17T10:19:52.122708Z","steps":["trace[1717893894] 'process raft request' (duration: 170.268264ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:20:40.590308Z","caller":"traceutil/trace.go:171","msg":"trace[361623838] transaction","detail":"{read_only:false; response_revision:2197; number_of_response:1; }","duration":"152.467694ms","start":"2026-08-17T10:20:40.437788Z","end":"2026-08-17T10:20:40.590256Z","steps":["trace[361623838] 'process raft request' (duration: 152.098275ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:20:46.561854Z","caller":"traceutil/trace.go:171","msg":"trace[13544660] linearizableReadLoop","detail":"{readStateIndex:2312; appliedIndex:2311; }","duration":"210.809591ms","start":"2026-08-17T10:20:46.35102Z","end":"2026-08-17T10:20:46.56183Z","steps":["trace[13544660] 'read index received' (duration: 210.672137ms)","trace[13544660] 'applied index is now lower than readState.Index' (duration: 136.924µs)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:20:46.561974Z","caller":"traceutil/trace.go:171","msg":"trace[1293916854] transaction","detail":"{read_only:false; response_revision:2229; number_of_response:1; }","duration":"264.612528ms","start":"2026-08-17T10:20:46.29733Z","end":"2026-08-17T10:20:46.561943Z","steps":["trace[1293916854] 'process raft request' (duration: 264.359161ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:20:46.56208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.015667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-17T10:20:46.56215Z","caller":"traceutil/trace.go:171","msg":"trace[352131936] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2229; }","duration":"211.14993ms","start":"2026-08-17T10:20:46.350963Z","end":"2026-08-17T10:20:46.562113Z","steps":["trace[352131936] 'agreement among raft nodes before linearized reading' (duration: 210.961996ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:21:27.180554Z","caller":"traceutil/trace.go:171","msg":"trace[573143703] transaction","detail":"{read_only:false; response_revision:2623; number_of_response:1; }","duration":"109.243534ms","start":"2026-08-17T10:21:27.071277Z","end":"2026-08-17T10:21:27.180521Z","steps":["trace[573143703] 'process raft request' (duration: 109.004158ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:22:06.311563Z","caller":"traceutil/trace.go:171","msg":"trace[1153060118] transaction","detail":"{read_only:false; response_revision:2856; number_of_response:1; }","duration":"110.566635ms","start":"2026-08-17T10:22:06.200967Z","end":"2026-08-17T10:22:06.311534Z","steps":["trace[1153060118] 'process raft request' (duration: 110.40589ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:26:11.16335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.284605ms","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-17T10:26:11.163498Z","caller":"traceutil/trace.go:171","msg":"trace[810299153] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5093; }","duration":"235.508571ms","start":"2026-08-17T10:26:10.927963Z","end":"2026-08-17T10:26:11.163472Z","steps":["trace[810299153] 'range keys from in-memory index tree' (duration: 234.902695ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:26:11.163445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.107675ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-17T10:26:11.163645Z","caller":"traceutil/trace.go:171","msg":"trace[2011765828] linearizableReadLoop","detail":"{readStateIndex:5282; appliedIndex:5281; }","duration":"140.74957ms","start":"2026-08-17T10:26:11.022867Z","end":"2026-08-17T10:26:11.163617Z","steps":["trace[2011765828] 'read index received' (duration: 39.095732ms)","trace[2011765828] 'applied index is now lower than readState.Index' (duration: 101.652198ms)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:26:11.163764Z","caller":"traceutil/trace.go:171","msg":"trace[199002997] transaction","detail":"{read_only:false; response_revision:5094; number_of_response:1; }","duration":"150.338641ms","start":"2026-08-17T10:26:11.013376Z","end":"2026-08-17T10:26:11.163715Z","steps":["trace[199002997] 'process raft request' (duration: 48.679192ms)","trace[199002997] 'compare' (duration: 100.953111ms)"],"step_count":2} {"level":"warn","ts":"2026-08-17T10:26:11.163982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.088918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fc55007a-dad4-4491-8f92-1d1e86f5d3d7\" ","response":"range_response_count:1 size:3601"} {"level":"warn","ts":"2026-08-17T10:26:11.164005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.761045ms","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-17T10:26:11.164079Z","caller":"traceutil/trace.go:171","msg":"trace[1045082725] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fc55007a-dad4-4491-8f92-1d1e86f5d3d7; range_end:; response_count:1; response_revision:5094; }","duration":"141.233472ms","start":"2026-08-17T10:26:11.022821Z","end":"2026-08-17T10:26:11.164055Z","steps":["trace[1045082725] 'agreement among raft nodes before linearized reading' (duration: 140.907714ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:26:11.164101Z","caller":"traceutil/trace.go:171","msg":"trace[1342489566] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5094; }","duration":"124.902048ms","start":"2026-08-17T10:26:11.039176Z","end":"2026-08-17T10:26:11.164078Z","steps":["trace[1342489566] 'agreement among raft nodes before linearized reading' (duration: 124.629732ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:26:11.615183Z","caller":"traceutil/trace.go:171","msg":"trace[950201132] transaction","detail":"{read_only:false; response_revision:5099; number_of_response:1; }","duration":"146.143729ms","start":"2026-08-17T10:26:11.469003Z","end":"2026-08-17T10:26:11.615147Z","steps":["trace[950201132] 'process raft request' (duration: 145.861212ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:26:24.422123Z","caller":"traceutil/trace.go:171","msg":"trace[1747254586] transaction","detail":"{read_only:false; response_revision:5345; number_of_response:1; }","duration":"109.331793ms","start":"2026-08-17T10:26:24.312734Z","end":"2026-08-17T10:26:24.422065Z","steps":["trace[1747254586] 'process raft request' (duration: 43.19479ms)","trace[1747254586] 'compare' (duration: 65.927667ms)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:26:24.794743Z","caller":"traceutil/trace.go:171","msg":"trace[1458849487] transaction","detail":"{read_only:false; response_revision:5348; number_of_response:1; }","duration":"271.502937ms","start":"2026-08-17T10:26:24.523216Z","end":"2026-08-17T10:26:24.794719Z","steps":["trace[1458849487] 'process raft request' (duration: 184.80586ms)","trace[1458849487] 'compare' (duration: 86.360048ms)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:26:24.794883Z","caller":"traceutil/trace.go:171","msg":"trace[1129322537] linearizableReadLoop","detail":"{readStateIndex:5545; appliedIndex:5543; }","duration":"108.437971ms","start":"2026-08-17T10:26:24.686422Z","end":"2026-08-17T10:26:24.79486Z","steps":["trace[1129322537] 'read index received' (duration: 21.620671ms)","trace[1129322537] 'applied index is now lower than readState.Index' (duration: 86.81624ms)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:26:24.794995Z","caller":"traceutil/trace.go:171","msg":"trace[941721178] transaction","detail":"{read_only:false; response_revision:5349; number_of_response:1; }","duration":"256.385763ms","start":"2026-08-17T10:26:24.538556Z","end":"2026-08-17T10:26:24.794942Z","steps":["trace[941721178] 'process raft request' (duration: 256.092786ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:26:24.795032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.580015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-17T10:26:24.795134Z","caller":"traceutil/trace.go:171","msg":"trace[1209029079] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5349; }","duration":"108.740748ms","start":"2026-08-17T10:26:24.686371Z","end":"2026-08-17T10:26:24.795111Z","steps":["trace[1209029079] 'agreement among raft nodes before linearized reading' (duration: 108.580884ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:26:33.259928Z","caller":"traceutil/trace.go:171","msg":"trace[265847594] transaction","detail":"{read_only:false; response_revision:5546; number_of_response:1; }","duration":"176.236203ms","start":"2026-08-17T10:26:33.083512Z","end":"2026-08-17T10:26:33.259749Z","steps":["trace[265847594] 'process raft request' (duration: 176.012628ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:26:33.403725Z","caller":"traceutil/trace.go:171","msg":"trace[1747019094] linearizableReadLoop","detail":"{readStateIndex:5747; appliedIndex:5746; }","duration":"136.699562ms","start":"2026-08-17T10:26:33.266999Z","end":"2026-08-17T10:26:33.403698Z","steps":["trace[1747019094] 'read index received' (duration: 119.773µs)","trace[1747019094] 'applied index is now lower than readState.Index' (duration: 136.578779ms)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:26:33.40381Z","caller":"traceutil/trace.go:171","msg":"trace[16903258] transaction","detail":"{read_only:false; response_revision:5547; number_of_response:1; }","duration":"136.806524ms","start":"2026-08-17T10:26:33.26696Z","end":"2026-08-17T10:26:33.403766Z","steps":["trace[16903258] 'process raft request' (duration: 54.765048ms)","trace[16903258] 'compare' (duration: 81.851402ms)"],"step_count":2} {"level":"warn","ts":"2026-08-17T10:26:33.404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.963097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-mstlc\" ","response":"range_response_count:1 size:8064"} {"level":"info","ts":"2026-08-17T10:26:33.404065Z","caller":"traceutil/trace.go:171","msg":"trace[1512248142] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-mstlc; range_end:; response_count:1; response_revision:5547; }","duration":"137.093201ms","start":"2026-08-17T10:26:33.266954Z","end":"2026-08-17T10:26:33.404047Z","steps":["trace[1512248142] 'agreement among raft nodes before linearized reading' (duration: 136.857905ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:26:33.416062Z","caller":"traceutil/trace.go:171","msg":"trace[1477028603] transaction","detail":"{read_only:false; response_revision:5548; number_of_response:1; }","duration":"147.564603ms","start":"2026-08-17T10:26:33.268463Z","end":"2026-08-17T10:26:33.416027Z","steps":["trace[1477028603] 'process raft request' (duration: 147.173424ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:26:33.598452Z","caller":"traceutil/trace.go:171","msg":"trace[364363281] transaction","detail":"{read_only:false; response_revision:5553; number_of_response:1; }","duration":"136.974648ms","start":"2026-08-17T10:26:33.461407Z","end":"2026-08-17T10:26:33.598382Z","steps":["trace[364363281] 'process raft request' (duration: 116.602418ms)","trace[364363281] 'compare' (duration: 20.145604ms)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:27:37.199537Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3025} {"level":"info","ts":"2026-08-17T10:27:37.289771Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3025,"took":"88.749197ms","hash":3871483094,"current-db-size-bytes":58834944,"current-db-size":"59 MB","current-db-size-in-use-bytes":31862784,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-08-17T10:27:37.289851Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3871483094,"revision":3025,"compact-revision":-1} {"level":"info","ts":"2026-08-17T10:32:37.206043Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6103} {"level":"info","ts":"2026-08-17T10:32:37.308319Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6103,"took":"100.011391ms","hash":612545697,"current-db-size-bytes":58834944,"current-db-size":"59 MB","current-db-size-in-use-bytes":22016000,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-08-17T10:32:37.308444Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":612545697,"revision":6103,"compact-revision":3025} {"level":"info","ts":"2026-08-17T10:32:53.81752Z","caller":"traceutil/trace.go:171","msg":"trace[1031748353] transaction","detail":"{read_only:false; response_revision:8414; number_of_response:1; }","duration":"260.642814ms","start":"2026-08-17T10:32:53.556847Z","end":"2026-08-17T10:32:53.81749Z","steps":["trace[1031748353] 'process raft request' (duration: 246.039052ms)","trace[1031748353] 'compare' (duration: 14.178962ms)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:32:53.817525Z","caller":"traceutil/trace.go:171","msg":"trace[1533644814] linearizableReadLoop","detail":"{readStateIndex:8709; appliedIndex:8708; }","duration":"130.086796ms","start":"2026-08-17T10:32:53.687396Z","end":"2026-08-17T10:32:53.817483Z","steps":["trace[1533644814] 'read index received' (duration: 115.362301ms)","trace[1533644814] 'applied index is now lower than readState.Index' (duration: 14.722595ms)"],"step_count":2} {"level":"warn","ts":"2026-08-17T10:32:53.817673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.26605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-17T10:32:53.817752Z","caller":"traceutil/trace.go:171","msg":"trace[156152634] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8414; }","duration":"130.355323ms","start":"2026-08-17T10:32:53.687379Z","end":"2026-08-17T10:32:53.817734Z","steps":["trace[156152634] 'agreement among raft nodes before linearized reading' (duration: 130.22877ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:33:10.087264Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002263.wal"} {"level":"info","ts":"2026-08-17T10:33:35.792397Z","caller":"traceutil/trace.go:171","msg":"trace[464458410] linearizableReadLoop","detail":"{readStateIndex:8996; appliedIndex:8995; }","duration":"104.564122ms","start":"2026-08-17T10:33:35.687807Z","end":"2026-08-17T10:33:35.792371Z","steps":["trace[464458410] 'read index received' (duration: 104.303276ms)","trace[464458410] 'applied index is now lower than readState.Index' (duration: 259.996µs)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:33:35.792777Z","caller":"traceutil/trace.go:171","msg":"trace[58028677] transaction","detail":"{read_only:false; response_revision:8690; number_of_response:1; }","duration":"163.926912ms","start":"2026-08-17T10:33:35.628834Z","end":"2026-08-17T10:33:35.792761Z","steps":["trace[58028677] 'process raft request' (duration: 163.371429ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:33:35.79306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.258618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-17T10:33:35.793105Z","caller":"traceutil/trace.go:171","msg":"trace[213672418] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8690; }","duration":"105.35514ms","start":"2026-08-17T10:33:35.687739Z","end":"2026-08-17T10:33:35.793094Z","steps":["trace[213672418] 'agreement among raft nodes before linearized reading' (duration: 105.270468ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:33:40.085259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.199775ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-17T10:33:40.08542Z","caller":"traceutil/trace.go:171","msg":"trace[681222365] linearizableReadLoop","detail":"{readStateIndex:9017; appliedIndex:9016; }","duration":"107.546612ms","start":"2026-08-17T10:33:39.977856Z","end":"2026-08-17T10:33:40.085402Z","steps":["trace[681222365] 'read index received' (duration: 57.191µs)","trace[681222365] 'applied index is now lower than readState.Index' (duration: 107.487971ms)"],"step_count":2} {"level":"warn","ts":"2026-08-17T10:33:40.085692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.8256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-17T10:33:40.085781Z","caller":"traceutil/trace.go:171","msg":"trace[453193570] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8711; }","duration":"107.974573ms","start":"2026-08-17T10:33:39.977783Z","end":"2026-08-17T10:33:40.085757Z","steps":["trace[453193570] 'agreement among raft nodes before linearized reading' (duration: 107.822569ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:33:40.085888Z","caller":"traceutil/trace.go:171","msg":"trace[1102146900] transaction","detail":"{read_only:false; response_revision:8711; number_of_response:1; }","duration":"234.154205ms","start":"2026-08-17T10:33:39.851689Z","end":"2026-08-17T10:33:40.085843Z","steps":["trace[1102146900] 'process raft request' (duration: 97.280545ms)","trace[1102146900] 'compare' (duration: 136.070561ms)"],"step_count":2} {"level":"warn","ts":"2026-08-17T10:33:48.805103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.642521ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-17T10:33:48.80543Z","caller":"traceutil/trace.go:171","msg":"trace[840149451] linearizableReadLoop","detail":"{readStateIndex:9111; appliedIndex:9109; }","duration":"118.23985ms","start":"2026-08-17T10:33:48.687165Z","end":"2026-08-17T10:33:48.805405Z","steps":["trace[840149451] 'read index received' (duration: 11.156809ms)","trace[840149451] 'applied index is now lower than readState.Index' (duration: 107.02297ms)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:33:48.805436Z","caller":"traceutil/trace.go:171","msg":"trace[2058613971] transaction","detail":"{read_only:false; response_revision:8799; number_of_response:1; }","duration":"157.772333ms","start":"2026-08-17T10:33:48.647629Z","end":"2026-08-17T10:33:48.805401Z","steps":["trace[2058613971] 'process raft request' (duration: 50.711542ms)","trace[2058613971] 'compare' (duration: 106.497688ms)"],"step_count":2} {"level":"warn","ts":"2026-08-17T10:33:48.805548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.378643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-17T10:33:48.805545Z","caller":"traceutil/trace.go:171","msg":"trace[712989486] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8800; }","duration":"157.104607ms","start":"2026-08-17T10:33:48.648386Z","end":"2026-08-17T10:33:48.805491Z","steps":["trace[712989486] 'process raft request' (duration: 156.857262ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:33:48.805605Z","caller":"traceutil/trace.go:171","msg":"trace[357738955] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8800; }","duration":"118.458856ms","start":"2026-08-17T10:33:48.687129Z","end":"2026-08-17T10:33:48.805588Z","steps":["trace[357738955] 'agreement among raft nodes before linearized reading' (duration: 118.365854ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:33:49.046398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.167397ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-17T10:33:49.046513Z","caller":"traceutil/trace.go:171","msg":"trace[890139029] transaction","detail":"{read_only:false; response_revision:8801; number_of_response:1; }","duration":"228.93399ms","start":"2026-08-17T10:33:48.81756Z","end":"2026-08-17T10:33:49.046494Z","steps":["trace[890139029] 'process raft request' (duration: 96.592309ms)","trace[890139029] 'compare' (duration: 131.985783ms)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:33:49.065945Z","caller":"traceutil/trace.go:171","msg":"trace[2105014533] transaction","detail":"{read_only:false; response_revision:8802; number_of_response:1; }","duration":"243.206074ms","start":"2026-08-17T10:33:48.822712Z","end":"2026-08-17T10:33:49.065919Z","steps":["trace[2105014533] 'process raft request' (duration: 243.049501ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:35:10.010636Z","caller":"traceutil/trace.go:171","msg":"trace[1853054308] transaction","detail":"{read_only:false; response_revision:9575; number_of_response:1; }","duration":"215.270041ms","start":"2026-08-17T10:35:09.794837Z","end":"2026-08-17T10:35:10.010107Z","steps":["trace[1853054308] 'process raft request' (duration: 215.074326ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:35:10.21193Z","caller":"traceutil/trace.go:171","msg":"trace[1198519912] transaction","detail":"{read_only:false; response_revision:9577; number_of_response:1; }","duration":"117.762569ms","start":"2026-08-17T10:35:10.094106Z","end":"2026-08-17T10:35:10.211868Z","steps":["trace[1198519912] 'process raft request' (duration: 117.056142ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:35:20.648887Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c51d7a9ea5537d6e","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-17T10:35:20.655307Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-08-17T10:35:20.655435Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-08-17T10:37:37.211897Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8184} {"level":"info","ts":"2026-08-17T10:37:37.279633Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8184,"took":"64.782759ms","hash":316764673,"current-db-size-bytes":58834944,"current-db-size":"59 MB","current-db-size-in-use-bytes":28323840,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-08-17T10:37:37.279724Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":316764673,"revision":8184,"compact-revision":6103} {"level":"info","ts":"2026-08-17T10:40:48.014381Z","caller":"traceutil/trace.go:171","msg":"trace[1659750273] transaction","detail":"{read_only:false; response_revision:12005; number_of_response:1; }","duration":"138.547136ms","start":"2026-08-17T10:40:47.875806Z","end":"2026-08-17T10:40:48.014353Z","steps":["trace[1659750273] 'process raft request' (duration: 138.452034ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:40:48.014382Z","caller":"traceutil/trace.go:171","msg":"trace[447196139] transaction","detail":"{read_only:false; response_revision:12004; number_of_response:1; }","duration":"141.072508ms","start":"2026-08-17T10:40:47.873271Z","end":"2026-08-17T10:40:48.014344Z","steps":["trace[447196139] 'process raft request' (duration: 140.816052ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:40:48.23424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.19392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-17T10:40:48.234348Z","caller":"traceutil/trace.go:171","msg":"trace[1773191764] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:12006; }","duration":"108.344184ms","start":"2026-08-17T10:40:48.125985Z","end":"2026-08-17T10:40:48.234329Z","steps":["trace[1773191764] 'range keys from in-memory index tree' (duration: 108.044337ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:42:37.219042Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10556} {"level":"info","ts":"2026-08-17T10:42:37.302528Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10556,"took":"80.399808ms","hash":305759899,"current-db-size-bytes":58834944,"current-db-size":"59 MB","current-db-size-in-use-bytes":25927680,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-08-17T10:42:37.302772Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":305759899,"revision":10556,"compact-revision":8184} {"level":"info","ts":"2026-08-17T10:47:04.1946Z","caller":"traceutil/trace.go:171","msg":"trace[578273916] linearizableReadLoop","detail":"{readStateIndex:15027; appliedIndex:15026; }","duration":"128.882691ms","start":"2026-08-17T10:47:04.065674Z","end":"2026-08-17T10:47:04.194557Z","steps":["trace[578273916] 'read index received' (duration: 128.654875ms)","trace[578273916] 'applied index is now lower than readState.Index' (duration: 226.266µs)"],"step_count":2} {"level":"warn","ts":"2026-08-17T10:47:04.1949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.182198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-17T10:47:04.194969Z","caller":"traceutil/trace.go:171","msg":"trace[2135770197] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14528; }","duration":"129.310031ms","start":"2026-08-17T10:47:04.065637Z","end":"2026-08-17T10:47:04.194947Z","steps":["trace[2135770197] 'agreement among raft nodes before linearized reading' (duration: 129.065565ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:47:04.19503Z","caller":"traceutil/trace.go:171","msg":"trace[608288948] transaction","detail":"{read_only:false; response_revision:14528; number_of_response:1; }","duration":"138.471246ms","start":"2026-08-17T10:47:04.056514Z","end":"2026-08-17T10:47:04.194985Z","steps":["trace[608288948] 'process raft request' (duration: 137.831081ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:47:24.707327Z","caller":"traceutil/trace.go:171","msg":"trace[319693856] transaction","detail":"{read_only:false; response_revision:14640; number_of_response:1; }","duration":"114.153281ms","start":"2026-08-17T10:47:24.593155Z","end":"2026-08-17T10:47:24.707308Z","steps":["trace[319693856] 'process raft request' (duration: 114.018028ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:47:24.708259Z","caller":"traceutil/trace.go:171","msg":"trace[1525588412] transaction","detail":"{read_only:false; response_revision:14641; number_of_response:1; }","duration":"115.063623ms","start":"2026-08-17T10:47:24.59318Z","end":"2026-08-17T10:47:24.708244Z","steps":["trace[1525588412] 'process raft request' (duration: 114.781367ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:47:37.224963Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12722} {"level":"info","ts":"2026-08-17T10:47:37.301833Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12722,"took":"74.068761ms","hash":2592463321,"current-db-size-bytes":58834944,"current-db-size":"59 MB","current-db-size-in-use-bytes":27664384,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-08-17T10:47:37.301899Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2592463321,"revision":12722,"compact-revision":10556} {"level":"info","ts":"2026-08-17T10:47:42.031819Z","caller":"traceutil/trace.go:171","msg":"trace[1176015110] transaction","detail":"{read_only:false; response_revision:14749; number_of_response:1; }","duration":"156.204977ms","start":"2026-08-17T10:47:41.875587Z","end":"2026-08-17T10:47:42.031792Z","steps":["trace[1176015110] 'process raft request' (duration: 154.66958ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:48:05.159652Z","caller":"traceutil/trace.go:171","msg":"trace[2092405758] linearizableReadLoop","detail":"{readStateIndex:15582; appliedIndex:15581; }","duration":"229.947181ms","start":"2026-08-17T10:48:04.929678Z","end":"2026-08-17T10:48:05.159625Z","steps":["trace[2092405758] 'read index received' (duration: 229.767586ms)","trace[2092405758] 'applied index is now lower than readState.Index' (duration: 178.575µs)"],"step_count":2} {"level":"warn","ts":"2026-08-17T10:48:05.159941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.02513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-08-17T10:48:05.159987Z","caller":"traceutil/trace.go:171","msg":"trace[2064393552] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:15059; }","duration":"227.120382ms","start":"2026-08-17T10:48:04.932853Z","end":"2026-08-17T10:48:05.159973Z","steps":["trace[2064393552] 'agreement among raft nodes before linearized reading' (duration: 226.929297ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:48:05.159976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.283049ms","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-17T10:48:05.160078Z","caller":"traceutil/trace.go:171","msg":"trace[1297893469] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:15059; }","duration":"230.398362ms","start":"2026-08-17T10:48:04.929654Z","end":"2026-08-17T10:48:05.160052Z","steps":["trace[1297893469] 'agreement among raft nodes before linearized reading' (duration: 230.103265ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:48:05.160073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.810965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-08-17T10:48:05.159945Z","caller":"traceutil/trace.go:171","msg":"trace[498755158] transaction","detail":"{read_only:false; response_revision:15059; number_of_response:1; }","duration":"304.335519ms","start":"2026-08-17T10:48:04.855367Z","end":"2026-08-17T10:48:05.159702Z","steps":["trace[498755158] 'process raft request' (duration: 304.047012ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:48:05.160175Z","caller":"traceutil/trace.go:171","msg":"trace[413290033] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15059; }","duration":"224.969789ms","start":"2026-08-17T10:48:04.935179Z","end":"2026-08-17T10:48:05.160149Z","steps":["trace[413290033] 'agreement among raft nodes before linearized reading' (duration: 224.649381ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:48:05.160361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:48:04.855332Z","time spent":"304.875903ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3742,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-17T10:49:32.245586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.168502ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-17T10:49:32.245856Z","caller":"traceutil/trace.go:171","msg":"trace[1961359366] linearizableReadLoop","detail":"{readStateIndex:16425; appliedIndex:16423; }","duration":"105.058739ms","start":"2026-08-17T10:49:32.140772Z","end":"2026-08-17T10:49:32.245831Z","steps":["trace[1961359366] 'read index received' (duration: 84.312µs)","trace[1961359366] 'applied index is now lower than readState.Index' (duration: 104.973117ms)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:49:32.245976Z","caller":"traceutil/trace.go:171","msg":"trace[1999447747] transaction","detail":"{read_only:false; response_revision:15878; number_of_response:1; }","duration":"289.649845ms","start":"2026-08-17T10:49:31.956285Z","end":"2026-08-17T10:49:32.245935Z","steps":["trace[1999447747] 'process raft request' (duration: 152.991101ms)","trace[1999447747] 'compare' (duration: 135.976037ms)"],"step_count":2} {"level":"warn","ts":"2026-08-17T10:49:32.246097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.304465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:666"} {"level":"info","ts":"2026-08-17T10:49:32.246176Z","caller":"traceutil/trace.go:171","msg":"trace[2086706935] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15879; }","duration":"105.456909ms","start":"2026-08-17T10:49:32.140702Z","end":"2026-08-17T10:49:32.246159Z","steps":["trace[2086706935] 'agreement among raft nodes before linearized reading' (duration: 105.242734ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:49:32.246462Z","caller":"traceutil/trace.go:171","msg":"trace[1975575281] transaction","detail":"{read_only:false; response_revision:15879; number_of_response:1; }","duration":"290.118585ms","start":"2026-08-17T10:49:31.956305Z","end":"2026-08-17T10:49:32.246423Z","steps":["trace[1975575281] 'process raft request' (duration: 289.439979ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:49:33.256973Z","caller":"traceutil/trace.go:171","msg":"trace[1051423461] transaction","detail":"{read_only:false; response_revision:15883; number_of_response:1; }","duration":"244.582533ms","start":"2026-08-17T10:49:33.012336Z","end":"2026-08-17T10:49:33.256919Z","steps":["trace[1051423461] 'process raft request' (duration: 163.558941ms)","trace[1051423461] 'compare' (duration: 80.393646ms)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:52:37.231825Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14707} {"level":"info","ts":"2026-08-17T10:52:37.309273Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14707,"took":"73.347124ms","hash":2421499656,"current-db-size-bytes":58834944,"current-db-size":"59 MB","current-db-size-in-use-bytes":31522816,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-08-17T10:52:37.309343Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2421499656,"revision":14707,"compact-revision":12722} {"level":"info","ts":"2026-08-17T10:55:55.298641Z","caller":"traceutil/trace.go:171","msg":"trace[1795636224] transaction","detail":"{read_only:false; response_revision:18639; number_of_response:1; }","duration":"164.475698ms","start":"2026-08-17T10:55:55.134136Z","end":"2026-08-17T10:55:55.298612Z","steps":["trace[1795636224] 'process raft request' (duration: 163.71805ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:56:02.533361Z","caller":"traceutil/trace.go:171","msg":"trace[1986486253] linearizableReadLoop","detail":"{readStateIndex:19326; appliedIndex:19325; }","duration":"239.324528ms","start":"2026-08-17T10:56:02.294003Z","end":"2026-08-17T10:56:02.533327Z","steps":["trace[1986486253] 'read index received' (duration: 239.232315ms)","trace[1986486253] 'applied index is now lower than readState.Index' (duration: 91.153µs)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:56:02.533464Z","caller":"traceutil/trace.go:171","msg":"trace[162840944] transaction","detail":"{read_only:false; response_revision:18684; number_of_response:1; }","duration":"250.340857ms","start":"2026-08-17T10:56:02.283078Z","end":"2026-08-17T10:56:02.533419Z","steps":["trace[162840944] 'process raft request' (duration: 250.079831ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:56:02.533596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.571553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-h8bmg\" ","response":"range_response_count:1 size:22101"} {"level":"info","ts":"2026-08-17T10:56:02.533849Z","caller":"traceutil/trace.go:171","msg":"trace[1032268549] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-h8bmg; range_end:; response_count:1; response_revision:18684; }","duration":"239.82788ms","start":"2026-08-17T10:56:02.293955Z","end":"2026-08-17T10:56:02.533783Z","steps":["trace[1032268549] 'agreement among raft nodes before linearized reading' (duration: 239.500212ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:56:03.56405Z","caller":"traceutil/trace.go:171","msg":"trace[2091498496] linearizableReadLoop","detail":"{readStateIndex:19327; appliedIndex:19326; }","duration":"211.19384ms","start":"2026-08-17T10:56:03.352833Z","end":"2026-08-17T10:56:03.564027Z","steps":["trace[2091498496] 'read index received' (duration: 210.978775ms)","trace[2091498496] 'applied index is now lower than readState.Index' (duration: 214.285µs)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:56:03.564138Z","caller":"traceutil/trace.go:171","msg":"trace[1475305916] transaction","detail":"{read_only:false; response_revision:18685; number_of_response:1; }","duration":"228.496264ms","start":"2026-08-17T10:56:03.335615Z","end":"2026-08-17T10:56:03.564111Z","steps":["trace[1475305916] 'process raft request' (duration: 228.259268ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:56:03.564258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.403575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-17T10:56:03.564299Z","caller":"traceutil/trace.go:171","msg":"trace[1287060695] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:18685; }","duration":"211.473937ms","start":"2026-08-17T10:56:03.352816Z","end":"2026-08-17T10:56:03.56429Z","steps":["trace[1287060695] 'agreement among raft nodes before linearized reading' (duration: 211.322334ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:56:03.580857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.330789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-cczdc\" ","response":"range_response_count:1 size:9792"} {"level":"info","ts":"2026-08-17T10:56:03.580916Z","caller":"traceutil/trace.go:171","msg":"trace[771205484] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-cczdc; range_end:; response_count:1; response_revision:18686; }","duration":"176.439691ms","start":"2026-08-17T10:56:03.404463Z","end":"2026-08-17T10:56:03.580903Z","steps":["trace[771205484] 'agreement among raft nodes before linearized reading' (duration: 176.228716ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:56:11.509328Z","caller":"traceutil/trace.go:171","msg":"trace[2018293030] linearizableReadLoop","detail":"{readStateIndex:19482; appliedIndex:19481; }","duration":"124.03365ms","start":"2026-08-17T10:56:11.385273Z","end":"2026-08-17T10:56:11.509306Z","steps":["trace[2018293030] 'read index received' (duration: 15.57044ms)","trace[2018293030] 'applied index is now lower than readState.Index' (duration: 108.46196ms)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:56:11.509395Z","caller":"traceutil/trace.go:171","msg":"trace[2144949795] transaction","detail":"{read_only:false; response_revision:18837; number_of_response:1; }","duration":"122.197105ms","start":"2026-08-17T10:56:11.387175Z","end":"2026-08-17T10:56:11.509372Z","steps":["trace[2144949795] 'process raft request' (duration: 121.947619ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:56:11.509519Z","caller":"traceutil/trace.go:171","msg":"trace[78440285] transaction","detail":"{read_only:false; response_revision:18838; number_of_response:1; }","duration":"122.021041ms","start":"2026-08-17T10:56:11.387489Z","end":"2026-08-17T10:56:11.50951Z","steps":["trace[78440285] 'process raft request' (duration: 121.654763ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:56:11.509574Z","caller":"traceutil/trace.go:171","msg":"trace[784399347] transaction","detail":"{read_only:false; response_revision:18840; number_of_response:1; }","duration":"119.430908ms","start":"2026-08-17T10:56:11.39013Z","end":"2026-08-17T10:56:11.509561Z","steps":["trace[784399347] 'process raft request' (duration: 119.11136ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:56:11.509728Z","caller":"traceutil/trace.go:171","msg":"trace[1374683792] transaction","detail":"{read_only:false; response_revision:18839; number_of_response:1; }","duration":"121.954799ms","start":"2026-08-17T10:56:11.387767Z","end":"2026-08-17T10:56:11.509721Z","steps":["trace[1374683792] 'process raft request' (duration: 121.400906ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:56:11.509869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.575584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:651"} {"level":"info","ts":"2026-08-17T10:56:11.509908Z","caller":"traceutil/trace.go:171","msg":"trace[1999159259] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:18840; }","duration":"124.637886ms","start":"2026-08-17T10:56:11.385259Z","end":"2026-08-17T10:56:11.509897Z","steps":["trace[1999159259] 'agreement among raft nodes before linearized reading' (duration: 124.472882ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:56:11.510129Z","caller":"traceutil/trace.go:171","msg":"trace[715075131] transaction","detail":"{read_only:false; response_revision:18835; number_of_response:1; }","duration":"123.048477ms","start":"2026-08-17T10:56:11.38707Z","end":"2026-08-17T10:56:11.510119Z","steps":["trace[715075131] 'process raft request' (duration: 121.995132ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:56:11.510227Z","caller":"traceutil/trace.go:171","msg":"trace[1637667355] transaction","detail":"{read_only:false; response_revision:18834; number_of_response:1; }","duration":"125.672911ms","start":"2026-08-17T10:56:11.384548Z","end":"2026-08-17T10:56:11.510221Z","steps":["trace[1637667355] 'process raft request' (duration: 124.380899ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:56:11.510466Z","caller":"traceutil/trace.go:171","msg":"trace[1983404709] transaction","detail":"{read_only:false; response_revision:18836; number_of_response:1; }","duration":"123.311473ms","start":"2026-08-17T10:56:11.387147Z","end":"2026-08-17T10:56:11.510459Z","steps":["trace[1983404709] 'process raft request' (duration: 121.942779ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:56:11.64924Z","caller":"traceutil/trace.go:171","msg":"trace[1837619677] transaction","detail":"{read_only:false; response_revision:18843; number_of_response:1; }","duration":"127.615337ms","start":"2026-08-17T10:56:11.521582Z","end":"2026-08-17T10:56:11.649197Z","steps":["trace[1837619677] 'process raft request' (duration: 96.515198ms)","trace[1837619677] 'compare' (duration: 30.881674ms)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:56:11.649554Z","caller":"traceutil/trace.go:171","msg":"trace[84962037] linearizableReadLoop","detail":"{readStateIndex:19491; appliedIndex:19490; }","duration":"117.565323ms","start":"2026-08-17T10:56:11.531975Z","end":"2026-08-17T10:56:11.64954Z","steps":["trace[84962037] 'read index received' (duration: 86.058683ms)","trace[84962037] 'applied index is now lower than readState.Index' (duration: 31.50543ms)"],"step_count":2} {"level":"warn","ts":"2026-08-17T10:56:11.649756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.765897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:709"} {"level":"info","ts":"2026-08-17T10:56:11.649795Z","caller":"traceutil/trace.go:171","msg":"trace[1728010285] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:18844; }","duration":"117.85447ms","start":"2026-08-17T10:56:11.531928Z","end":"2026-08-17T10:56:11.649782Z","steps":["trace[1728010285] 'agreement among raft nodes before linearized reading' (duration: 117.693026ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:56:11.64979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.329223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1822"} {"level":"info","ts":"2026-08-17T10:56:11.649847Z","caller":"traceutil/trace.go:171","msg":"trace[756027442] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:18844; }","duration":"105.416826ms","start":"2026-08-17T10:56:11.544414Z","end":"2026-08-17T10:56:11.649831Z","steps":["trace[756027442] 'agreement among raft nodes before linearized reading' (duration: 105.236381ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:57:00.08246Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c51d7a9ea5537d6e","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-17T10:57:00.088001Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-08-17T10:57:00.088161Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-08-17T10:57:10.25936Z","caller":"traceutil/trace.go:171","msg":"trace[76750532] transaction","detail":"{read_only:false; response_revision:19444; number_of_response:1; }","duration":"101.687646ms","start":"2026-08-17T10:57:10.156814Z","end":"2026-08-17T10:57:10.258502Z","steps":["trace[76750532] 'process raft request' (duration: 95.466463ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:57:37.23816Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17173} {"level":"info","ts":"2026-08-17T10:57:37.34033Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17173,"took":"97.789049ms","hash":1868044115,"current-db-size-bytes":58834944,"current-db-size":"59 MB","current-db-size-in-use-bytes":32960512,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-08-17T10:57:37.340413Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1868044115,"revision":17173,"compact-revision":14707} {"level":"info","ts":"2026-08-17T11:02:21.228606Z","caller":"traceutil/trace.go:171","msg":"trace[572754822] linearizableReadLoop","detail":"{readStateIndex:22337; appliedIndex:22336; }","duration":"102.30291ms","start":"2026-08-17T11:02:21.126269Z","end":"2026-08-17T11:02:21.228572Z","steps":["trace[572754822] 'read index received' (duration: 102.200808ms)","trace[572754822] 'applied index is now lower than readState.Index' (duration: 100.592µs)"],"step_count":2} {"level":"warn","ts":"2026-08-17T11:02:21.22881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.509085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-17T11:02:21.228853Z","caller":"traceutil/trace.go:171","msg":"trace[1517055656] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:21600; }","duration":"102.627158ms","start":"2026-08-17T11:02:21.126215Z","end":"2026-08-17T11:02:21.228842Z","steps":["trace[1517055656] 'agreement among raft nodes before linearized reading' (duration: 102.491985ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T11:02:21.229122Z","caller":"traceutil/trace.go:171","msg":"trace[94002676] transaction","detail":"{read_only:false; response_revision:21600; number_of_response:1; }","duration":"119.664785ms","start":"2026-08-17T11:02:21.109264Z","end":"2026-08-17T11:02:21.228928Z","steps":["trace[94002676] 'process raft request' (duration: 119.026289ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T11:02:21.403494Z","caller":"traceutil/trace.go:171","msg":"trace[995111822] transaction","detail":"{read_only:false; response_revision:21601; number_of_response:1; }","duration":"240.62992ms","start":"2026-08-17T11:02:21.162822Z","end":"2026-08-17T11:02:21.403452Z","steps":["trace[995111822] 'process raft request' (duration: 210.042203ms)","trace[995111822] 'compare' (duration: 30.237159ms)"],"step_count":2} {"level":"info","ts":"2026-08-17T11:02:21.403573Z","caller":"traceutil/trace.go:171","msg":"trace[212706465] transaction","detail":"{read_only:false; response_revision:21602; number_of_response:1; }","duration":"110.360246ms","start":"2026-08-17T11:02:21.293179Z","end":"2026-08-17T11:02:21.403539Z","steps":["trace[212706465] 'process raft request' (duration: 110.237463ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T11:02:21.403571Z","caller":"traceutil/trace.go:171","msg":"trace[1507231675] linearizableReadLoop","detail":"{readStateIndex:22338; appliedIndex:22337; }","duration":"170.622979ms","start":"2026-08-17T11:02:21.232909Z","end":"2026-08-17T11:02:21.403532Z","steps":["trace[1507231675] 'read index received' (duration: 140.085533ms)","trace[1507231675] 'applied index is now lower than readState.Index' (duration: 30.532356ms)"],"step_count":2} {"level":"warn","ts":"2026-08-17T11:02:21.403951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.02846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-17T11:02:21.403994Z","caller":"traceutil/trace.go:171","msg":"trace[1223076326] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:21602; }","duration":"171.128792ms","start":"2026-08-17T11:02:21.232855Z","end":"2026-08-17T11:02:21.403984Z","steps":["trace[1223076326] 'agreement among raft nodes before linearized reading' (duration: 171.0347ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T11:02:21.897821Z","caller":"traceutil/trace.go:171","msg":"trace[334859586] transaction","detail":"{read_only:false; response_revision:21603; number_of_response:1; }","duration":"154.917087ms","start":"2026-08-17T11:02:21.742862Z","end":"2026-08-17T11:02:21.897779Z","steps":["trace[334859586] 'process raft request' (duration: 154.685331ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T11:02:22.097917Z","caller":"traceutil/trace.go:171","msg":"trace[1740492127] transaction","detail":"{read_only:false; response_revision:21604; number_of_response:1; }","duration":"353.98626ms","start":"2026-08-17T11:02:21.743893Z","end":"2026-08-17T11:02:22.09788Z","steps":["trace[1740492127] 'process raft request' (duration: 317.5621ms)","trace[1740492127] 'compare' (duration: 35.637461ms)"],"step_count":2} {"level":"warn","ts":"2026-08-17T11:02:22.098118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T11:02:21.743861Z","time spent":"354.166045ms","remote":"127.0.0.1:38696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-17T11:02:22.09814Z","caller":"traceutil/trace.go:171","msg":"trace[869315509] linearizableReadLoop","detail":"{readStateIndex:22341; appliedIndex:22339; }","duration":"256.353604ms","start":"2026-08-17T11:02:21.841683Z","end":"2026-08-17T11:02:22.098036Z","steps":["trace[869315509] 'read index received' (duration: 55.870195ms)","trace[869315509] 'applied index is now lower than readState.Index' (duration: 200.480969ms)"],"step_count":2} {"level":"info","ts":"2026-08-17T11:02:22.098254Z","caller":"traceutil/trace.go:171","msg":"trace[2142342326] transaction","detail":"{read_only:false; response_revision:21605; number_of_response:1; }","duration":"240.701163ms","start":"2026-08-17T11:02:21.857523Z","end":"2026-08-17T11:02:22.098224Z","steps":["trace[2142342326] 'process raft request' (duration: 240.289793ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T11:02:22.098431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.731503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-08-17T11:02:22.09847Z","caller":"traceutil/trace.go:171","msg":"trace[1791082840] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:21605; }","duration":"256.835976ms","start":"2026-08-17T11:02:21.841625Z","end":"2026-08-17T11:02:22.098461Z","steps":["trace[1791082840] 'agreement among raft nodes before linearized reading' (duration: 256.678853ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T11:02:22.13672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.718035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-08-17T11:02:22.136837Z","caller":"traceutil/trace.go:171","msg":"trace[1633847757] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:21606; }","duration":"290.883038ms","start":"2026-08-17T11:02:21.845909Z","end":"2026-08-17T11:02:22.136792Z","steps":["trace[1633847757] 'agreement among raft nodes before linearized reading' (duration: 290.583331ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T11:02:22.137079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.503313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-08-17T11:02:22.137225Z","caller":"traceutil/trace.go:171","msg":"trace[856956403] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:21606; }","duration":"291.647577ms","start":"2026-08-17T11:02:21.845519Z","end":"2026-08-17T11:02:22.137167Z","steps":["trace[856956403] 'agreement among raft nodes before linearized reading' (duration: 290.888999ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T11:02:22.282564Z","caller":"traceutil/trace.go:171","msg":"trace[843521070] transaction","detail":"{read_only:false; response_revision:21607; number_of_response:1; }","duration":"179.775903ms","start":"2026-08-17T11:02:22.102758Z","end":"2026-08-17T11:02:22.282533Z","steps":["trace[843521070] 'process raft request' (duration: 179.572258ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T11:02:22.294664Z","caller":"traceutil/trace.go:171","msg":"trace[1291716387] transaction","detail":"{read_only:false; response_revision:21608; number_of_response:1; }","duration":"152.756362ms","start":"2026-08-17T11:02:22.141867Z","end":"2026-08-17T11:02:22.294624Z","steps":["trace[1291716387] 'process raft request' (duration: 152.480105ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T11:02:22.294671Z","caller":"traceutil/trace.go:171","msg":"trace[574590228] transaction","detail":"{read_only:false; response_revision:21609; number_of_response:1; }","duration":"152.64769ms","start":"2026-08-17T11:02:22.14194Z","end":"2026-08-17T11:02:22.294588Z","steps":["trace[574590228] 'process raft request' (duration: 152.598369ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T11:02:23.091768Z","caller":"traceutil/trace.go:171","msg":"trace[1303556291] transaction","detail":"{read_only:false; response_revision:21610; number_of_response:1; }","duration":"203.283228ms","start":"2026-08-17T11:02:22.888449Z","end":"2026-08-17T11:02:23.091732Z","steps":["trace[1303556291] 'process raft request' (duration: 203.030302ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T11:02:23.371079Z","caller":"traceutil/trace.go:171","msg":"trace[1584215795] transaction","detail":"{read_only:false; response_revision:21611; number_of_response:1; }","duration":"136.439335ms","start":"2026-08-17T11:02:23.234602Z","end":"2026-08-17T11:02:23.371041Z","steps":["trace[1584215795] 'process raft request' (duration: 90.663165ms)","trace[1584215795] 'compare' (duration: 45.522613ms)"],"step_count":2} {"level":"info","ts":"2026-08-17T11:02:37.244498Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19628} {"level":"info","ts":"2026-08-17T11:02:37.362444Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19628,"took":"113.943032ms","hash":1111265596,"current-db-size-bytes":58834944,"current-db-size":"59 MB","current-db-size-in-use-bytes":29044736,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-17T11:02:37.36254Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1111265596,"revision":19628,"compact-revision":17173} {"level":"info","ts":"2026-08-17T11:05:31.026866Z","caller":"traceutil/trace.go:171","msg":"trace[387456485] linearizableReadLoop","detail":"{readStateIndex:23908; appliedIndex:23907; }","duration":"137.553528ms","start":"2026-08-17T11:05:30.889288Z","end":"2026-08-17T11:05:31.026841Z","steps":["trace[387456485] 'read index received' (duration: 124.284283ms)","trace[387456485] 'applied index is now lower than readState.Index' (duration: 13.267784ms)"],"step_count":2} {"level":"warn","ts":"2026-08-17T11:05:31.02706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.769003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-17T11:05:31.027086Z","caller":"traceutil/trace.go:171","msg":"trace[153341926] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:23120; }","duration":"137.861675ms","start":"2026-08-17T11:05:30.889217Z","end":"2026-08-17T11:05:31.027078Z","steps":["trace[153341926] 'agreement among raft nodes before linearized reading' (duration: 137.723172ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T11:05:31.027307Z","caller":"traceutil/trace.go:171","msg":"trace[1203297577] transaction","detail":"{read_only:false; response_revision:23120; number_of_response:1; }","duration":"164.044453ms","start":"2026-08-17T11:05:30.863252Z","end":"2026-08-17T11:05:31.027297Z","steps":["trace[1203297577] 'process raft request' (duration: 150.252707ms)","trace[1203297577] 'compare' (duration: 12.968816ms)"],"step_count":2} {"level":"warn","ts":"2026-08-17T11:06:37.604824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.820977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-17T11:06:37.604925Z","caller":"traceutil/trace.go:171","msg":"trace[1126838758] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:24218; }","duration":"133.936569ms","start":"2026-08-17T11:06:37.470965Z","end":"2026-08-17T11:06:37.604901Z","steps":["trace[1126838758] 'count revisions from in-memory index tree' (duration: 133.702533ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T11:06:37.605036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.063082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-17T11:06:37.605165Z","caller":"traceutil/trace.go:171","msg":"trace[1465910151] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24218; }","duration":"218.253706ms","start":"2026-08-17T11:06:37.386878Z","end":"2026-08-17T11:06:37.605131Z","steps":["trace[1465910151] 'range keys from in-memory index tree' (duration: 217.725433ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T11:07:37.258067Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21683} {"level":"info","ts":"2026-08-17T11:07:37.373431Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21683,"took":"109.597325ms","hash":1720152901,"current-db-size-bytes":58834944,"current-db-size":"59 MB","current-db-size-in-use-bytes":42811392,"current-db-size-in-use":"43 MB"} {"level":"info","ts":"2026-08-17T11:07:37.373511Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1720152901,"revision":21683,"compact-revision":19628} {"level":"info","ts":"2026-08-17T11:09:48.781259Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000068a9.wal"} {"level":"info","ts":"2026-08-17T11:12:37.26502Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24808} {"level":"info","ts":"2026-08-17T11:12:37.411263Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24808,"took":"142.894002ms","hash":1278506909,"current-db-size-bytes":58834944,"current-db-size":"59 MB","current-db-size-in-use-bytes":32305152,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-08-17T11:12:37.411357Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1278506909,"revision":24808,"compact-revision":21683} {"level":"info","ts":"2026-08-17T11:16:46.356455Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c51d7a9ea5537d6e","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-17T11:16:46.362726Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-08-17T11:16:46.362846Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}