{"level":"warn","ts":"2026-04-08T22:57:26.963984Z","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-08T22:57:26.964108Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.246: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.246:2380","--initial-cluster=instance=https://199.204.45.246:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.246:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.246: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-08T22:57:26.964273Z","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-08T22:57:26.964292Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.246:2380"]} {"level":"info","ts":"2026-04-08T22:57:26.964356Z","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-08T22:57:26.965364Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.246:2379"]} {"level":"info","ts":"2026-04-08T22:57:26.965547Z","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.246:2380"],"listen-peer-urls":["https://199.204.45.246:2380"],"advertise-client-urls":["https://199.204.45.246:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.246:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.246: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-08T22:57:26.97017Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.271707ms"} {"level":"info","ts":"2026-04-08T22:57:26.976148Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ab97322ebdd79664","cluster-id":"87bc89380c3dc2c"} {"level":"info","ts":"2026-04-08T22:57:26.976231Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 switched to configuration voters=()"} {"level":"info","ts":"2026-04-08T22:57:26.97628Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became follower at term 0"} {"level":"info","ts":"2026-04-08T22:57:26.976302Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ab97322ebdd79664 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-08T22:57:26.976312Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became follower at term 1"} {"level":"info","ts":"2026-04-08T22:57:26.976377Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 switched to configuration voters=(12364406478303893092)"} {"level":"warn","ts":"2026-04-08T22:57:26.987639Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-08T22:57:26.989614Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-08T22:57:26.99087Z","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-08T22:57:26.99365Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ab97322ebdd79664","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-08T22:57:26.993914Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ab97322ebdd79664","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-08T22:57:26.99412Z","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-08T22:57:26.994241Z","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-08T22:57:26.994506Z","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-08T22:57:26.995171Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 switched to configuration voters=(12364406478303893092)"} {"level":"info","ts":"2026-04-08T22:57:26.99539Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87bc89380c3dc2c","local-member-id":"ab97322ebdd79664","added-peer-id":"ab97322ebdd79664","added-peer-peer-urls":["https://199.204.45.246:2380"]} {"level":"info","ts":"2026-04-08T22:57:26.999088Z","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-08T22:57:26.999394Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.246:2380"} {"level":"info","ts":"2026-04-08T22:57:26.999477Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.246:2380"} {"level":"info","ts":"2026-04-08T22:57:26.99972Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ab97322ebdd79664","initial-advertise-peer-urls":["https://199.204.45.246:2380"],"listen-peer-urls":["https://199.204.45.246:2380"],"advertise-client-urls":["https://199.204.45.246:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.246:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-08T22:57:26.999795Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-08T22:57:27.578086Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 is starting a new election at term 1"} {"level":"info","ts":"2026-04-08T22:57:27.578164Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-08T22:57:27.57819Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 received MsgPreVoteResp from ab97322ebdd79664 at term 1"} {"level":"info","ts":"2026-04-08T22:57:27.578201Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became candidate at term 2"} {"level":"info","ts":"2026-04-08T22:57:27.578207Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 received MsgVoteResp from ab97322ebdd79664 at term 2"} {"level":"info","ts":"2026-04-08T22:57:27.578216Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became leader at term 2"} {"level":"info","ts":"2026-04-08T22:57:27.578223Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ab97322ebdd79664 elected leader ab97322ebdd79664 at term 2"} {"level":"info","ts":"2026-04-08T22:57:27.579875Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T22:57:27.581918Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ab97322ebdd79664","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.246:2379]}","request-path":"/0/members/ab97322ebdd79664/attributes","cluster-id":"87bc89380c3dc2c","publish-timeout":"7s"} {"level":"info","ts":"2026-04-08T22:57:27.581987Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T22:57:27.58208Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T22:57:27.582421Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-08T22:57:27.582452Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-08T22:57:27.583915Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87bc89380c3dc2c","local-member-id":"ab97322ebdd79664","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T22:57:27.583989Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T22:57:27.584012Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T22:57:27.585651Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-08T22:57:27.585799Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.246:2379"} {"level":"warn","ts":"2026-04-08T22:57:45.29496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.158641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-08T22:57:45.295065Z","caller":"traceutil/trace.go:171","msg":"trace[1491994697] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:409; }","duration":"141.324295ms","start":"2026-04-08T22:57:45.153714Z","end":"2026-04-08T22:57:45.295039Z","steps":["trace[1491994697] 'range keys from in-memory index tree' (duration: 140.916675ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:57:56.974775Z","caller":"traceutil/trace.go:171","msg":"trace[872100606] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"112.468101ms","start":"2026-04-08T22:57:56.862274Z","end":"2026-04-08T22:57:56.974742Z","steps":["trace[872100606] 'process raft request' (duration: 93.729141ms)","trace[872100606] 'compare' (duration: 18.541115ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:57:56.977487Z","caller":"traceutil/trace.go:171","msg":"trace[1241569424] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"111.155199ms","start":"2026-04-08T22:57:56.866294Z","end":"2026-04-08T22:57:56.97745Z","steps":["trace[1241569424] 'process raft request' (duration: 110.892293ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:57:56.977771Z","caller":"traceutil/trace.go:171","msg":"trace[181963896] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"107.820026ms","start":"2026-04-08T22:57:56.869907Z","end":"2026-04-08T22:57:56.977727Z","steps":["trace[181963896] 'process raft request' (duration: 107.667302ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:57:56.977755Z","caller":"traceutil/trace.go:171","msg":"trace[1407238085] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"109.409544ms","start":"2026-04-08T22:57:56.868293Z","end":"2026-04-08T22:57:56.977703Z","steps":["trace[1407238085] 'process raft request' (duration: 109.145938ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:57:56.977831Z","caller":"traceutil/trace.go:171","msg":"trace[2088165126] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"109.118178ms","start":"2026-04-08T22:57:56.868685Z","end":"2026-04-08T22:57:56.977803Z","steps":["trace[2088165126] 'process raft request' (duration: 108.81803ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:57:56.977906Z","caller":"traceutil/trace.go:171","msg":"trace[743956228] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"105.059106ms","start":"2026-04-08T22:57:56.872793Z","end":"2026-04-08T22:57:56.977852Z","steps":["trace[743956228] 'process raft request' (duration: 104.878722ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:57:56.977901Z","caller":"traceutil/trace.go:171","msg":"trace[1996895336] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"111.013276ms","start":"2026-04-08T22:57:56.866833Z","end":"2026-04-08T22:57:56.977846Z","steps":["trace[1996895336] 'process raft request' (duration: 110.528304ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:57:56.977973Z","caller":"traceutil/trace.go:171","msg":"trace[19643402] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"100.265906ms","start":"2026-04-08T22:57:56.877673Z","end":"2026-04-08T22:57:56.977939Z","steps":["trace[19643402] 'process raft request' (duration: 100.062671ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:57:56.977972Z","caller":"traceutil/trace.go:171","msg":"trace[29885087] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"105.342463ms","start":"2026-04-08T22:57:56.872399Z","end":"2026-04-08T22:57:56.977741Z","steps":["trace[29885087] 'process raft request' (duration: 105.232011ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:57:57.119268Z","caller":"traceutil/trace.go:171","msg":"trace[983269801] linearizableReadLoop","detail":"{readStateIndex:511; appliedIndex:510; }","duration":"125.486708ms","start":"2026-04-08T22:57:56.993758Z","end":"2026-04-08T22:57:57.119245Z","steps":["trace[983269801] 'read index received' (duration: 103.708901ms)","trace[983269801] 'applied index is now lower than readState.Index' (duration: 21.776747ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:57:57.119394Z","caller":"traceutil/trace.go:171","msg":"trace[372677602] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"126.76126ms","start":"2026-04-08T22:57:56.992619Z","end":"2026-04-08T22:57:57.11938Z","steps":["trace[372677602] 'process raft request' (duration: 104.770698ms)","trace[372677602] 'compare' (duration: 21.629413ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:57:57.119704Z","caller":"traceutil/trace.go:171","msg":"trace[1609989152] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"124.072582ms","start":"2026-04-08T22:57:56.995619Z","end":"2026-04-08T22:57:57.119692Z","steps":["trace[1609989152] 'process raft request' (duration: 123.567269ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:57:57.119791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.989721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:30408"} {"level":"info","ts":"2026-04-08T22:57:57.119882Z","caller":"traceutil/trace.go:171","msg":"trace[1577276339] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:495; }","duration":"126.132104ms","start":"2026-04-08T22:57:56.993724Z","end":"2026-04-08T22:57:57.119856Z","steps":["trace[1577276339] 'agreement among raft nodes before linearized reading' (duration: 125.780005ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:57:57.120019Z","caller":"traceutil/trace.go:171","msg":"trace[1411596355] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"116.537363ms","start":"2026-04-08T22:57:57.003387Z","end":"2026-04-08T22:57:57.119924Z","steps":["trace[1411596355] 'process raft request' (duration: 116.287596ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:57:57.120159Z","caller":"traceutil/trace.go:171","msg":"trace[264571394] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"105.827995ms","start":"2026-04-08T22:57:57.014318Z","end":"2026-04-08T22:57:57.120146Z","steps":["trace[264571394] 'process raft request' (duration: 105.669771ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:57:57.120114Z","caller":"traceutil/trace.go:171","msg":"trace[1621912732] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"111.481137ms","start":"2026-04-08T22:57:57.008608Z","end":"2026-04-08T22:57:57.120089Z","steps":["trace[1621912732] 'process raft request' (duration: 111.283871ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:58:03.381986Z","caller":"traceutil/trace.go:171","msg":"trace[2087349873] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"227.291462ms","start":"2026-04-08T22:58:03.154655Z","end":"2026-04-08T22:58:03.381947Z","steps":["trace[2087349873] 'process raft request' (duration: 221.21024ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:58:03.382014Z","caller":"traceutil/trace.go:171","msg":"trace[949148095] linearizableReadLoop","detail":"{readStateIndex:595; appliedIndex:594; }","duration":"167.491803ms","start":"2026-04-08T22:58:03.214433Z","end":"2026-04-08T22:58:03.381925Z","steps":["trace[949148095] 'read index received' (duration: 161.169234ms)","trace[949148095] 'applied index is now lower than readState.Index' (duration: 6.321469ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:58:03.382215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.762819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-08T22:58:03.382305Z","caller":"traceutil/trace.go:171","msg":"trace[1469779559] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:577; }","duration":"167.897913ms","start":"2026-04-08T22:58:03.214387Z","end":"2026-04-08T22:58:03.382285Z","steps":["trace[1469779559] 'agreement among raft nodes before linearized reading' (duration: 167.673477ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:58:03.59329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.562091ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T22:58:03.593398Z","caller":"traceutil/trace.go:171","msg":"trace[1008260360] linearizableReadLoop","detail":"{readStateIndex:596; appliedIndex:595; }","duration":"183.981205ms","start":"2026-04-08T22:58:03.409401Z","end":"2026-04-08T22:58:03.593382Z","steps":["trace[1008260360] 'read index received' (duration: 44.541µs)","trace[1008260360] 'applied index is now lower than readState.Index' (duration: 183.935454ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:58:03.593469Z","caller":"traceutil/trace.go:171","msg":"trace[1570547351] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"207.160527ms","start":"2026-04-08T22:58:03.386298Z","end":"2026-04-08T22:58:03.593458Z","steps":["trace[1570547351] 'process raft request' (duration: 19.881879ms)","trace[1570547351] 'compare' (duration: 186.432907ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:58:03.593712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.282013ms","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-08T22:58:03.593788Z","caller":"traceutil/trace.go:171","msg":"trace[969606273] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:578; }","duration":"184.405156ms","start":"2026-04-08T22:58:03.409365Z","end":"2026-04-08T22:58:03.59377Z","steps":["trace[969606273] 'agreement among raft nodes before linearized reading' (duration: 184.17516ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:58:03.636288Z","caller":"traceutil/trace.go:171","msg":"trace[1585703671] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"196.296315ms","start":"2026-04-08T22:58:03.439968Z","end":"2026-04-08T22:58:03.636264Z","steps":["trace[1585703671] 'process raft request' (duration: 196.176912ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:58:03.636664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.693681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-ffddq\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-08T22:58:03.636742Z","caller":"traceutil/trace.go:171","msg":"trace[1625441834] range","detail":"{range_begin:/registry/pods/kube-system/cilium-ffddq; range_end:; response_count:1; response_revision:579; }","duration":"209.811024ms","start":"2026-04-08T22:58:03.42691Z","end":"2026-04-08T22:58:03.636721Z","steps":["trace[1625441834] 'agreement among raft nodes before linearized reading' (duration: 209.524397ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:58:03.637065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.152083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:58:03.637197Z","caller":"traceutil/trace.go:171","msg":"trace[1346408124] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:579; }","duration":"110.308346ms","start":"2026-04-08T22:58:03.526833Z","end":"2026-04-08T22:58:03.637142Z","steps":["trace[1346408124] 'agreement among raft nodes before linearized reading' (duration: 110.106361ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:58:04.189241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:58:03.697688Z","time spent":"491.543385ms","remote":"127.0.0.1:46156","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-08T22:58:04.189547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.452951ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T22:58:04.189632Z","caller":"traceutil/trace.go:171","msg":"trace[1710639238] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"535.57876ms","start":"2026-04-08T22:58:03.654037Z","end":"2026-04-08T22:58:04.189615Z","steps":["trace[1710639238] 'process raft request' (duration: 314.979747ms)","trace[1710639238] 'compare' (duration: 220.350987ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:58:04.189686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:58:03.653986Z","time spent":"535.673853ms","remote":"127.0.0.1:37848","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-08T22:58:04.196425Z","caller":"traceutil/trace.go:171","msg":"trace[658684823] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"146.207746ms","start":"2026-04-08T22:58:04.050193Z","end":"2026-04-08T22:58:04.196401Z","steps":["trace[658684823] 'process raft request' (duration: 145.731293ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:58:19.72848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.206817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-fsfp2\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-04-08T22:58:19.728565Z","caller":"traceutil/trace.go:171","msg":"trace[350538696] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-fsfp2; range_end:; response_count:1; response_revision:740; }","duration":"202.32911ms","start":"2026-04-08T22:58:19.526216Z","end":"2026-04-08T22:58:19.728545Z","steps":["trace[350538696] 'range keys from in-memory index tree' (duration: 202.047033ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:58:19.728556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.026863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-08T22:58:19.728638Z","caller":"traceutil/trace.go:171","msg":"trace[193088442] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:740; }","duration":"266.130776ms","start":"2026-04-08T22:58:19.462489Z","end":"2026-04-08T22:58:19.72862Z","steps":["trace[193088442] 'range keys from in-memory index tree' (duration: 265.790798ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:59:19.713429Z","caller":"traceutil/trace.go:171","msg":"trace[492303904] transaction","detail":"{read_only:false; response_revision:1605; number_of_response:1; }","duration":"112.802136ms","start":"2026-04-08T22:59:19.600598Z","end":"2026-04-08T22:59:19.7134Z","steps":["trace[492303904] 'process raft request' (duration: 112.638183ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:59:31.422168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.243698ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T22:59:31.422274Z","caller":"traceutil/trace.go:171","msg":"trace[662900632] linearizableReadLoop","detail":"{readStateIndex:1847; appliedIndex:1846; }","duration":"200.406157ms","start":"2026-04-08T22:59:31.221852Z","end":"2026-04-08T22:59:31.422259Z","steps":["trace[662900632] 'read index received' (duration: 43.761µs)","trace[662900632] 'applied index is now lower than readState.Index' (duration: 200.361246ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:59:31.422355Z","caller":"traceutil/trace.go:171","msg":"trace[2109499516] transaction","detail":"{read_only:false; response_revision:1782; number_of_response:1; }","duration":"313.716814ms","start":"2026-04-08T22:59:31.108613Z","end":"2026-04-08T22:59:31.42233Z","steps":["trace[2109499516] 'process raft request' (duration: 107.23026ms)","trace[2109499516] 'compare' (duration: 206.127916ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:59:31.422473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:59:31.108586Z","time spent":"313.827237ms","remote":"127.0.0.1:37848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T22:59:31.422506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.655532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-08T22:59:31.422683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.93869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:59:31.422777Z","caller":"traceutil/trace.go:171","msg":"trace[933812829] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1782; }","duration":"200.746694ms","start":"2026-04-08T22:59:31.221797Z","end":"2026-04-08T22:59:31.422544Z","steps":["trace[933812829] 'agreement among raft nodes before linearized reading' (duration: 200.56141ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:59:31.422796Z","caller":"traceutil/trace.go:171","msg":"trace[1831902444] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1782; }","duration":"118.093474ms","start":"2026-04-08T22:59:31.304673Z","end":"2026-04-08T22:59:31.422766Z","steps":["trace[1831902444] 'agreement among raft nodes before linearized reading' (duration: 117.91815ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:00:16.397255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.857798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-04-08T23:00:16.397343Z","caller":"traceutil/trace.go:171","msg":"trace[1757758400] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2082; }","duration":"101.990761ms","start":"2026-04-08T23:00:16.295333Z","end":"2026-04-08T23:00:16.397324Z","steps":["trace[1757758400] 'range keys from in-memory index tree' (duration: 101.695863ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:00:16.515555Z","caller":"traceutil/trace.go:171","msg":"trace[2005423053] transaction","detail":"{read_only:false; response_revision:2083; number_of_response:1; }","duration":"113.585042ms","start":"2026-04-08T23:00:16.401935Z","end":"2026-04-08T23:00:16.51552Z","steps":["trace[2005423053] 'process raft request' (duration: 113.389057ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:00:16.517866Z","caller":"traceutil/trace.go:171","msg":"trace[43977481] transaction","detail":"{read_only:false; response_revision:2084; number_of_response:1; }","duration":"115.853307ms","start":"2026-04-08T23:00:16.401988Z","end":"2026-04-08T23:00:16.517841Z","steps":["trace[43977481] 'process raft request' (duration: 115.672193ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:00:16.518018Z","caller":"traceutil/trace.go:171","msg":"trace[232646281] transaction","detail":"{read_only:false; response_revision:2085; number_of_response:1; }","duration":"115.610911ms","start":"2026-04-08T23:00:16.402383Z","end":"2026-04-08T23:00:16.517993Z","steps":["trace[232646281] 'process raft request' (duration: 115.417006ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:01:11.238935Z","caller":"traceutil/trace.go:171","msg":"trace[128264842] transaction","detail":"{read_only:false; response_revision:2552; number_of_response:1; }","duration":"122.464568ms","start":"2026-04-08T23:01:11.116431Z","end":"2026-04-08T23:01:11.238896Z","steps":["trace[128264842] 'process raft request' (duration: 122.235243ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:01:45.108694Z","caller":"traceutil/trace.go:171","msg":"trace[914075193] transaction","detail":"{read_only:false; response_revision:2755; number_of_response:1; }","duration":"167.167293ms","start":"2026-04-08T23:01:44.941501Z","end":"2026-04-08T23:01:45.108668Z","steps":["trace[914075193] 'process raft request' (duration: 166.979998ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:01:45.118546Z","caller":"traceutil/trace.go:171","msg":"trace[685231624] linearizableReadLoop","detail":"{readStateIndex:2858; appliedIndex:2856; }","duration":"155.94374ms","start":"2026-04-08T23:01:44.962586Z","end":"2026-04-08T23:01:45.11853Z","steps":["trace[685231624] 'read index received' (duration: 146.632104ms)","trace[685231624] 'applied index is now lower than readState.Index' (duration: 9.311026ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T23:01:45.118677Z","caller":"traceutil/trace.go:171","msg":"trace[850605049] transaction","detail":"{read_only:false; response_revision:2757; number_of_response:1; }","duration":"176.56824ms","start":"2026-04-08T23:01:44.94208Z","end":"2026-04-08T23:01:45.118649Z","steps":["trace[850605049] 'process raft request' (duration: 176.417975ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:01:45.118791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.173346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-04-08T23:01:45.118901Z","caller":"traceutil/trace.go:171","msg":"trace[1247314863] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2757; }","duration":"156.299329ms","start":"2026-04-08T23:01:44.962534Z","end":"2026-04-08T23:01:45.118833Z","steps":["trace[1247314863] 'agreement among raft nodes before linearized reading' (duration: 156.064504ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:01:45.119193Z","caller":"traceutil/trace.go:171","msg":"trace[1993714031] transaction","detail":"{read_only:false; response_revision:2756; number_of_response:1; }","duration":"177.36502ms","start":"2026-04-08T23:01:44.941797Z","end":"2026-04-08T23:01:45.119162Z","steps":["trace[1993714031] 'process raft request' (duration: 176.619861ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:01:45.412727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.041575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T23:01:45.412818Z","caller":"traceutil/trace.go:171","msg":"trace[1548342148] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:2757; }","duration":"218.146118ms","start":"2026-04-08T23:01:45.194648Z","end":"2026-04-08T23:01:45.412794Z","steps":["trace[1548342148] 'count revisions from in-memory index tree' (duration: 217.956933ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:01:45.413163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.317209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T23:01:45.413521Z","caller":"traceutil/trace.go:171","msg":"trace[1885142681] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2757; }","duration":"109.705269ms","start":"2026-04-08T23:01:45.303802Z","end":"2026-04-08T23:01:45.413508Z","steps":["trace[1885142681] 'range keys from in-memory index tree' (duration: 109.217037ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:01:45.68735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.544444ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T23:01:45.687703Z","caller":"traceutil/trace.go:171","msg":"trace[528710533] transaction","detail":"{read_only:false; response_revision:2759; number_of_response:1; }","duration":"257.762158ms","start":"2026-04-08T23:01:45.429877Z","end":"2026-04-08T23:01:45.687639Z","steps":["trace[528710533] 'process raft request' (duration: 138.858335ms)","trace[528710533] 'compare' (duration: 118.271477ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T23:01:45.687857Z","caller":"traceutil/trace.go:171","msg":"trace[664403599] transaction","detail":"{read_only:false; response_revision:2760; number_of_response:1; }","duration":"136.5335ms","start":"2026-04-08T23:01:45.550977Z","end":"2026-04-08T23:01:45.68751Z","steps":["trace[664403599] 'process raft request' (duration: 136.475458ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:05:31.095553Z","caller":"traceutil/trace.go:171","msg":"trace[666714195] linearizableReadLoop","detail":"{readStateIndex:4914; appliedIndex:4913; }","duration":"128.192011ms","start":"2026-04-08T23:05:30.967327Z","end":"2026-04-08T23:05:31.095519Z","steps":["trace[666714195] 'read index received' (duration: 128.011806ms)","trace[666714195] 'applied index is now lower than readState.Index' (duration: 178.785µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T23:05:31.095647Z","caller":"traceutil/trace.go:171","msg":"trace[1811760536] transaction","detail":"{read_only:false; response_revision:4738; number_of_response:1; }","duration":"133.435319ms","start":"2026-04-08T23:05:30.962171Z","end":"2026-04-08T23:05:31.095606Z","steps":["trace[1811760536] 'process raft request' (duration: 133.138132ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:05:31.095851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.487418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-04-08T23:05:31.095897Z","caller":"traceutil/trace.go:171","msg":"trace[1529705693] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4738; }","duration":"128.574391ms","start":"2026-04-08T23:05:30.967312Z","end":"2026-04-08T23:05:31.095886Z","steps":["trace[1529705693] 'agreement among raft nodes before linearized reading' (duration: 128.372766ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:05:31.104035Z","caller":"traceutil/trace.go:171","msg":"trace[601216280] transaction","detail":"{read_only:false; response_revision:4739; number_of_response:1; }","duration":"134.71162ms","start":"2026-04-08T23:05:30.969297Z","end":"2026-04-08T23:05:31.104009Z","steps":["trace[601216280] 'process raft request' (duration: 134.509535ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:05:31.10435Z","caller":"traceutil/trace.go:171","msg":"trace[76794712] transaction","detail":"{read_only:false; response_revision:4744; number_of_response:1; }","duration":"134.420933ms","start":"2026-04-08T23:05:30.969918Z","end":"2026-04-08T23:05:31.104338Z","steps":["trace[76794712] 'process raft request' (duration: 134.117426ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:05:31.104445Z","caller":"traceutil/trace.go:171","msg":"trace[412367329] transaction","detail":"{read_only:false; response_revision:4740; number_of_response:1; }","duration":"135.039447ms","start":"2026-04-08T23:05:30.969396Z","end":"2026-04-08T23:05:31.104436Z","steps":["trace[412367329] 'process raft request' (duration: 134.528775ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:05:31.104489Z","caller":"traceutil/trace.go:171","msg":"trace[1957054792] transaction","detail":"{read_only:false; response_revision:4742; number_of_response:1; }","duration":"134.879824ms","start":"2026-04-08T23:05:30.969585Z","end":"2026-04-08T23:05:31.104465Z","steps":["trace[1957054792] 'process raft request' (duration: 134.396173ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:05:31.104636Z","caller":"traceutil/trace.go:171","msg":"trace[1510303675] transaction","detail":"{read_only:false; response_revision:4741; number_of_response:1; }","duration":"135.13687ms","start":"2026-04-08T23:05:30.969493Z","end":"2026-04-08T23:05:31.10463Z","steps":["trace[1510303675] 'process raft request' (duration: 134.462974ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:05:31.104527Z","caller":"traceutil/trace.go:171","msg":"trace[1745441087] transaction","detail":"{read_only:false; response_revision:4743; number_of_response:1; }","duration":"134.701499ms","start":"2026-04-08T23:05:30.969819Z","end":"2026-04-08T23:05:31.104521Z","steps":["trace[1745441087] 'process raft request' (duration: 134.187967ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:05:31.104763Z","caller":"traceutil/trace.go:171","msg":"trace[375054486] transaction","detail":"{read_only:false; response_revision:4745; number_of_response:1; }","duration":"124.975321ms","start":"2026-04-08T23:05:30.979781Z","end":"2026-04-08T23:05:31.104756Z","steps":["trace[375054486] 'process raft request' (duration: 124.284795ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:05:31.105048Z","caller":"traceutil/trace.go:171","msg":"trace[762158094] transaction","detail":"{read_only:false; response_revision:4746; number_of_response:1; }","duration":"103.454157ms","start":"2026-04-08T23:05:31.001587Z","end":"2026-04-08T23:05:31.105042Z","steps":["trace[762158094] 'process raft request' (duration: 102.538635ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:05:36.728295Z","caller":"traceutil/trace.go:171","msg":"trace[1661617923] transaction","detail":"{read_only:false; response_revision:4920; number_of_response:1; }","duration":"168.629308ms","start":"2026-04-08T23:05:36.559631Z","end":"2026-04-08T23:05:36.72826Z","steps":["trace[1661617923] 'process raft request' (duration: 168.414943ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:05:37.144962Z","caller":"traceutil/trace.go:171","msg":"trace[1007138306] transaction","detail":"{read_only:false; response_revision:4926; number_of_response:1; }","duration":"290.475715ms","start":"2026-04-08T23:05:36.854466Z","end":"2026-04-08T23:05:37.144942Z","steps":["trace[1007138306] 'process raft request' (duration: 290.319071ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:05:37.217945Z","caller":"traceutil/trace.go:171","msg":"trace[1545054097] transaction","detail":"{read_only:false; response_revision:4927; number_of_response:1; }","duration":"331.912165ms","start":"2026-04-08T23:05:36.885992Z","end":"2026-04-08T23:05:37.217904Z","steps":["trace[1545054097] 'process raft request' (duration: 306.003954ms)","trace[1545054097] 'compare' (duration: 25.626114ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T23:05:37.218103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:05:36.885963Z","time spent":"332.054118ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1813,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T23:05:46.490849Z","caller":"traceutil/trace.go:171","msg":"trace[1620567360] linearizableReadLoop","detail":"{readStateIndex:5306; appliedIndex:5305; }","duration":"190.364547ms","start":"2026-04-08T23:05:46.300458Z","end":"2026-04-08T23:05:46.490822Z","steps":["trace[1620567360] 'read index received' (duration: 189.498535ms)","trace[1620567360] 'applied index is now lower than readState.Index' (duration: 864.382µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T23:05:46.490855Z","caller":"traceutil/trace.go:171","msg":"trace[444684116] transaction","detail":"{read_only:false; response_revision:5117; number_of_response:1; }","duration":"195.306157ms","start":"2026-04-08T23:05:46.295523Z","end":"2026-04-08T23:05:46.490829Z","steps":["trace[444684116] 'process raft request' (duration: 194.418505ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:05:46.491045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.345439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T23:05:46.491132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.705933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-08T23:05:46.491162Z","caller":"traceutil/trace.go:171","msg":"trace[1616477827] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5117; }","duration":"109.810905ms","start":"2026-04-08T23:05:46.381344Z","end":"2026-04-08T23:05:46.491155Z","steps":["trace[1616477827] 'agreement among raft nodes before linearized reading' (duration: 109.628341ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:05:46.491171Z","caller":"traceutil/trace.go:171","msg":"trace[985494196] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5117; }","duration":"188.490592ms","start":"2026-04-08T23:05:46.302655Z","end":"2026-04-08T23:05:46.491146Z","steps":["trace[985494196] 'agreement among raft nodes before linearized reading' (duration: 188.319398ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:05:46.491253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.742946ms","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-08T23:05:46.491389Z","caller":"traceutil/trace.go:171","msg":"trace[1734695485] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5117; }","duration":"190.937251ms","start":"2026-04-08T23:05:46.300425Z","end":"2026-04-08T23:05:46.491362Z","steps":["trace[1734695485] 'agreement among raft nodes before linearized reading' (duration: 190.512921ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:05:46.491439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.042525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-gkpz4.18a484385746d9b0\" ","response":"range_response_count:1 size:906"} {"level":"info","ts":"2026-04-08T23:05:46.49159Z","caller":"traceutil/trace.go:171","msg":"trace[794375673] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-gkpz4.18a484385746d9b0; range_end:; response_count:1; response_revision:5117; }","duration":"150.273151ms","start":"2026-04-08T23:05:46.341279Z","end":"2026-04-08T23:05:46.491552Z","steps":["trace[794375673] 'agreement among raft nodes before linearized reading' (duration: 149.763948ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:05:54.204084Z","caller":"traceutil/trace.go:171","msg":"trace[243256783] linearizableReadLoop","detail":"{readStateIndex:5479; appliedIndex:5478; }","duration":"234.159175ms","start":"2026-04-08T23:05:53.969905Z","end":"2026-04-08T23:05:54.204064Z","steps":["trace[243256783] 'read index received' (duration: 233.942609ms)","trace[243256783] 'applied index is now lower than readState.Index' (duration: 215.576µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T23:05:54.204189Z","caller":"traceutil/trace.go:171","msg":"trace[666706616] transaction","detail":"{read_only:false; response_revision:5287; number_of_response:1; }","duration":"332.371747ms","start":"2026-04-08T23:05:53.871794Z","end":"2026-04-08T23:05:54.204166Z","steps":["trace[666706616] 'process raft request' (duration: 332.125551ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:05:54.204318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:05:53.871774Z","time spent":"332.466329ms","remote":"127.0.0.1:37756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3745,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T23:05:54.204296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.37481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4e95228f-2e6d-45b8-8591-f34657c4b25d\" ","response":"range_response_count:1 size:3760"} {"level":"info","ts":"2026-04-08T23:05:54.204522Z","caller":"traceutil/trace.go:171","msg":"trace[1451694577] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4e95228f-2e6d-45b8-8591-f34657c4b25d; range_end:; response_count:1; response_revision:5287; }","duration":"234.611675ms","start":"2026-04-08T23:05:53.969857Z","end":"2026-04-08T23:05:54.204469Z","steps":["trace[1451694577] 'agreement among raft nodes before linearized reading' (duration: 234.328989ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:05:54.456536Z","caller":"traceutil/trace.go:171","msg":"trace[1638824753] transaction","detail":"{read_only:false; response_revision:5288; number_of_response:1; }","duration":"188.379648ms","start":"2026-04-08T23:05:54.268114Z","end":"2026-04-08T23:05:54.456493Z","steps":["trace[1638824753] 'process raft request' (duration: 89.691315ms)","trace[1638824753] 'compare' (duration: 98.5353ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T23:07:27.610641Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2991} {"level":"info","ts":"2026-04-08T23:07:27.678935Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2991,"took":"66.539459ms","hash":1953326057,"current-db-size-bytes":57692160,"current-db-size":"58 MB","current-db-size-in-use-bytes":34078720,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-08T23:07:27.679005Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1953326057,"revision":2991,"compact-revision":-1} {"level":"info","ts":"2026-04-08T23:11:48.974356Z","caller":"traceutil/trace.go:171","msg":"trace[1186569352] linearizableReadLoop","detail":"{readStateIndex:8337; appliedIndex:8336; }","duration":"185.206473ms","start":"2026-04-08T23:11:48.789119Z","end":"2026-04-08T23:11:48.974326Z","steps":["trace[1186569352] 'read index received' (duration: 184.884965ms)","trace[1186569352] 'applied index is now lower than readState.Index' (duration: 320.038µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T23:11:48.974456Z","caller":"traceutil/trace.go:171","msg":"trace[30770956] transaction","detail":"{read_only:false; response_revision:8061; number_of_response:1; }","duration":"314.5307ms","start":"2026-04-08T23:11:48.65989Z","end":"2026-04-08T23:11:48.974421Z","steps":["trace[30770956] 'process raft request' (duration: 314.228243ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:11:48.974584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.448398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-04-08T23:11:48.974615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:11:48.659859Z","time spent":"314.673124ms","remote":"127.0.0.1:37848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T23:11:48.974632Z","caller":"traceutil/trace.go:171","msg":"trace[582261134] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8061; }","duration":"185.565122ms","start":"2026-04-08T23:11:48.789054Z","end":"2026-04-08T23:11:48.974619Z","steps":["trace[582261134] 'agreement among raft nodes before linearized reading' (duration: 185.388828ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:11:49.213191Z","caller":"traceutil/trace.go:171","msg":"trace[981708999] linearizableReadLoop","detail":"{readStateIndex:8338; appliedIndex:8337; }","duration":"223.258283ms","start":"2026-04-08T23:11:48.989902Z","end":"2026-04-08T23:11:49.21316Z","steps":["trace[981708999] 'read index received' (duration: 223.047187ms)","trace[981708999] 'applied index is now lower than readState.Index' (duration: 210.156µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T23:11:49.213295Z","caller":"traceutil/trace.go:171","msg":"trace[1758086874] transaction","detail":"{read_only:false; response_revision:8062; number_of_response:1; }","duration":"233.731958ms","start":"2026-04-08T23:11:48.979532Z","end":"2026-04-08T23:11:49.213264Z","steps":["trace[1758086874] 'process raft request' (duration: 233.44838ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:11:49.213395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.467238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T23:11:49.21344Z","caller":"traceutil/trace.go:171","msg":"trace[1136846995] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:8062; }","duration":"223.562599ms","start":"2026-04-08T23:11:48.989863Z","end":"2026-04-08T23:11:49.213426Z","steps":["trace[1136846995] 'agreement among raft nodes before linearized reading' (duration: 223.435916ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:12:01.465747Z","caller":"traceutil/trace.go:171","msg":"trace[924260232] linearizableReadLoop","detail":"{readStateIndex:8405; appliedIndex:8404; }","duration":"162.461687ms","start":"2026-04-08T23:12:01.303271Z","end":"2026-04-08T23:12:01.465732Z","steps":["trace[924260232] 'read index received' (duration: 162.311394ms)","trace[924260232] 'applied index is now lower than readState.Index' (duration: 149.843µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T23:12:01.465819Z","caller":"traceutil/trace.go:171","msg":"trace[1911887707] transaction","detail":"{read_only:false; response_revision:8126; number_of_response:1; }","duration":"197.78863ms","start":"2026-04-08T23:12:01.268008Z","end":"2026-04-08T23:12:01.465797Z","steps":["trace[1911887707] 'process raft request' (duration: 197.620476ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:12:01.465851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.574891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T23:12:01.465872Z","caller":"traceutil/trace.go:171","msg":"trace[1818361706] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8126; }","duration":"162.641241ms","start":"2026-04-08T23:12:01.303224Z","end":"2026-04-08T23:12:01.465865Z","steps":["trace[1818361706] 'agreement among raft nodes before linearized reading' (duration: 162.58841ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:12:02.051777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.503537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T23:12:02.051844Z","caller":"traceutil/trace.go:171","msg":"trace[505117621] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:8129; }","duration":"146.63092ms","start":"2026-04-08T23:12:01.9052Z","end":"2026-04-08T23:12:02.051831Z","steps":["trace[505117621] 'count revisions from in-memory index tree' (duration: 146.374274ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:12:03.69981Z","caller":"traceutil/trace.go:171","msg":"trace[197705955] transaction","detail":"{read_only:false; response_revision:8137; number_of_response:1; }","duration":"165.281956ms","start":"2026-04-08T23:12:03.534502Z","end":"2026-04-08T23:12:03.699784Z","steps":["trace[197705955] 'process raft request' (duration: 165.125613ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:12:27.397945Z","caller":"traceutil/trace.go:171","msg":"trace[1968398294] transaction","detail":"{read_only:false; response_revision:8318; number_of_response:1; }","duration":"144.431637ms","start":"2026-04-08T23:12:27.253489Z","end":"2026-04-08T23:12:27.39792Z","steps":["trace[1968398294] 'process raft request' (duration: 144.027317ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:12:27.619023Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6126} {"level":"info","ts":"2026-04-08T23:12:27.771935Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6126,"took":"150.590218ms","hash":3572789983,"current-db-size-bytes":57692160,"current-db-size":"58 MB","current-db-size-in-use-bytes":23011328,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-08T23:12:27.772008Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3572789983,"revision":6126,"compact-revision":2991} {"level":"info","ts":"2026-04-08T23:12:30.612665Z","caller":"traceutil/trace.go:171","msg":"trace[1431693097] linearizableReadLoop","detail":"{readStateIndex:8625; appliedIndex:8624; }","duration":"175.151259ms","start":"2026-04-08T23:12:30.437492Z","end":"2026-04-08T23:12:30.612643Z","steps":["trace[1431693097] 'read index received' (duration: 174.972294ms)","trace[1431693097] 'applied index is now lower than readState.Index' (duration: 177.105µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T23:12:30.612756Z","caller":"traceutil/trace.go:171","msg":"trace[363211243] transaction","detail":"{read_only:false; response_revision:8337; number_of_response:1; }","duration":"181.78904ms","start":"2026-04-08T23:12:30.430912Z","end":"2026-04-08T23:12:30.612701Z","steps":["trace[363211243] 'process raft request' (duration: 181.541054ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:12:30.612909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.731082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.246\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-08T23:12:30.612955Z","caller":"traceutil/trace.go:171","msg":"trace[1692581398] range","detail":"{range_begin:/registry/masterleases/199.204.45.246; range_end:; response_count:1; response_revision:8337; }","duration":"105.863106ms","start":"2026-04-08T23:12:30.507081Z","end":"2026-04-08T23:12:30.612944Z","steps":["trace[1692581398] 'agreement among raft nodes before linearized reading' (duration: 105.719792ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:12:30.613026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.440635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-04-08T23:12:30.613117Z","caller":"traceutil/trace.go:171","msg":"trace[1062471161] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:8337; }","duration":"175.63288ms","start":"2026-04-08T23:12:30.437453Z","end":"2026-04-08T23:12:30.613086Z","steps":["trace[1062471161] 'agreement among raft nodes before linearized reading' (duration: 175.296342ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:12:30.867908Z","caller":"traceutil/trace.go:171","msg":"trace[913139646] transaction","detail":"{read_only:false; response_revision:8338; number_of_response:1; }","duration":"250.149729ms","start":"2026-04-08T23:12:30.617727Z","end":"2026-04-08T23:12:30.867877Z","steps":["trace[913139646] 'process raft request' (duration: 249.880882ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:12:30.868289Z","caller":"traceutil/trace.go:171","msg":"trace[1157482579] transaction","detail":"{read_only:false; response_revision:8339; number_of_response:1; }","duration":"250.520838ms","start":"2026-04-08T23:12:30.617731Z","end":"2026-04-08T23:12:30.868252Z","steps":["trace[1157482579] 'process raft request' (duration: 250.096388ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:12:30.86835Z","caller":"traceutil/trace.go:171","msg":"trace[1527581285] transaction","detail":"{read_only:false; response_revision:8340; number_of_response:1; }","duration":"250.574099ms","start":"2026-04-08T23:12:30.617755Z","end":"2026-04-08T23:12:30.868329Z","steps":["trace[1527581285] 'process raft request' (duration: 250.374464ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:12:30.868471Z","caller":"traceutil/trace.go:171","msg":"trace[744535242] linearizableReadLoop","detail":"{readStateIndex:8629; appliedIndex:8626; }","duration":"239.839148ms","start":"2026-04-08T23:12:30.628546Z","end":"2026-04-08T23:12:30.868385Z","steps":["trace[744535242] 'read index received' (duration: 238.981187ms)","trace[744535242] 'applied index is now lower than readState.Index' (duration: 857.061µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T23:12:30.868634Z","caller":"traceutil/trace.go:171","msg":"trace[755361055] transaction","detail":"{read_only:false; response_revision:8341; number_of_response:1; }","duration":"229.232509ms","start":"2026-04-08T23:12:30.639362Z","end":"2026-04-08T23:12:30.868594Z","steps":["trace[755361055] 'process raft request' (duration: 228.957162ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:12:30.869004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.972784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228554"} {"level":"info","ts":"2026-04-08T23:12:30.869112Z","caller":"traceutil/trace.go:171","msg":"trace[483632230] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8341; }","duration":"252.096997ms","start":"2026-04-08T23:12:30.616993Z","end":"2026-04-08T23:12:30.86909Z","steps":["trace[483632230] 'agreement among raft nodes before linearized reading' (duration: 251.514693ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:12:31.966482Z","caller":"traceutil/trace.go:171","msg":"trace[104787473] transaction","detail":"{read_only:false; response_revision:8346; number_of_response:1; }","duration":"109.900443ms","start":"2026-04-08T23:12:31.856546Z","end":"2026-04-08T23:12:31.966447Z","steps":["trace[104787473] 'process raft request' (duration: 109.649557ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:12:43.19799Z","caller":"traceutil/trace.go:171","msg":"trace[873584929] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8447; }","duration":"168.72154ms","start":"2026-04-08T23:12:43.029229Z","end":"2026-04-08T23:12:43.197951Z","steps":["trace[873584929] 'process raft request' (duration: 112.861976ms)","trace[873584929] 'compare' (duration: 55.67133ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T23:12:43.295044Z","caller":"traceutil/trace.go:171","msg":"trace[808224388] transaction","detail":"{read_only:false; response_revision:8448; number_of_response:1; }","duration":"264.336305ms","start":"2026-04-08T23:12:43.030688Z","end":"2026-04-08T23:12:43.295024Z","steps":["trace[808224388] 'process raft request' (duration: 264.11672ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:12:43.295371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.627068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T23:12:43.295486Z","caller":"traceutil/trace.go:171","msg":"trace[297783016] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:8448; }","duration":"220.766382ms","start":"2026-04-08T23:12:43.07469Z","end":"2026-04-08T23:12:43.295457Z","steps":["trace[297783016] 'agreement among raft nodes before linearized reading' (duration: 220.490935ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:12:43.295984Z","caller":"traceutil/trace.go:171","msg":"trace[806579365] linearizableReadLoop","detail":"{readStateIndex:8742; appliedIndex:8740; }","duration":"220.28067ms","start":"2026-04-08T23:12:43.074699Z","end":"2026-04-08T23:12:43.294979Z","steps":["trace[806579365] 'read index received' (duration: 67.408096ms)","trace[806579365] 'applied index is now lower than readState.Index' (duration: 152.870914ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T23:12:43.854519Z","caller":"traceutil/trace.go:171","msg":"trace[1919285566] linearizableReadLoop","detail":"{readStateIndex:8745; appliedIndex:8744; }","duration":"111.681857ms","start":"2026-04-08T23:12:43.74281Z","end":"2026-04-08T23:12:43.854492Z","steps":["trace[1919285566] 'read index received' (duration: 111.432181ms)","trace[1919285566] 'applied index is now lower than readState.Index' (duration: 248.496µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T23:12:43.854656Z","caller":"traceutil/trace.go:171","msg":"trace[449153594] transaction","detail":"{read_only:false; response_revision:8451; number_of_response:1; }","duration":"123.815474ms","start":"2026-04-08T23:12:43.730809Z","end":"2026-04-08T23:12:43.854625Z","steps":["trace[449153594] 'process raft request' (duration: 123.507326ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:12:43.854756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.932553ms","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-08T23:12:43.855798Z","caller":"traceutil/trace.go:171","msg":"trace[1617960317] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8451; }","duration":"113.04029ms","start":"2026-04-08T23:12:43.742738Z","end":"2026-04-08T23:12:43.855778Z","steps":["trace[1617960317] 'agreement among raft nodes before linearized reading' (duration: 111.872782ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:12:44.008135Z","caller":"traceutil/trace.go:171","msg":"trace[1630960148] transaction","detail":"{read_only:false; response_revision:8452; number_of_response:1; }","duration":"147.674496ms","start":"2026-04-08T23:12:43.860433Z","end":"2026-04-08T23:12:44.008107Z","steps":["trace[1630960148] 'process raft request' (duration: 139.877496ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:12:44.12646Z","caller":"traceutil/trace.go:171","msg":"trace[1172826653] linearizableReadLoop","detail":"{readStateIndex:8748; appliedIndex:8746; }","duration":"105.077457ms","start":"2026-04-08T23:12:44.021358Z","end":"2026-04-08T23:12:44.126435Z","steps":["trace[1172826653] 'read index received' (duration: 39.067214ms)","trace[1172826653] 'applied index is now lower than readState.Index' (duration: 66.009113ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T23:12:44.126612Z","caller":"traceutil/trace.go:171","msg":"trace[1356995348] transaction","detail":"{read_only:false; response_revision:8454; number_of_response:1; }","duration":"115.768728ms","start":"2026-04-08T23:12:44.010825Z","end":"2026-04-08T23:12:44.126594Z","steps":["trace[1356995348] 'process raft request' (duration: 97.322307ms)","trace[1356995348] 'compare' (duration: 18.192795ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T23:12:44.126884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.506367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-04-08T23:12:44.12693Z","caller":"traceutil/trace.go:171","msg":"trace[1657694252] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8454; }","duration":"105.61362ms","start":"2026-04-08T23:12:44.021303Z","end":"2026-04-08T23:12:44.126917Z","steps":["trace[1657694252] 'agreement among raft nodes before linearized reading' (duration: 105.440965ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:12:44.811779Z","caller":"traceutil/trace.go:171","msg":"trace[68671753] transaction","detail":"{read_only:false; response_revision:8459; number_of_response:1; }","duration":"233.220695ms","start":"2026-04-08T23:12:44.57853Z","end":"2026-04-08T23:12:44.81175Z","steps":["trace[68671753] 'process raft request' (duration: 233.00834ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:12:44.836667Z","caller":"traceutil/trace.go:171","msg":"trace[2036378822] transaction","detail":"{read_only:false; response_revision:8460; number_of_response:1; }","duration":"175.463675ms","start":"2026-04-08T23:12:44.661175Z","end":"2026-04-08T23:12:44.836639Z","steps":["trace[2036378822] 'process raft request' (duration: 175.343892ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:12:45.176126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.317416ms","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-08T23:12:45.176246Z","caller":"traceutil/trace.go:171","msg":"trace[609524886] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8460; }","duration":"226.47202ms","start":"2026-04-08T23:12:44.949744Z","end":"2026-04-08T23:12:45.176216Z","steps":["trace[609524886] 'range keys from in-memory index tree' (duration: 226.100281ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:12:45.176259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.237879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-08T23:12:45.176901Z","caller":"traceutil/trace.go:171","msg":"trace[351123601] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8460; }","duration":"227.932927ms","start":"2026-04-08T23:12:44.948942Z","end":"2026-04-08T23:12:45.176875Z","steps":["trace[351123601] 'range keys from in-memory index tree' (duration: 226.803359ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:12:45.176257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.402647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-z2pb9\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-08T23:12:45.177007Z","caller":"traceutil/trace.go:171","msg":"trace[483376586] range","detail":"{range_begin:/registry/pods/openstack/keepalived-z2pb9; range_end:; response_count:1; response_revision:8460; }","duration":"222.201107ms","start":"2026-04-08T23:12:44.95478Z","end":"2026-04-08T23:12:45.176981Z","steps":["trace[483376586] 'range keys from in-memory index tree' (duration: 221.0914ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:12:45.177179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.608288ms","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-08T23:12:45.177325Z","caller":"traceutil/trace.go:171","msg":"trace[1588162515] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8460; }","duration":"227.849025ms","start":"2026-04-08T23:12:44.949444Z","end":"2026-04-08T23:12:45.177293Z","steps":["trace[1588162515] 'range keys from in-memory index tree' (duration: 226.367728ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:12:45.300917Z","caller":"traceutil/trace.go:171","msg":"trace[2055994325] transaction","detail":"{read_only:false; response_revision:8462; number_of_response:1; }","duration":"118.151556ms","start":"2026-04-08T23:12:45.182731Z","end":"2026-04-08T23:12:45.300882Z","steps":["trace[2055994325] 'process raft request' (duration: 103.140349ms)","trace[2055994325] 'compare' (duration: 14.74866ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T23:12:45.301205Z","caller":"traceutil/trace.go:171","msg":"trace[1492238770] transaction","detail":"{read_only:false; response_revision:8463; number_of_response:1; }","duration":"118.167216ms","start":"2026-04-08T23:12:45.183005Z","end":"2026-04-08T23:12:45.301172Z","steps":["trace[1492238770] 'process raft request' (duration: 117.822587ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:12:57.506711Z","caller":"traceutil/trace.go:171","msg":"trace[655275058] transaction","detail":"{read_only:false; response_revision:8566; number_of_response:1; }","duration":"111.060502ms","start":"2026-04-08T23:12:57.395609Z","end":"2026-04-08T23:12:57.50667Z","steps":["trace[655275058] 'process raft request' (duration: 109.973306ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:13:32.192616Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002419.wal"} {"level":"warn","ts":"2026-04-08T23:13:55.891841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.04355ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-08T23:13:55.892269Z","caller":"traceutil/trace.go:171","msg":"trace[22921635] transaction","detail":"{read_only:false; response_revision:9182; number_of_response:1; }","duration":"161.925466ms","start":"2026-04-08T23:13:55.730307Z","end":"2026-04-08T23:13:55.892232Z","steps":["trace[22921635] 'process raft request' (duration: 161.659759ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:15:06.754109Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"ab97322ebdd79664","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-08T23:15:06.760556Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-08T23:15:06.760692Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-08T23:17:27.63002Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8319} {"level":"info","ts":"2026-04-08T23:17:27.710993Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8319,"took":"78.838692ms","hash":776698219,"current-db-size-bytes":57692160,"current-db-size":"58 MB","current-db-size-in-use-bytes":24952832,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-08T23:17:27.711067Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":776698219,"revision":8319,"compact-revision":6126} {"level":"info","ts":"2026-04-08T23:22:27.636114Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10671} {"level":"info","ts":"2026-04-08T23:22:27.719035Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10671,"took":"81.221081ms","hash":3457754552,"current-db-size-bytes":57692160,"current-db-size":"58 MB","current-db-size-in-use-bytes":20340736,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-08T23:22:27.719141Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3457754552,"revision":10671,"compact-revision":8319}