{"level":"warn","ts":"2026-04-07T01:26:34.751714Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-07T01:26:34.751812Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.227: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.204.45.227:2380","--initial-cluster=instance=https://199.204.45.227:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.227:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.227: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-04-07T01:26:34.751893Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-07T01:26:34.751908Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-04-07T01:26:34.751931Z","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-04-07T01:26:34.752629Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"]} {"level":"info","ts":"2026-04-07T01:26:34.752714Z","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.204.45.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.227: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-04-07T01:26:34.756647Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.6598ms"} {"level":"info","ts":"2026-04-07T01:26:34.768673Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"572db18442eba1c2","cluster-id":"fb1028a037bf3cd6"} {"level":"info","ts":"2026-04-07T01:26:34.768788Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T01:26:34.768817Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 0"} {"level":"info","ts":"2026-04-07T01:26:34.768833Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 572db18442eba1c2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T01:26:34.768847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 1"} {"level":"info","ts":"2026-04-07T01:26:34.768889Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"warn","ts":"2026-04-07T01:26:34.778477Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T01:26:34.780838Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T01:26:34.782468Z","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-04-07T01:26:34.785358Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"572db18442eba1c2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T01:26:34.785462Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"572db18442eba1c2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T01:26:34.785564Z","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-04-07T01:26:34.785654Z","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-04-07T01:26:34.785685Z","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-04-07T01:26:34.786585Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"info","ts":"2026-04-07T01:26:34.786849Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","added-peer-id":"572db18442eba1c2","added-peer-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-04-07T01:26:34.788735Z","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-04-07T01:26:34.789019Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"572db18442eba1c2","initial-advertise-peer-urls":["https://199.204.45.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T01:26:34.788971Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-04-07T01:26:34.789059Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T01:26:34.789071Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-04-07T01:26:35.669347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T01:26:35.669397Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T01:26:35.669426Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgPreVoteResp from 572db18442eba1c2 at term 1"} {"level":"info","ts":"2026-04-07T01:26:35.66944Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became candidate at term 2"} {"level":"info","ts":"2026-04-07T01:26:35.669448Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgVoteResp from 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-04-07T01:26:35.669459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became leader at term 2"} {"level":"info","ts":"2026-04-07T01:26:35.669469Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 572db18442eba1c2 elected leader 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-04-07T01:26:35.670326Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:26:35.671119Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T01:26:35.671118Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"572db18442eba1c2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.227:2379]}","request-path":"/0/members/572db18442eba1c2/attributes","cluster-id":"fb1028a037bf3cd6","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T01:26:35.671178Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T01:26:35.671511Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T01:26:35.671533Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T01:26:35.671958Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:26:35.672139Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:26:35.672202Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:26:35.674492Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.227:2379"} {"level":"info","ts":"2026-04-07T01:26:35.676207Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-07T01:26:39.956389Z","caller":"traceutil/trace.go:171","msg":"trace[1236062463] linearizableReadLoop","detail":"{readStateIndex:212; appliedIndex:211; }","duration":"159.295746ms","start":"2026-04-07T01:26:39.797064Z","end":"2026-04-07T01:26:39.95636Z","steps":["trace[1236062463] 'read index received' (duration: 134.872551ms)","trace[1236062463] 'applied index is now lower than readState.Index' (duration: 24.422035ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:26:39.9566Z","caller":"traceutil/trace.go:171","msg":"trace[1074235884] transaction","detail":"{read_only:false; response_revision:207; number_of_response:1; }","duration":"391.658361ms","start":"2026-04-07T01:26:39.564888Z","end":"2026-04-07T01:26:39.956546Z","steps":["trace[1074235884] 'process raft request' (duration: 367.123054ms)","trace[1074235884] 'compare' (duration: 24.20354ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:26:39.956657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.564072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:39.956751Z","caller":"traceutil/trace.go:171","msg":"trace[1832151808] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:207; }","duration":"159.718095ms","start":"2026-04-07T01:26:39.797017Z","end":"2026-04-07T01:26:39.956735Z","steps":["trace[1832151808] 'agreement among raft nodes before linearized reading' (duration: 159.526661ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:39.957395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:39.564871Z","time spent":"391.847605ms","remote":"127.0.0.1:33242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":525,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T01:26:45.016565Z","caller":"traceutil/trace.go:171","msg":"trace[1853542059] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"100.583191ms","start":"2026-04-07T01:26:44.915956Z","end":"2026-04-07T01:26:45.016539Z","steps":["trace[1853542059] 'process raft request' (duration: 100.427277ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:51.156577Z","caller":"traceutil/trace.go:171","msg":"trace[1369940747] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"151.470965ms","start":"2026-04-07T01:26:51.005084Z","end":"2026-04-07T01:26:51.156555Z","steps":["trace[1369940747] 'process raft request' (duration: 151.341522ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:05.984623Z","caller":"traceutil/trace.go:171","msg":"trace[1876400834] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"210.214207ms","start":"2026-04-07T01:27:05.774379Z","end":"2026-04-07T01:27:05.984593Z","steps":["trace[1876400834] 'process raft request' (duration: 210.026582ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:06.245485Z","caller":"traceutil/trace.go:171","msg":"trace[484032594] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"464.403422ms","start":"2026-04-07T01:27:05.781044Z","end":"2026-04-07T01:27:06.245448Z","steps":["trace[484032594] 'process raft request' (duration: 464.103696ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:06.245516Z","caller":"traceutil/trace.go:171","msg":"trace[118268439] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"464.373822ms","start":"2026-04-07T01:27:05.781107Z","end":"2026-04-07T01:27:06.24548Z","steps":["trace[118268439] 'process raft request' (duration: 464.232429ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:06.245621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:27:05.781019Z","time spent":"464.541026ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T01:27:06.245708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:27:05.781102Z","time spent":"464.504555ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T01:27:06.245745Z","caller":"traceutil/trace.go:171","msg":"trace[2145729485] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"455.639528ms","start":"2026-04-07T01:27:05.790098Z","end":"2026-04-07T01:27:06.245737Z","steps":["trace[2145729485] 'process raft request' (duration: 455.422303ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:06.24571Z","caller":"traceutil/trace.go:171","msg":"trace[1311221334] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"457.169781ms","start":"2026-04-07T01:27:05.78849Z","end":"2026-04-07T01:27:06.24566Z","steps":["trace[1311221334] 'process raft request' (duration: 456.939866ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:06.245782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:27:05.790076Z","time spent":"455.687109ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T01:27:06.24581Z","caller":"traceutil/trace.go:171","msg":"trace[1629546236] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"457.557919ms","start":"2026-04-07T01:27:05.78821Z","end":"2026-04-07T01:27:06.245768Z","steps":["trace[1629546236] 'process raft request' (duration: 457.178291ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:06.245834Z","caller":"traceutil/trace.go:171","msg":"trace[2011379524] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"452.945678ms","start":"2026-04-07T01:27:05.792845Z","end":"2026-04-07T01:27:06.245791Z","steps":["trace[2011379524] 'process raft request' (duration: 452.713803ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:06.245872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:27:05.788481Z","time spent":"457.305684ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T01:27:06.245884Z","caller":"traceutil/trace.go:171","msg":"trace[1178130200] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"455.766461ms","start":"2026-04-07T01:27:05.790066Z","end":"2026-04-07T01:27:06.245833Z","steps":["trace[1178130200] 'process raft request' (duration: 455.400283ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:06.245953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:27:05.788188Z","time spent":"457.687873ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T01:27:06.245951Z","caller":"traceutil/trace.go:171","msg":"trace[1263999475] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"444.065629ms","start":"2026-04-07T01:27:05.801808Z","end":"2026-04-07T01:27:06.245873Z","steps":["trace[1263999475] 'process raft request' (duration: 443.794604ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:06.245989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:27:05.792826Z","time spent":"453.098051ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T01:27:06.245997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:27:05.79005Z","time spent":"455.907513ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T01:27:06.246037Z","caller":"traceutil/trace.go:171","msg":"trace[808732800] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"441.361509ms","start":"2026-04-07T01:27:05.804667Z","end":"2026-04-07T01:27:06.246028Z","steps":["trace[808732800] 'process raft request' (duration: 441.056872ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:06.246057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:27:05.801788Z","time spent":"444.220802ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T01:27:06.246077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:27:05.804647Z","time spent":"441.41177ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T01:27:06.246331Z","caller":"traceutil/trace.go:171","msg":"trace[1987164406] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"423.807329ms","start":"2026-04-07T01:27:05.822479Z","end":"2026-04-07T01:27:06.246287Z","steps":["trace[1987164406] 'process raft request' (duration: 423.337638ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:06.246391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:27:05.822454Z","time spent":"423.911321ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T01:27:06.2464Z","caller":"traceutil/trace.go:171","msg":"trace[934831541] linearizableReadLoop","detail":"{readStateIndex:501; appliedIndex:490; }","duration":"318.550426ms","start":"2026-04-07T01:27:05.927799Z","end":"2026-04-07T01:27:06.24635Z","steps":["trace[934831541] 'read index received' (duration: 56.636699ms)","trace[934831541] 'applied index is now lower than readState.Index' (duration: 261.912537ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:27:06.246511Z","caller":"traceutil/trace.go:171","msg":"trace[734624080] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"295.441652ms","start":"2026-04-07T01:27:05.951059Z","end":"2026-04-07T01:27:06.246501Z","steps":["trace[734624080] 'process raft request' (duration: 295.160706ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:06.246571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.752061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:27:06.246651Z","caller":"traceutil/trace.go:171","msg":"trace[1737131701] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:485; }","duration":"318.841992ms","start":"2026-04-07T01:27:05.927758Z","end":"2026-04-07T01:27:06.2466Z","steps":["trace[1737131701] 'agreement among raft nodes before linearized reading' (duration: 318.74173ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:06.24669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:27:05.927734Z","time spent":"318.947495ms","remote":"127.0.0.1:33156","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-04-07T01:27:06.251112Z","caller":"traceutil/trace.go:171","msg":"trace[1559255393] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"256.469716ms","start":"2026-04-07T01:27:05.994576Z","end":"2026-04-07T01:27:06.251045Z","steps":["trace[1559255393] 'process raft request' (duration: 256.273172ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:06.251355Z","caller":"traceutil/trace.go:171","msg":"trace[105154856] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"258.656224ms","start":"2026-04-07T01:27:05.992679Z","end":"2026-04-07T01:27:06.251335Z","steps":["trace[105154856] 'process raft request' (duration: 258.03466ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:06.25144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.119515ms","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-04-07T01:27:06.251479Z","caller":"traceutil/trace.go:171","msg":"trace[1048700246] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:487; }","duration":"130.184346ms","start":"2026-04-07T01:27:06.121286Z","end":"2026-04-07T01:27:06.25147Z","steps":["trace[1048700246] 'agreement among raft nodes before linearized reading' (duration: 130.105464ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:06.251367Z","caller":"traceutil/trace.go:171","msg":"trace[1226251546] transaction","detail":"{read_only:false; number_of_response:1; response_revision:487; }","duration":"255.79325ms","start":"2026-04-07T01:27:05.995561Z","end":"2026-04-07T01:27:06.251355Z","steps":["trace[1226251546] 'process raft request' (duration: 255.373671ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:06.251641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.422792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-07T01:27:06.25167Z","caller":"traceutil/trace.go:171","msg":"trace[1177679174] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:487; }","duration":"135.485164ms","start":"2026-04-07T01:27:06.116177Z","end":"2026-04-07T01:27:06.251662Z","steps":["trace[1177679174] 'agreement among raft nodes before linearized reading' (duration: 135.433133ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:12.80135Z","caller":"traceutil/trace.go:171","msg":"trace[281244915] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"289.883159ms","start":"2026-04-07T01:27:12.511431Z","end":"2026-04-07T01:27:12.801314Z","steps":["trace[281244915] 'process raft request' (duration: 288.09947ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:13.116946Z","caller":"traceutil/trace.go:171","msg":"trace[181437998] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:607; }","duration":"189.031876ms","start":"2026-04-07T01:27:12.927889Z","end":"2026-04-07T01:27:13.11692Z","steps":["trace[181437998] 'read index received' (duration: 188.785891ms)","trace[181437998] 'applied index is now lower than readState.Index' (duration: 245.145µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:27:13.116991Z","caller":"traceutil/trace.go:171","msg":"trace[2000464766] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"256.868525ms","start":"2026-04-07T01:27:12.860101Z","end":"2026-04-07T01:27:13.116969Z","steps":["trace[2000464766] 'process raft request' (duration: 256.658441ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:13.117111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.21699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:27:13.117151Z","caller":"traceutil/trace.go:171","msg":"trace[724009327] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:586; }","duration":"189.270671ms","start":"2026-04-07T01:27:12.92787Z","end":"2026-04-07T01:27:13.117141Z","steps":["trace[724009327] 'agreement among raft nodes before linearized reading' (duration: 189.177059ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:13.894523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.245053ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:27:13.89463Z","caller":"traceutil/trace.go:171","msg":"trace[1425759894] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"761.679295ms","start":"2026-04-07T01:27:13.132936Z","end":"2026-04-07T01:27:13.894616Z","steps":["trace[1425759894] 'process raft request' (duration: 464.062923ms)","trace[1425759894] 'compare' (duration: 296.941997ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:27:13.894674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:27:13.132916Z","time spent":"761.738057ms","remote":"127.0.0.1:33332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:27:13.901575Z","caller":"traceutil/trace.go:171","msg":"trace[911816393] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:608; }","duration":"478.120598ms","start":"2026-04-07T01:27:13.423428Z","end":"2026-04-07T01:27:13.901549Z","steps":["trace[911816393] 'read index received' (duration: 173.569071ms)","trace[911816393] 'applied index is now lower than readState.Index' (duration: 304.550587ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:27:13.901655Z","caller":"traceutil/trace.go:171","msg":"trace[983573962] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"768.14894ms","start":"2026-04-07T01:27:13.13347Z","end":"2026-04-07T01:27:13.901619Z","steps":["trace[983573962] 'process raft request' (duration: 767.963796ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:13.901793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:27:13.133459Z","time spent":"768.271143ms","remote":"127.0.0.1:33332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T01:27:13.901843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.404535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-07T01:27:13.90187Z","caller":"traceutil/trace.go:171","msg":"trace[377359630] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:588; }","duration":"478.481006ms","start":"2026-04-07T01:27:13.42338Z","end":"2026-04-07T01:27:13.901861Z","steps":["trace[377359630] 'agreement among raft nodes before linearized reading' (duration: 478.314362ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:13.90193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:27:13.42336Z","time spent":"478.528827ms","remote":"127.0.0.1:33406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-07T01:27:13.909397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.831458ms","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-04-07T01:27:13.909464Z","caller":"traceutil/trace.go:171","msg":"trace[692923956] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:588; }","duration":"253.937651ms","start":"2026-04-07T01:27:13.655514Z","end":"2026-04-07T01:27:13.909451Z","steps":["trace[692923956] 'agreement among raft nodes before linearized reading' (duration: 253.785947ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:19.295433Z","caller":"traceutil/trace.go:171","msg":"trace[1417199124] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"117.065034ms","start":"2026-04-07T01:27:19.178343Z","end":"2026-04-07T01:27:19.295408Z","steps":["trace[1417199124] 'process raft request' (duration: 116.9044ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:29.413552Z","caller":"traceutil/trace.go:171","msg":"trace[1175011546] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"209.126092ms","start":"2026-04-07T01:27:29.204394Z","end":"2026-04-07T01:27:29.41352Z","steps":["trace[1175011546] 'process raft request' (duration: 208.878556ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:12.712515Z","caller":"traceutil/trace.go:171","msg":"trace[393305967] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"141.225762ms","start":"2026-04-07T01:28:12.571247Z","end":"2026-04-07T01:28:12.712473Z","steps":["trace[393305967] 'process raft request' (duration: 140.993766ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:43.339776Z","caller":"traceutil/trace.go:171","msg":"trace[859013236] linearizableReadLoop","detail":"{readStateIndex:1893; appliedIndex:1891; }","duration":"372.787044ms","start":"2026-04-07T01:28:42.966963Z","end":"2026-04-07T01:28:43.33975Z","steps":["trace[859013236] 'read index received' (duration: 13.487751ms)","trace[859013236] 'applied index is now lower than readState.Index' (duration: 359.298053ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:28:43.339879Z","caller":"traceutil/trace.go:171","msg":"trace[769104546] transaction","detail":"{read_only:false; response_revision:1821; number_of_response:1; }","duration":"424.503355ms","start":"2026-04-07T01:28:42.915332Z","end":"2026-04-07T01:28:43.339835Z","steps":["trace[769104546] 'process raft request' (duration: 414.265587ms)","trace[769104546] 'compare' (duration: 10.038542ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:28:43.339962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.444643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:28:43.34004Z","caller":"traceutil/trace.go:171","msg":"trace[715526939] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1821; }","duration":"308.561016ms","start":"2026-04-07T01:28:43.031461Z","end":"2026-04-07T01:28:43.340022Z","steps":["trace[715526939] 'agreement among raft nodes before linearized reading' (duration: 308.449343ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:28:43.340079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.05659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-04-07T01:28:43.340087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:28:43.031441Z","time spent":"308.637797ms","remote":"127.0.0.1:33156","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-04-07T01:28:43.340557Z","caller":"traceutil/trace.go:171","msg":"trace[1046247174] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1821; }","duration":"373.172533ms","start":"2026-04-07T01:28:42.966943Z","end":"2026-04-07T01:28:43.340116Z","steps":["trace[1046247174] 'agreement among raft nodes before linearized reading' (duration: 372.951278ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:28:43.340628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:28:42.966846Z","time spent":"373.756115ms","remote":"127.0.0.1:56954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-07T01:28:43.340816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:28:42.915308Z","time spent":"424.701139ms","remote":"127.0.0.1:33406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:28:43.883344Z","caller":"traceutil/trace.go:171","msg":"trace[1238315635] transaction","detail":"{read_only:false; response_revision:1822; number_of_response:1; }","duration":"312.888971ms","start":"2026-04-07T01:28:43.570431Z","end":"2026-04-07T01:28:43.88332Z","steps":["trace[1238315635] 'process raft request' (duration: 312.722746ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:28:43.883488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:28:43.570401Z","time spent":"313.010724ms","remote":"127.0.0.1:33332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:28:43.8847Z","caller":"traceutil/trace.go:171","msg":"trace[587696082] transaction","detail":"{read_only:false; response_revision:1823; number_of_response:1; }","duration":"206.219698ms","start":"2026-04-07T01:28:43.67846Z","end":"2026-04-07T01:28:43.88468Z","steps":["trace[587696082] 'process raft request' (duration: 206.051274ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:43.884881Z","caller":"traceutil/trace.go:171","msg":"trace[1614612224] linearizableReadLoop","detail":"{readStateIndex:1895; appliedIndex:1893; }","duration":"195.781356ms","start":"2026-04-07T01:28:43.689072Z","end":"2026-04-07T01:28:43.884854Z","steps":["trace[1614612224] 'read index received' (duration: 194.209871ms)","trace[1614612224] 'applied index is now lower than readState.Index' (duration: 1.570134ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:28:43.885212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.129533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-24d35817-f133-48ec-9b63-0609e0e22c7a\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-04-07T01:28:43.88522Z","caller":"traceutil/trace.go:171","msg":"trace[534672233] transaction","detail":"{read_only:false; response_revision:1824; number_of_response:1; }","duration":"102.158982ms","start":"2026-04-07T01:28:43.783036Z","end":"2026-04-07T01:28:43.885195Z","steps":["trace[534672233] 'process raft request' (duration: 101.574119ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:43.885291Z","caller":"traceutil/trace.go:171","msg":"trace[752417101] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-24d35817-f133-48ec-9b63-0609e0e22c7a; range_end:; response_count:1; response_revision:1824; }","duration":"196.248346ms","start":"2026-04-07T01:28:43.689026Z","end":"2026-04-07T01:28:43.885274Z","steps":["trace[752417101] 'agreement among raft nodes before linearized reading' (duration: 196.079942ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:28:43.88545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.345278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-07T01:28:43.885501Z","caller":"traceutil/trace.go:171","msg":"trace[1685193974] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1824; }","duration":"111.549932ms","start":"2026-04-07T01:28:43.773938Z","end":"2026-04-07T01:28:43.885488Z","steps":["trace[1685193974] 'agreement among raft nodes before linearized reading' (duration: 111.285867ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:56.291591Z","caller":"traceutil/trace.go:171","msg":"trace[30529351] transaction","detail":"{read_only:false; response_revision:1929; number_of_response:1; }","duration":"241.260657ms","start":"2026-04-07T01:28:56.050307Z","end":"2026-04-07T01:28:56.291568Z","steps":["trace[30529351] 'process raft request' (duration: 241.107314ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:56.291596Z","caller":"traceutil/trace.go:171","msg":"trace[2073407708] transaction","detail":"{read_only:false; response_revision:1928; number_of_response:1; }","duration":"252.644931ms","start":"2026-04-07T01:28:56.038913Z","end":"2026-04-07T01:28:56.291558Z","steps":["trace[2073407708] 'process raft request' (duration: 229.68582ms)","trace[2073407708] 'compare' (duration: 22.642904ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:28:56.291685Z","caller":"traceutil/trace.go:171","msg":"trace[1775987872] transaction","detail":"{read_only:false; response_revision:1930; number_of_response:1; }","duration":"157.707978ms","start":"2026-04-07T01:28:56.133956Z","end":"2026-04-07T01:28:56.291664Z","steps":["trace[1775987872] 'process raft request' (duration: 157.571725ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:56.651389Z","caller":"traceutil/trace.go:171","msg":"trace[1006767742] transaction","detail":"{read_only:false; response_revision:1931; number_of_response:1; }","duration":"113.097625ms","start":"2026-04-07T01:28:56.538263Z","end":"2026-04-07T01:28:56.65136Z","steps":["trace[1006767742] 'process raft request' (duration: 112.86702ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:56.672163Z","caller":"traceutil/trace.go:171","msg":"trace[2003067342] transaction","detail":"{read_only:false; response_revision:1932; number_of_response:1; }","duration":"133.269295ms","start":"2026-04-07T01:28:56.538872Z","end":"2026-04-07T01:28:56.672141Z","steps":["trace[2003067342] 'process raft request' (duration: 133.130812ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:29:00.059418Z","caller":"traceutil/trace.go:171","msg":"trace[807657005] linearizableReadLoop","detail":"{readStateIndex:2034; appliedIndex:2033; }","duration":"131.513026ms","start":"2026-04-07T01:28:59.927881Z","end":"2026-04-07T01:29:00.059394Z","steps":["trace[807657005] 'read index received' (duration: 131.484306ms)","trace[807657005] 'applied index is now lower than readState.Index' (duration: 27.33µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:29:00.05953Z","caller":"traceutil/trace.go:171","msg":"trace[808324218] transaction","detail":"{read_only:false; response_revision:1958; number_of_response:1; }","duration":"267.112792ms","start":"2026-04-07T01:28:59.79238Z","end":"2026-04-07T01:29:00.059492Z","steps":["trace[808324218] 'process raft request' (duration: 266.878747ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:29:00.059567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.66809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:29:00.059719Z","caller":"traceutil/trace.go:171","msg":"trace[305185285] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1958; }","duration":"131.850723ms","start":"2026-04-07T01:28:59.927838Z","end":"2026-04-07T01:29:00.059689Z","steps":["trace[305185285] 'agreement among raft nodes before linearized reading' (duration: 131.678649ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:29:00.439363Z","caller":"traceutil/trace.go:171","msg":"trace[675205199] transaction","detail":"{read_only:false; response_revision:1960; number_of_response:1; }","duration":"137.252353ms","start":"2026-04-07T01:29:00.302096Z","end":"2026-04-07T01:29:00.439348Z","steps":["trace[675205199] 'process raft request' (duration: 137.020657ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:29:00.439326Z","caller":"traceutil/trace.go:171","msg":"trace[108268194] linearizableReadLoop","detail":"{readStateIndex:2036; appliedIndex:2035; }","duration":"136.025715ms","start":"2026-04-07T01:29:00.303267Z","end":"2026-04-07T01:29:00.439292Z","steps":["trace[108268194] 'read index received' (duration: 135.828581ms)","trace[108268194] 'applied index is now lower than readState.Index' (duration: 196.284µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:29:00.439631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.330303ms","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-04-07T01:29:00.439715Z","caller":"traceutil/trace.go:171","msg":"trace[888574969] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1960; }","duration":"136.478936ms","start":"2026-04-07T01:29:00.303227Z","end":"2026-04-07T01:29:00.439706Z","steps":["trace[888574969] 'agreement among raft nodes before linearized reading' (duration: 136.20019ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:29:00.441422Z","caller":"traceutil/trace.go:171","msg":"trace[1754768495] transaction","detail":"{read_only:false; response_revision:1961; number_of_response:1; }","duration":"136.790663ms","start":"2026-04-07T01:29:00.3046Z","end":"2026-04-07T01:29:00.44139Z","steps":["trace[1754768495] 'process raft request' (duration: 136.665051ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:29:39.026542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.071799ms","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-04-07T01:29:39.026622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.247611ms","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-04-07T01:29:39.026665Z","caller":"traceutil/trace.go:171","msg":"trace[310952966] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2172; }","duration":"117.228542ms","start":"2026-04-07T01:29:38.909411Z","end":"2026-04-07T01:29:39.02664Z","steps":["trace[310952966] 'range keys from in-memory index tree' (duration: 116.903365ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:29:39.026714Z","caller":"traceutil/trace.go:171","msg":"trace[884300864] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2172; }","duration":"133.394804ms","start":"2026-04-07T01:29:38.893296Z","end":"2026-04-07T01:29:39.026691Z","steps":["trace[884300864] 'range keys from in-memory index tree' (duration: 132.991665ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:29:39.278228Z","caller":"traceutil/trace.go:171","msg":"trace[2094643970] transaction","detail":"{read_only:false; response_revision:2173; number_of_response:1; }","duration":"247.230361ms","start":"2026-04-07T01:29:39.030971Z","end":"2026-04-07T01:29:39.278201Z","steps":["trace[2094643970] 'process raft request' (duration: 247.094648ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:29:39.407947Z","caller":"traceutil/trace.go:171","msg":"trace[163490661] linearizableReadLoop","detail":"{readStateIndex:2259; appliedIndex:2257; }","duration":"123.490082ms","start":"2026-04-07T01:29:39.284434Z","end":"2026-04-07T01:29:39.407924Z","steps":["trace[163490661] 'read index received' (duration: 117.489188ms)","trace[163490661] 'applied index is now lower than readState.Index' (duration: 5.999824ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:29:39.407965Z","caller":"traceutil/trace.go:171","msg":"trace[108136206] transaction","detail":"{read_only:false; response_revision:2174; number_of_response:1; }","duration":"376.953702ms","start":"2026-04-07T01:29:39.030985Z","end":"2026-04-07T01:29:39.407939Z","steps":["trace[108136206] 'process raft request' (duration: 370.999809ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:29:39.408074Z","caller":"traceutil/trace.go:171","msg":"trace[723090495] transaction","detail":"{read_only:false; response_revision:2175; number_of_response:1; }","duration":"317.321018ms","start":"2026-04-07T01:29:39.090717Z","end":"2026-04-07T01:29:39.408038Z","steps":["trace[723090495] 'process raft request' (duration: 317.160074ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:29:39.408199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.760949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-07T01:29:39.408217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:29:39.030965Z","time spent":"377.062905ms","remote":"127.0.0.1:33406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:29:39.408265Z","caller":"traceutil/trace.go:171","msg":"trace[476836418] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2175; }","duration":"123.86263ms","start":"2026-04-07T01:29:39.284385Z","end":"2026-04-07T01:29:39.408248Z","steps":["trace[476836418] 'agreement among raft nodes before linearized reading' (duration: 123.640115ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:29:39.408264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:29:39.090696Z","time spent":"317.467391ms","remote":"127.0.0.1:33406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:29:39.774353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.810943ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:29:39.774506Z","caller":"traceutil/trace.go:171","msg":"trace[446159386] transaction","detail":"{read_only:false; response_revision:2176; number_of_response:1; }","duration":"362.263344ms","start":"2026-04-07T01:29:39.412205Z","end":"2026-04-07T01:29:39.774468Z","steps":["trace[446159386] 'process raft request' (duration: 186.246176ms)","trace[446159386] 'compare' (duration: 175.704711ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:29:39.77468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:29:39.412184Z","time spent":"362.412256ms","remote":"127.0.0.1:33406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:29:44.793643Z","caller":"traceutil/trace.go:171","msg":"trace[232204504] transaction","detail":"{read_only:false; response_revision:2200; number_of_response:1; }","duration":"150.236931ms","start":"2026-04-07T01:29:44.643373Z","end":"2026-04-07T01:29:44.79361Z","steps":["trace[232204504] 'process raft request' (duration: 52.26558ms)","trace[232204504] 'compare' (duration: 97.672584ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:30:11.250488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.071623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"warn","ts":"2026-04-07T01:30:11.25053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.690059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T01:30:11.250601Z","caller":"traceutil/trace.go:171","msg":"trace[477145036] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2520; }","duration":"182.243037ms","start":"2026-04-07T01:30:11.068333Z","end":"2026-04-07T01:30:11.250576Z","steps":["trace[477145036] 'range keys from in-memory index tree' (duration: 181.886979ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:30:11.250612Z","caller":"traceutil/trace.go:171","msg":"trace[1652111725] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:2520; }","duration":"191.823492ms","start":"2026-04-07T01:30:11.058772Z","end":"2026-04-07T01:30:11.250595Z","steps":["trace[1652111725] 'count revisions from in-memory index tree' (duration: 191.576816ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:30:46.240804Z","caller":"traceutil/trace.go:171","msg":"trace[1179748291] transaction","detail":"{read_only:false; response_revision:2735; number_of_response:1; }","duration":"115.140498ms","start":"2026-04-07T01:30:46.125634Z","end":"2026-04-07T01:30:46.240774Z","steps":["trace[1179748291] 'process raft request' (duration: 104.90688ms)","trace[1179748291] 'compare' (duration: 10.098615ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:30:46.683611Z","caller":"traceutil/trace.go:171","msg":"trace[208423650] transaction","detail":"{read_only:false; response_revision:2736; number_of_response:1; }","duration":"248.979576ms","start":"2026-04-07T01:30:46.43461Z","end":"2026-04-07T01:30:46.68359Z","steps":["trace[208423650] 'process raft request' (duration: 248.851453ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:33:07.057323Z","caller":"traceutil/trace.go:171","msg":"trace[1648587258] transaction","detail":"{read_only:false; response_revision:3677; number_of_response:1; }","duration":"123.280953ms","start":"2026-04-07T01:33:06.934017Z","end":"2026-04-07T01:33:07.057298Z","steps":["trace[1648587258] 'process raft request' (duration: 123.156001ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:33:12.742769Z","caller":"traceutil/trace.go:171","msg":"trace[1847810815] transaction","detail":"{read_only:false; response_revision:3704; number_of_response:1; }","duration":"299.381571ms","start":"2026-04-07T01:33:12.443363Z","end":"2026-04-07T01:33:12.742745Z","steps":["trace[1847810815] 'process raft request' (duration: 299.245628ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:33:12.765406Z","caller":"traceutil/trace.go:171","msg":"trace[434545953] transaction","detail":"{read_only:false; response_revision:3705; number_of_response:1; }","duration":"320.482144ms","start":"2026-04-07T01:33:12.444901Z","end":"2026-04-07T01:33:12.765383Z","steps":["trace[434545953] 'process raft request' (duration: 320.357272ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:33:12.765556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:33:12.444867Z","time spent":"320.613717ms","remote":"127.0.0.1:33406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:34:29.406939Z","caller":"traceutil/trace.go:171","msg":"trace[1331663753] linearizableReadLoop","detail":"{readStateIndex:4760; appliedIndex:4759; }","duration":"152.720161ms","start":"2026-04-07T01:34:29.254199Z","end":"2026-04-07T01:34:29.40692Z","steps":["trace[1331663753] 'read index received' (duration: 58.302016ms)","trace[1331663753] 'applied index is now lower than readState.Index' (duration: 94.417415ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:34:29.407065Z","caller":"traceutil/trace.go:171","msg":"trace[1583231138] transaction","detail":"{read_only:false; response_revision:4580; number_of_response:1; }","duration":"159.530925ms","start":"2026-04-07T01:34:29.247465Z","end":"2026-04-07T01:34:29.406996Z","steps":["trace[1583231138] 'process raft request' (duration: 65.103ms)","trace[1583231138] 'compare' (duration: 94.24412ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:34:29.407097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.869294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:34:29.407289Z","caller":"traceutil/trace.go:171","msg":"trace[379014562] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:0; response_revision:4580; }","duration":"153.102099ms","start":"2026-04-07T01:34:29.254161Z","end":"2026-04-07T01:34:29.407263Z","steps":["trace[379014562] 'agreement among raft nodes before linearized reading' (duration: 152.833053ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:34:34.601834Z","caller":"traceutil/trace.go:171","msg":"trace[1844426889] transaction","detail":"{read_only:false; response_revision:4737; number_of_response:1; }","duration":"108.847219ms","start":"2026-04-07T01:34:34.492965Z","end":"2026-04-07T01:34:34.601812Z","steps":["trace[1844426889] 'process raft request' (duration: 108.678745ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:34:38.751343Z","caller":"traceutil/trace.go:171","msg":"trace[355171026] transaction","detail":"{read_only:false; response_revision:4901; number_of_response:1; }","duration":"137.837245ms","start":"2026-04-07T01:34:38.613478Z","end":"2026-04-07T01:34:38.751315Z","steps":["trace[355171026] 'process raft request' (duration: 137.538239ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:34:39.30227Z","caller":"traceutil/trace.go:171","msg":"trace[2059264521] transaction","detail":"{read_only:false; response_revision:4904; number_of_response:1; }","duration":"155.993323ms","start":"2026-04-07T01:34:39.146245Z","end":"2026-04-07T01:34:39.302238Z","steps":["trace[2059264521] 'process raft request' (duration: 56.185308ms)","trace[2059264521] 'compare' (duration: 99.222831ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:34:39.302348Z","caller":"traceutil/trace.go:171","msg":"trace[734158084] transaction","detail":"{read_only:false; response_revision:4905; number_of_response:1; }","duration":"155.212016ms","start":"2026-04-07T01:34:39.147112Z","end":"2026-04-07T01:34:39.302324Z","steps":["trace[734158084] 'process raft request' (duration: 155.063473ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:34:56.507999Z","caller":"traceutil/trace.go:171","msg":"trace[1523333430] transaction","detail":"{read_only:false; response_revision:5268; number_of_response:1; }","duration":"141.659572ms","start":"2026-04-07T01:34:56.366308Z","end":"2026-04-07T01:34:56.507967Z","steps":["trace[1523333430] 'process raft request' (duration: 141.448357ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:34:56.727417Z","caller":"traceutil/trace.go:171","msg":"trace[433831347] transaction","detail":"{read_only:false; response_revision:5269; number_of_response:1; }","duration":"210.024032ms","start":"2026-04-07T01:34:56.517376Z","end":"2026-04-07T01:34:56.7274Z","steps":["trace[433831347] 'process raft request' (duration: 209.871949ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:34:57.033689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.992097ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:34:57.03398Z","caller":"traceutil/trace.go:171","msg":"trace[908389494] linearizableReadLoop","detail":"{readStateIndex:5468; appliedIndex:5466; }","duration":"199.266451ms","start":"2026-04-07T01:34:56.834688Z","end":"2026-04-07T01:34:57.033954Z","steps":["trace[908389494] 'read index received' (duration: 38.929222ms)","trace[908389494] 'applied index is now lower than readState.Index' (duration: 160.335989ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:34:57.034141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.502957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:34:57.034166Z","caller":"traceutil/trace.go:171","msg":"trace[437083589] transaction","detail":"{read_only:false; response_revision:5270; number_of_response:1; }","duration":"328.171007ms","start":"2026-04-07T01:34:56.705875Z","end":"2026-04-07T01:34:57.034046Z","steps":["trace[437083589] 'process raft request' (duration: 127.683769ms)","trace[437083589] 'compare' (duration: 199.849424ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:34:57.034295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.571287ms","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-04-07T01:34:57.034431Z","caller":"traceutil/trace.go:171","msg":"trace[1281296011] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5271; }","duration":"199.750853ms","start":"2026-04-07T01:34:56.834658Z","end":"2026-04-07T01:34:57.034409Z","steps":["trace[1281296011] 'agreement among raft nodes before linearized reading' (duration: 199.427365ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:34:57.034193Z","caller":"traceutil/trace.go:171","msg":"trace[152981238] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5271; }","duration":"107.555658ms","start":"2026-04-07T01:34:56.926622Z","end":"2026-04-07T01:34:57.034178Z","steps":["trace[152981238] 'agreement among raft nodes before linearized reading' (duration: 107.456976ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:34:57.034185Z","caller":"traceutil/trace.go:171","msg":"trace[466266930] transaction","detail":"{read_only:false; response_revision:5271; number_of_response:1; }","duration":"211.173117ms","start":"2026-04-07T01:34:56.822966Z","end":"2026-04-07T01:34:57.03414Z","steps":["trace[466266930] 'process raft request' (duration: 210.88014ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:34:57.034585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:34:56.705848Z","time spent":"328.559057ms","remote":"127.0.0.1:33406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:35:08.858635Z","caller":"traceutil/trace.go:171","msg":"trace[358035342] linearizableReadLoop","detail":"{readStateIndex:5633; appliedIndex:5632; }","duration":"158.909397ms","start":"2026-04-07T01:35:08.699701Z","end":"2026-04-07T01:35:08.85861Z","steps":["trace[358035342] 'read index received' (duration: 158.691023ms)","trace[358035342] 'applied index is now lower than readState.Index' (duration: 217.494µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:35:08.858699Z","caller":"traceutil/trace.go:171","msg":"trace[770854733] transaction","detail":"{read_only:false; response_revision:5434; number_of_response:1; }","duration":"226.838429ms","start":"2026-04-07T01:35:08.631829Z","end":"2026-04-07T01:35:08.858668Z","steps":["trace[770854733] 'process raft request' (duration: 226.619404ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:35:08.8589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.185053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.227\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-04-07T01:35:08.858932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.894399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-04-07T01:35:08.858951Z","caller":"traceutil/trace.go:171","msg":"trace[690683632] range","detail":"{range_begin:/registry/masterleases/199.204.45.227; range_end:; response_count:1; response_revision:5434; }","duration":"159.290056ms","start":"2026-04-07T01:35:08.699647Z","end":"2026-04-07T01:35:08.858937Z","steps":["trace[690683632] 'agreement among raft nodes before linearized reading' (duration: 159.115582ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:35:08.859046Z","caller":"traceutil/trace.go:171","msg":"trace[1390883528] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5434; }","duration":"138.991932ms","start":"2026-04-07T01:35:08.719991Z","end":"2026-04-07T01:35:08.858983Z","steps":["trace[1390883528] 'agreement among raft nodes before linearized reading' (duration: 138.827008ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:36:35.760662Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3002} {"level":"info","ts":"2026-04-07T01:36:35.841839Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3002,"took":"79.819732ms","hash":929170813,"current-db-size-bytes":58667008,"current-db-size":"59 MB","current-db-size-in-use-bytes":32174080,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-07T01:36:35.841936Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":929170813,"revision":3002,"compact-revision":-1} {"level":"info","ts":"2026-04-07T01:40:58.571521Z","caller":"traceutil/trace.go:171","msg":"trace[634853751] transaction","detail":"{read_only:false; response_revision:8081; number_of_response:1; }","duration":"245.698075ms","start":"2026-04-07T01:40:58.325794Z","end":"2026-04-07T01:40:58.571492Z","steps":["trace[634853751] 'process raft request' (duration: 245.535061ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:40:58.800424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.394617ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:40:58.80053Z","caller":"traceutil/trace.go:171","msg":"trace[1003914525] linearizableReadLoop","detail":"{readStateIndex:8367; appliedIndex:8366; }","duration":"109.712892ms","start":"2026-04-07T01:40:58.690801Z","end":"2026-04-07T01:40:58.800513Z","steps":["trace[1003914525] 'read index received' (duration: 72.252µs)","trace[1003914525] 'applied index is now lower than readState.Index' (duration: 109.63958ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:40:58.800793Z","caller":"traceutil/trace.go:171","msg":"trace[1726321259] transaction","detail":"{read_only:false; response_revision:8082; number_of_response:1; }","duration":"396.856266ms","start":"2026-04-07T01:40:58.403919Z","end":"2026-04-07T01:40:58.800776Z","steps":["trace[1726321259] 'process raft request' (duration: 188.02483ms)","trace[1726321259] 'compare' (duration: 208.183482ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:40:58.800886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:40:58.403897Z","time spent":"396.94795ms","remote":"127.0.0.1:33406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:40:58.800859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.02948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:40:58.80109Z","caller":"traceutil/trace.go:171","msg":"trace[965139828] range","detail":"{range_begin:/registry/monitoring.coreos.com/scrapeconfigs/; range_end:/registry/monitoring.coreos.com/scrapeconfigs0; response_count:0; response_revision:8082; }","duration":"110.316207ms","start":"2026-04-07T01:40:58.690752Z","end":"2026-04-07T01:40:58.801068Z","steps":["trace[965139828] 'agreement among raft nodes before linearized reading' (duration: 110.018949ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:41:09.849177Z","caller":"traceutil/trace.go:171","msg":"trace[1171437859] transaction","detail":"{read_only:false; response_revision:8143; number_of_response:1; }","duration":"273.007237ms","start":"2026-04-07T01:41:09.576136Z","end":"2026-04-07T01:41:09.849143Z","steps":["trace[1171437859] 'process raft request' (duration: 272.741531ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:41:11.960884Z","caller":"traceutil/trace.go:171","msg":"trace[726737155] transaction","detail":"{read_only:false; response_revision:8153; number_of_response:1; }","duration":"103.223198ms","start":"2026-04-07T01:41:11.857625Z","end":"2026-04-07T01:41:11.960848Z","steps":["trace[726737155] 'process raft request' (duration: 102.946211ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:41:35.7683Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6160} {"level":"info","ts":"2026-04-07T01:41:35.882235Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6160,"took":"110.565881ms","hash":4127529003,"current-db-size-bytes":58667008,"current-db-size":"59 MB","current-db-size-in-use-bytes":23138304,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-07T01:41:35.882322Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4127529003,"revision":6160,"compact-revision":3002} {"level":"info","ts":"2026-04-07T01:41:39.54889Z","caller":"traceutil/trace.go:171","msg":"trace[721240398] transaction","detail":"{read_only:false; response_revision:8355; number_of_response:1; }","duration":"259.31499ms","start":"2026-04-07T01:41:39.289547Z","end":"2026-04-07T01:41:39.548862Z","steps":["trace[721240398] 'process raft request' (duration: 256.991928ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:41:39.812473Z","caller":"traceutil/trace.go:171","msg":"trace[494104042] linearizableReadLoop","detail":"{readStateIndex:8654; appliedIndex:8652; }","duration":"417.02456ms","start":"2026-04-07T01:41:39.395421Z","end":"2026-04-07T01:41:39.812445Z","steps":["trace[494104042] 'read index received' (duration: 151.187083ms)","trace[494104042] 'applied index is now lower than readState.Index' (duration: 265.836347ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:41:39.81252Z","caller":"traceutil/trace.go:171","msg":"trace[1327143053] transaction","detail":"{read_only:false; response_revision:8356; number_of_response:1; }","duration":"473.259772ms","start":"2026-04-07T01:41:39.339213Z","end":"2026-04-07T01:41:39.812473Z","steps":["trace[1327143053] 'process raft request' (duration: 473.031386ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:41:39.812668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:41:39.339173Z","time spent":"473.415705ms","remote":"127.0.0.1:33406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:41:39.812756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.37105ms","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":"warn","ts":"2026-04-07T01:41:39.812806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.362017ms","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-04-07T01:41:39.812855Z","caller":"traceutil/trace.go:171","msg":"trace[293482032] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8356; }","duration":"373.506332ms","start":"2026-04-07T01:41:39.439326Z","end":"2026-04-07T01:41:39.812832Z","steps":["trace[293482032] 'agreement among raft nodes before linearized reading' (duration: 373.343879ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:41:39.812907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.327359ms","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-04-07T01:41:39.81292Z","caller":"traceutil/trace.go:171","msg":"trace[828339329] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8356; }","duration":"417.532042ms","start":"2026-04-07T01:41:39.395365Z","end":"2026-04-07T01:41:39.812897Z","steps":["trace[828339329] 'agreement among raft nodes before linearized reading' (duration: 417.195323ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:41:39.813013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:41:39.395342Z","time spent":"417.661175ms","remote":"127.0.0.1:33406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-07T01:41:39.813008Z","caller":"traceutil/trace.go:171","msg":"trace[817318044] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8356; }","duration":"238.499024ms","start":"2026-04-07T01:41:39.574489Z","end":"2026-04-07T01:41:39.812987Z","steps":["trace[817318044] 'agreement among raft nodes before linearized reading' (duration: 238.176556ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:41:39.812922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:41:39.439314Z","time spent":"373.593756ms","remote":"127.0.0.1:56920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-04-07T01:41:39.812854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.404301ms","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-04-07T01:41:39.81332Z","caller":"traceutil/trace.go:171","msg":"trace[1006810641] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8356; }","duration":"410.885242ms","start":"2026-04-07T01:41:39.402381Z","end":"2026-04-07T01:41:39.813266Z","steps":["trace[1006810641] 'agreement among raft nodes before linearized reading' (duration: 410.246377ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:41:39.813365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:41:39.402359Z","time spent":"410.993695ms","remote":"127.0.0.1:33406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-07T01:41:41.940676Z","caller":"traceutil/trace.go:171","msg":"trace[1124588976] linearizableReadLoop","detail":"{readStateIndex:8664; appliedIndex:8663; }","duration":"118.138282ms","start":"2026-04-07T01:41:41.822512Z","end":"2026-04-07T01:41:41.94065Z","steps":["trace[1124588976] 'read index received' (duration: 117.979168ms)","trace[1124588976] 'applied index is now lower than readState.Index' (duration: 158.094µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:41:41.940748Z","caller":"traceutil/trace.go:171","msg":"trace[725366946] transaction","detail":"{read_only:false; response_revision:8366; number_of_response:1; }","duration":"121.736792ms","start":"2026-04-07T01:41:41.818974Z","end":"2026-04-07T01:41:41.94071Z","steps":["trace[725366946] 'process raft request' (duration: 121.527248ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:41:41.940997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.094858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-04-07T01:41:41.940989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.444048ms","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-04-07T01:41:41.941045Z","caller":"traceutil/trace.go:171","msg":"trace[1992836130] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8366; }","duration":"117.230221ms","start":"2026-04-07T01:41:41.823801Z","end":"2026-04-07T01:41:41.941031Z","steps":["trace[1992836130] 'agreement among raft nodes before linearized reading' (duration: 117.081318ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:41:41.941085Z","caller":"traceutil/trace.go:171","msg":"trace[2061615909] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8366; }","duration":"118.585431ms","start":"2026-04-07T01:41:41.82248Z","end":"2026-04-07T01:41:41.941065Z","steps":["trace[2061615909] 'agreement among raft nodes before linearized reading' (duration: 118.317605ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:41:41.941261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.099971ms","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-04-07T01:41:41.941323Z","caller":"traceutil/trace.go:171","msg":"trace[1961765303] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8366; }","duration":"118.200233ms","start":"2026-04-07T01:41:41.823112Z","end":"2026-04-07T01:41:41.941313Z","steps":["trace[1961765303] 'agreement among raft nodes before linearized reading' (duration: 117.687471ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:41:52.224421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.205106ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:41:52.224533Z","caller":"traceutil/trace.go:171","msg":"trace[1594395154] linearizableReadLoop","detail":"{readStateIndex:8767; appliedIndex:8766; }","duration":"229.302967ms","start":"2026-04-07T01:41:51.995211Z","end":"2026-04-07T01:41:52.224514Z","steps":["trace[1594395154] 'read index received' (duration: 96.872885ms)","trace[1594395154] 'applied index is now lower than readState.Index' (duration: 132.428562ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:41:52.224567Z","caller":"traceutil/trace.go:171","msg":"trace[788284905] transaction","detail":"{read_only:false; response_revision:8464; number_of_response:1; }","duration":"245.913539ms","start":"2026-04-07T01:41:51.978624Z","end":"2026-04-07T01:41:52.224538Z","steps":["trace[788284905] 'process raft request' (duration: 113.488368ms)","trace[788284905] 'compare' (duration: 131.995832ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:41:52.224739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.532512ms","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-04-07T01:41:52.224774Z","caller":"traceutil/trace.go:171","msg":"trace[1857980850] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8464; }","duration":"229.594872ms","start":"2026-04-07T01:41:51.99517Z","end":"2026-04-07T01:41:52.224765Z","steps":["trace[1857980850] 'agreement among raft nodes before linearized reading' (duration: 229.441369ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:41:52.225022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.820381ms","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-04-07T01:41:52.22511Z","caller":"traceutil/trace.go:171","msg":"trace[375044825] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8464; }","duration":"120.932094ms","start":"2026-04-07T01:41:52.104157Z","end":"2026-04-07T01:41:52.225089Z","steps":["trace[375044825] 'agreement among raft nodes before linearized reading' (duration: 120.693948ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:41:52.225028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.645707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-07T01:41:52.225252Z","caller":"traceutil/trace.go:171","msg":"trace[1346545552] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8464; }","duration":"124.910683ms","start":"2026-04-07T01:41:52.100322Z","end":"2026-04-07T01:41:52.225232Z","steps":["trace[1346545552] 'agreement among raft nodes before linearized reading' (duration: 124.519614ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:41:52.491073Z","caller":"traceutil/trace.go:171","msg":"trace[1428691186] linearizableReadLoop","detail":"{readStateIndex:8770; appliedIndex:8767; }","duration":"231.393123ms","start":"2026-04-07T01:41:52.25965Z","end":"2026-04-07T01:41:52.491043Z","steps":["trace[1428691186] 'read index received' (duration: 6.874254ms)","trace[1428691186] 'applied index is now lower than readState.Index' (duration: 224.517629ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:41:52.491246Z","caller":"traceutil/trace.go:171","msg":"trace[1127911239] transaction","detail":"{read_only:false; response_revision:8467; number_of_response:1; }","duration":"260.619639ms","start":"2026-04-07T01:41:52.230608Z","end":"2026-04-07T01:41:52.491227Z","steps":["trace[1127911239] 'process raft request' (duration: 260.301852ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:41:52.491267Z","caller":"traceutil/trace.go:171","msg":"trace[75846480] transaction","detail":"{read_only:false; response_revision:8466; number_of_response:1; }","duration":"260.857284ms","start":"2026-04-07T01:41:52.230387Z","end":"2026-04-07T01:41:52.491244Z","steps":["trace[75846480] 'process raft request' (duration: 168.616984ms)","trace[75846480] 'compare' (duration: 91.659727ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:41:52.491464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.650845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"warn","ts":"2026-04-07T01:41:52.491507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.836332ms","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-04-07T01:41:52.491521Z","caller":"traceutil/trace.go:171","msg":"trace[1793810879] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8467; }","duration":"107.720417ms","start":"2026-04-07T01:41:52.383786Z","end":"2026-04-07T01:41:52.491507Z","steps":["trace[1793810879] 'agreement among raft nodes before linearized reading' (duration: 107.533733ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:41:52.491573Z","caller":"traceutil/trace.go:171","msg":"trace[1855806974] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8467; }","duration":"231.952665ms","start":"2026-04-07T01:41:52.259603Z","end":"2026-04-07T01:41:52.491556Z","steps":["trace[1855806974] 'agreement among raft nodes before linearized reading' (duration: 231.74244ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:41:52.677541Z","caller":"traceutil/trace.go:171","msg":"trace[1279858993] linearizableReadLoop","detail":"{readStateIndex:8773; appliedIndex:8772; }","duration":"112.104176ms","start":"2026-04-07T01:41:52.565415Z","end":"2026-04-07T01:41:52.677519Z","steps":["trace[1279858993] 'read index received' (duration: 111.85472ms)","trace[1279858993] 'applied index is now lower than readState.Index' (duration: 248.586µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:41:52.67763Z","caller":"traceutil/trace.go:171","msg":"trace[1936775930] transaction","detail":"{read_only:false; response_revision:8470; number_of_response:1; }","duration":"130.186203ms","start":"2026-04-07T01:41:52.547412Z","end":"2026-04-07T01:41:52.677598Z","steps":["trace[1936775930] 'process raft request' (duration: 129.925007ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:41:52.677809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.061689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-config-override\" ","response":"range_response_count:1 size:626"} {"level":"info","ts":"2026-04-07T01:41:52.677855Z","caller":"traceutil/trace.go:171","msg":"trace[981254571] range","detail":"{range_begin:/registry/configmaps/openstack/rook-config-override; range_end:; response_count:1; response_revision:8470; }","duration":"105.150011ms","start":"2026-04-07T01:41:52.572692Z","end":"2026-04-07T01:41:52.677842Z","steps":["trace[981254571] 'agreement among raft nodes before linearized reading' (duration: 104.955837ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:41:52.677871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.74402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-gcd58\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-07T01:41:52.677977Z","caller":"traceutil/trace.go:171","msg":"trace[506322469] range","detail":"{range_begin:/registry/pods/openstack/keepalived-gcd58; range_end:; response_count:1; response_revision:8470; }","duration":"132.858812ms","start":"2026-04-07T01:41:52.545099Z","end":"2026-04-07T01:41:52.677958Z","steps":["trace[506322469] 'agreement among raft nodes before linearized reading' (duration: 132.509755ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:41:53.104952Z","caller":"traceutil/trace.go:171","msg":"trace[1704747541] linearizableReadLoop","detail":"{readStateIndex:8775; appliedIndex:8774; }","duration":"143.341877ms","start":"2026-04-07T01:41:52.96159Z","end":"2026-04-07T01:41:53.104932Z","steps":["trace[1704747541] 'read index received' (duration: 143.280096ms)","trace[1704747541] 'applied index is now lower than readState.Index' (duration: 60.961µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:41:53.105086Z","caller":"traceutil/trace.go:171","msg":"trace[929378140] transaction","detail":"{read_only:false; response_revision:8472; number_of_response:1; }","duration":"153.588456ms","start":"2026-04-07T01:41:52.951477Z","end":"2026-04-07T01:41:53.105065Z","steps":["trace[929378140] 'process raft request' (duration: 153.32125ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:41:53.105155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.546321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-04-07T01:41:53.105187Z","caller":"traceutil/trace.go:171","msg":"trace[593793280] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:8472; }","duration":"143.618393ms","start":"2026-04-07T01:41:52.961557Z","end":"2026-04-07T01:41:53.105176Z","steps":["trace[593793280] 'agreement among raft nodes before linearized reading' (duration: 143.45956ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:41:53.341931Z","caller":"traceutil/trace.go:171","msg":"trace[815717510] transaction","detail":"{read_only:false; response_revision:8475; number_of_response:1; }","duration":"110.866199ms","start":"2026-04-07T01:41:53.230615Z","end":"2026-04-07T01:41:53.341481Z","steps":["trace[815717510] 'process raft request' (duration: 63.70304ms)","trace[815717510] 'compare' (duration: 46.965824ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:42:06.028711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.158671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:42:06.028794Z","caller":"traceutil/trace.go:171","msg":"trace[1545735165] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8572; }","duration":"101.293423ms","start":"2026-04-07T01:42:05.927487Z","end":"2026-04-07T01:42:06.028781Z","steps":["trace[1545735165] 'range keys from in-memory index tree' (duration: 101.071348ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:42:43.628765Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002434.wal"} {"level":"info","ts":"2026-04-07T01:42:56.785385Z","caller":"traceutil/trace.go:171","msg":"trace[611051270] transaction","detail":"{read_only:false; response_revision:9145; number_of_response:1; }","duration":"171.888957ms","start":"2026-04-07T01:42:56.613469Z","end":"2026-04-07T01:42:56.785358Z","steps":["trace[611051270] 'process raft request' (duration: 171.732584ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:43:09.010579Z","caller":"traceutil/trace.go:171","msg":"trace[598112139] linearizableReadLoop","detail":"{readStateIndex:9539; appliedIndex:9538; }","duration":"114.371607ms","start":"2026-04-07T01:43:08.896181Z","end":"2026-04-07T01:43:09.010553Z","steps":["trace[598112139] 'read index received' (duration: 42.775861ms)","trace[598112139] 'applied index is now lower than readState.Index' (duration: 71.594666ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:43:09.010689Z","caller":"traceutil/trace.go:171","msg":"trace[1666974421] transaction","detail":"{read_only:false; response_revision:9215; number_of_response:1; }","duration":"120.743069ms","start":"2026-04-07T01:43:08.889913Z","end":"2026-04-07T01:43:09.010656Z","steps":["trace[1666974421] 'process raft request' (duration: 49.078332ms)","trace[1666974421] 'compare' (duration: 71.447193ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:43:09.010839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.635663ms","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-04-07T01:43:09.010939Z","caller":"traceutil/trace.go:171","msg":"trace[412712453] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9215; }","duration":"114.800506ms","start":"2026-04-07T01:43:08.89612Z","end":"2026-04-07T01:43:09.01092Z","steps":["trace[412712453] 'agreement among raft nodes before linearized reading' (duration: 114.563481ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:43:09.024328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.387191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-07T01:43:09.024507Z","caller":"traceutil/trace.go:171","msg":"trace[415776525] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9216; }","duration":"124.634987ms","start":"2026-04-07T01:43:08.899856Z","end":"2026-04-07T01:43:09.024491Z","steps":["trace[415776525] 'agreement among raft nodes before linearized reading' (duration: 124.297999ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:44:12.135223Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"572db18442eba1c2","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-07T01:44:12.142762Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-07T01:44:12.142852Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-07T01:46:35.777019Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8333} {"level":"info","ts":"2026-04-07T01:46:35.860167Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8333,"took":"80.707431ms","hash":78426149,"current-db-size-bytes":58667008,"current-db-size":"59 MB","current-db-size-in-use-bytes":24891392,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-07T01:46:35.860245Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":78426149,"revision":8333,"compact-revision":6160} {"level":"info","ts":"2026-04-07T01:51:35.783205Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10677} {"level":"info","ts":"2026-04-07T01:51:35.862089Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10677,"took":"76.25182ms","hash":1636143619,"current-db-size-bytes":58667008,"current-db-size":"59 MB","current-db-size-in-use-bytes":20299776,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-07T01:51:35.862139Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1636143619,"revision":10677,"compact-revision":8333}