{"level":"warn","ts":"2026-07-09T16:35:29.927872Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-09T16:35:29.927962Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.250:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.250:2380","--initial-cluster=instance=https://199.19.213.250:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.250:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.250: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-07-09T16:35:29.928027Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-09T16:35:29.928041Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.250:2380"]} {"level":"info","ts":"2026-07-09T16:35:29.928058Z","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-07-09T16:35:29.928681Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.250:2379"]} {"level":"info","ts":"2026-07-09T16:35:29.92875Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.250:2380"],"listen-peer-urls":["https://199.19.213.250:2380"],"advertise-client-urls":["https://199.19.213.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.250: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-07-09T16:35:29.933726Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.760154ms"} {"level":"info","ts":"2026-07-09T16:35:29.940888Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1918dd9317ae83a2","cluster-id":"1b9b645507bfe47a"} {"level":"info","ts":"2026-07-09T16:35:29.940966Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 switched to configuration voters=()"} {"level":"info","ts":"2026-07-09T16:35:29.940996Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 became follower at term 0"} {"level":"info","ts":"2026-07-09T16:35:29.941006Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1918dd9317ae83a2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-09T16:35:29.941018Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 became follower at term 1"} {"level":"info","ts":"2026-07-09T16:35:29.941054Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 switched to configuration voters=(1808438874216498082)"} {"level":"warn","ts":"2026-07-09T16:35:29.946448Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-09T16:35:29.948004Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-09T16:35:29.949041Z","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-07-09T16:35:29.950789Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1918dd9317ae83a2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-09T16:35:29.951555Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1918dd9317ae83a2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-09T16:35:29.95161Z","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-07-09T16:35:29.951782Z","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-07-09T16:35:29.954243Z","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-07-09T16:35:29.958289Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 switched to configuration voters=(1808438874216498082)"} {"level":"info","ts":"2026-07-09T16:35:29.958381Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"1b9b645507bfe47a","local-member-id":"1918dd9317ae83a2","added-peer-id":"1918dd9317ae83a2","added-peer-peer-urls":["https://199.19.213.250:2380"]} {"level":"info","ts":"2026-07-09T16:35:29.959206Z","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-07-09T16:35:29.959366Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1918dd9317ae83a2","initial-advertise-peer-urls":["https://199.19.213.250:2380"],"listen-peer-urls":["https://199.19.213.250:2380"],"advertise-client-urls":["https://199.19.213.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-09T16:35:29.959383Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-09T16:35:29.959351Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.250:2380"} {"level":"info","ts":"2026-07-09T16:35:29.95943Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.250:2380"} {"level":"info","ts":"2026-07-09T16:35:30.741538Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 is starting a new election at term 1"} {"level":"info","ts":"2026-07-09T16:35:30.741627Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-09T16:35:30.741685Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 received MsgPreVoteResp from 1918dd9317ae83a2 at term 1"} {"level":"info","ts":"2026-07-09T16:35:30.741711Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 became candidate at term 2"} {"level":"info","ts":"2026-07-09T16:35:30.741732Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 received MsgVoteResp from 1918dd9317ae83a2 at term 2"} {"level":"info","ts":"2026-07-09T16:35:30.74175Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 became leader at term 2"} {"level":"info","ts":"2026-07-09T16:35:30.741765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1918dd9317ae83a2 elected leader 1918dd9317ae83a2 at term 2"} {"level":"info","ts":"2026-07-09T16:35:30.743185Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T16:35:30.743806Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1918dd9317ae83a2","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.250:2379]}","request-path":"/0/members/1918dd9317ae83a2/attributes","cluster-id":"1b9b645507bfe47a","publish-timeout":"7s"} {"level":"info","ts":"2026-07-09T16:35:30.743832Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-09T16:35:30.743812Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-09T16:35:30.744407Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"1b9b645507bfe47a","local-member-id":"1918dd9317ae83a2","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T16:35:30.744507Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-09T16:35:30.744549Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-09T16:35:30.74467Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T16:35:30.744747Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T16:35:30.747726Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.250:2379"} {"level":"info","ts":"2026-07-09T16:35:30.748221Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-09T16:36:07.291761Z","caller":"traceutil/trace.go:171","msg":"trace[2140448372] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"199.818493ms","start":"2026-07-09T16:36:07.091919Z","end":"2026-07-09T16:36:07.291737Z","steps":["trace[2140448372] 'process raft request' (duration: 194.630598ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:36:07.292437Z","caller":"traceutil/trace.go:171","msg":"trace[502582471] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"156.659936ms","start":"2026-07-09T16:36:07.135758Z","end":"2026-07-09T16:36:07.292418Z","steps":["trace[502582471] 'process raft request' (duration: 156.397768ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:36:07.292426Z","caller":"traceutil/trace.go:171","msg":"trace[889241532] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"200.272746ms","start":"2026-07-09T16:36:07.092127Z","end":"2026-07-09T16:36:07.2924Z","steps":["trace[889241532] 'process raft request' (duration: 199.927485ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:36:13.4853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.515755ms","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-07-09T16:36:13.485473Z","caller":"traceutil/trace.go:171","msg":"trace[202454] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:635; }","duration":"165.747851ms","start":"2026-07-09T16:36:13.319702Z","end":"2026-07-09T16:36:13.48545Z","steps":["trace[202454] 'range keys from in-memory index tree' (duration: 165.230387ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:36:14.102015Z","caller":"traceutil/trace.go:171","msg":"trace[1300471868] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:657; }","duration":"377.470731ms","start":"2026-07-09T16:36:13.724512Z","end":"2026-07-09T16:36:14.101983Z","steps":["trace[1300471868] 'read index received' (duration: 196.920033ms)","trace[1300471868] 'applied index is now lower than readState.Index' (duration: 180.549078ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T16:36:14.102558Z","caller":"traceutil/trace.go:171","msg":"trace[1405405082] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"430.333344ms","start":"2026-07-09T16:36:13.672176Z","end":"2026-07-09T16:36:14.102509Z","steps":["trace[1405405082] 'process raft request' (duration: 429.18692ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:36:14.102653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.11731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-vxt2f\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-09T16:36:14.102724Z","caller":"traceutil/trace.go:171","msg":"trace[2088335767] range","detail":"{range_begin:/registry/pods/kube-system/cilium-vxt2f; range_end:; response_count:1; response_revision:637; }","duration":"378.251803ms","start":"2026-07-09T16:36:13.724456Z","end":"2026-07-09T16:36:14.102708Z","steps":["trace[2088335767] 'agreement among raft nodes before linearized reading' (duration: 378.046157ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:36:14.102775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:36:13.72443Z","time spent":"378.333416ms","remote":"127.0.0.1:58682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-vxt2f\" "} {"level":"warn","ts":"2026-07-09T16:36:14.10378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:36:13.672151Z","time spent":"430.821758ms","remote":"127.0.0.1:58572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T16:36:14.10563Z","caller":"traceutil/trace.go:171","msg":"trace[1501789526] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"182.567297ms","start":"2026-07-09T16:36:13.923007Z","end":"2026-07-09T16:36:14.105575Z","steps":["trace[1501789526] 'process raft request' (duration: 182.246248ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:37:19.261309Z","caller":"traceutil/trace.go:171","msg":"trace[29228175] transaction","detail":"{read_only:false; response_revision:1456; number_of_response:1; }","duration":"103.003789ms","start":"2026-07-09T16:37:19.158272Z","end":"2026-07-09T16:37:19.261275Z","steps":["trace[29228175] 'process raft request' (duration: 102.794962ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:37:43.467047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.004062ms","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-07-09T16:37:43.467136Z","caller":"traceutil/trace.go:171","msg":"trace[113220555] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1854; }","duration":"377.145138ms","start":"2026-07-09T16:37:43.08997Z","end":"2026-07-09T16:37:43.467115Z","steps":["trace[113220555] 'range keys from in-memory index tree' (duration: 376.841417ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:37:43.467196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:37:43.08995Z","time spent":"377.230251ms","remote":"127.0.0.1:58776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-09T16:37:43.467435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.650911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-64c9584d-da60-4246-922a-a0ea43ab1b1f\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-07-09T16:37:43.467553Z","caller":"traceutil/trace.go:171","msg":"trace[1626080881] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-64c9584d-da60-4246-922a-a0ea43ab1b1f; range_end:; response_count:1; response_revision:1854; }","duration":"271.92899ms","start":"2026-07-09T16:37:43.195598Z","end":"2026-07-09T16:37:43.467527Z","steps":["trace[1626080881] 'range keys from in-memory index tree' (duration: 271.365831ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:37:43.467753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.2052ms","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-07-09T16:37:43.467823Z","caller":"traceutil/trace.go:171","msg":"trace[1044076712] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1854; }","duration":"375.304893ms","start":"2026-07-09T16:37:43.092501Z","end":"2026-07-09T16:37:43.467806Z","steps":["trace[1044076712] 'range keys from in-memory index tree' (duration: 375.057065ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:37:43.46794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:37:43.092484Z","time spent":"375.371276ms","remote":"127.0.0.1:58776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-09T16:37:43.477973Z","caller":"traceutil/trace.go:171","msg":"trace[796535205] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"140.160278ms","start":"2026-07-09T16:37:43.337788Z","end":"2026-07-09T16:37:43.477949Z","steps":["trace[796535205] 'process raft request' (duration: 139.952051ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:37:43.618435Z","caller":"traceutil/trace.go:171","msg":"trace[1496222296] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"144.917556ms","start":"2026-07-09T16:37:43.473477Z","end":"2026-07-09T16:37:43.618395Z","steps":["trace[1496222296] 'process raft request' (duration: 139.132511ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:37:43.61862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.247672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-64c9584d-da60-4246-922a-a0ea43ab1b1f\" ","response":"range_response_count:1 size:3744"} {"level":"info","ts":"2026-07-09T16:37:43.618732Z","caller":"traceutil/trace.go:171","msg":"trace[1054659221] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-64c9584d-da60-4246-922a-a0ea43ab1b1f; range_end:; response_count:1; response_revision:1858; }","duration":"142.457929ms","start":"2026-07-09T16:37:43.476261Z","end":"2026-07-09T16:37:43.618719Z","steps":["trace[1054659221] 'agreement among raft nodes before linearized reading' (duration: 142.239462ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:37:43.618829Z","caller":"traceutil/trace.go:171","msg":"trace[498164709] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"143.765426ms","start":"2026-07-09T16:37:43.475036Z","end":"2026-07-09T16:37:43.618802Z","steps":["trace[498164709] 'process raft request' (duration: 143.257767ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:37:43.61906Z","caller":"traceutil/trace.go:171","msg":"trace[1968689534] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"142.689137ms","start":"2026-07-09T16:37:43.47636Z","end":"2026-07-09T16:37:43.619049Z","steps":["trace[1968689534] 'process raft request' (duration: 142.004523ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:37:43.618453Z","caller":"traceutil/trace.go:171","msg":"trace[1536814832] linearizableReadLoop","detail":"{readStateIndex:1923; appliedIndex:1920; }","duration":"140.518891ms","start":"2026-07-09T16:37:43.477915Z","end":"2026-07-09T16:37:43.618434Z","steps":["trace[1536814832] 'read index received' (duration: 134.706936ms)","trace[1536814832] 'applied index is now lower than readState.Index' (duration: 5.810725ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T16:37:43.625432Z","caller":"traceutil/trace.go:171","msg":"trace[774760243] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"144.026235ms","start":"2026-07-09T16:37:43.481378Z","end":"2026-07-09T16:37:43.625404Z","steps":["trace[774760243] 'process raft request' (duration: 143.865169ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:37:43.981115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.282015ms","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-07-09T16:37:43.981215Z","caller":"traceutil/trace.go:171","msg":"trace[1809250259] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1860; }","duration":"125.43962ms","start":"2026-07-09T16:37:43.855756Z","end":"2026-07-09T16:37:43.981196Z","steps":["trace[1809250259] 'range keys from in-memory index tree' (duration: 125.057406ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:38:16.220378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.18856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T16:38:16.220489Z","caller":"traceutil/trace.go:171","msg":"trace[66674779] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:2088; }","duration":"331.314615ms","start":"2026-07-09T16:38:15.889157Z","end":"2026-07-09T16:38:16.220472Z","steps":["trace[66674779] 'count revisions from in-memory index tree' (duration: 331.044305ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:38:16.220537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:38:15.889035Z","time spent":"331.487921ms","remote":"127.0.0.1:57946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"warn","ts":"2026-07-09T16:38:16.220537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.403219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T16:38:16.220615Z","caller":"traceutil/trace.go:171","msg":"trace[1815175840] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:2088; }","duration":"308.498312ms","start":"2026-07-09T16:38:15.912101Z","end":"2026-07-09T16:38:16.220599Z","steps":["trace[1815175840] 'count revisions from in-memory index tree' (duration: 308.313896ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:38:16.220661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:38:15.912049Z","time spent":"308.594595ms","remote":"127.0.0.1:58610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":27,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"warn","ts":"2026-07-09T16:38:16.221001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.19877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-09T16:38:16.221038Z","caller":"traceutil/trace.go:171","msg":"trace[2118548815] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2088; }","duration":"451.271982ms","start":"2026-07-09T16:38:15.769756Z","end":"2026-07-09T16:38:16.221028Z","steps":["trace[2118548815] 'range keys from in-memory index tree' (duration: 451.010612ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:38:16.221053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.853482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-09T16:38:16.221065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:38:15.769732Z","time spent":"451.326474ms","remote":"127.0.0.1:58776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-09T16:38:16.221101Z","caller":"traceutil/trace.go:171","msg":"trace[957841318] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:2088; }","duration":"235.953975ms","start":"2026-07-09T16:38:15.985134Z","end":"2026-07-09T16:38:16.221088Z","steps":["trace[957841318] 'count revisions from in-memory index tree' (duration: 235.750538ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:38:16.22125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.53975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-09T16:38:16.221259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.813424ms","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-07-09T16:38:16.221278Z","caller":"traceutil/trace.go:171","msg":"trace[1731552395] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:2088; }","duration":"220.619053ms","start":"2026-07-09T16:38:16.00065Z","end":"2026-07-09T16:38:16.221269Z","steps":["trace[1731552395] 'count revisions from in-memory index tree' (duration: 220.448967ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:38:16.221292Z","caller":"traceutil/trace.go:171","msg":"trace[177202214] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2088; }","duration":"448.897747ms","start":"2026-07-09T16:38:15.772383Z","end":"2026-07-09T16:38:16.221281Z","steps":["trace[177202214] 'range keys from in-memory index tree' (duration: 448.67816ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:38:16.224073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:38:15.772352Z","time spent":"451.705169ms","remote":"127.0.0.1:58776","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-07-09T16:38:16.221358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.659834ms","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-07-09T16:38:16.224352Z","caller":"traceutil/trace.go:171","msg":"trace[494307574] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2088; }","duration":"447.666593ms","start":"2026-07-09T16:38:15.776673Z","end":"2026-07-09T16:38:16.22434Z","steps":["trace[494307574] 'range keys from in-memory index tree' (duration: 444.56753ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:38:16.22447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:38:15.776658Z","time spent":"447.801257ms","remote":"127.0.0.1:58776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-09T16:38:16.221548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.133391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T16:38:16.224639Z","caller":"traceutil/trace.go:171","msg":"trace[1299800147] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:2088; }","duration":"420.254174ms","start":"2026-07-09T16:38:15.804374Z","end":"2026-07-09T16:38:16.224628Z","steps":["trace[1299800147] 'count revisions from in-memory index tree' (duration: 417.056988ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:38:16.224691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:38:15.804361Z","time spent":"420.316346ms","remote":"127.0.0.1:38148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"warn","ts":"2026-07-09T16:38:16.221767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.525888ms","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-07-09T16:38:16.224872Z","caller":"traceutil/trace.go:171","msg":"trace[162987842] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2088; }","duration":"371.654821ms","start":"2026-07-09T16:38:15.8532Z","end":"2026-07-09T16:38:16.224855Z","steps":["trace[162987842] 'range keys from in-memory index tree' (duration: 368.374773ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:38:16.226867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:38:15.853183Z","time spent":"373.673025ms","remote":"127.0.0.1:52352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5466,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-07-09T16:38:16.459412Z","caller":"traceutil/trace.go:171","msg":"trace[822827625] transaction","detail":"{read_only:false; response_revision:2090; number_of_response:1; }","duration":"230.589053ms","start":"2026-07-09T16:38:16.228772Z","end":"2026-07-09T16:38:16.459361Z","steps":["trace[822827625] 'process raft request' (duration: 164.5726ms)","trace[822827625] 'compare' (duration: 65.741072ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T16:38:16.460183Z","caller":"traceutil/trace.go:171","msg":"trace[263531024] transaction","detail":"{read_only:false; response_revision:2091; number_of_response:1; }","duration":"231.35681ms","start":"2026-07-09T16:38:16.228787Z","end":"2026-07-09T16:38:16.460144Z","steps":["trace[263531024] 'process raft request' (duration: 230.51123ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:38:16.460602Z","caller":"traceutil/trace.go:171","msg":"trace[39658705] transaction","detail":"{read_only:false; response_revision:2092; number_of_response:1; }","duration":"231.63035ms","start":"2026-07-09T16:38:16.228961Z","end":"2026-07-09T16:38:16.460592Z","steps":["trace[39658705] 'process raft request' (duration: 231.450314ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:38:16.460933Z","caller":"traceutil/trace.go:171","msg":"trace[77800063] transaction","detail":"{read_only:false; response_revision:2095; number_of_response:1; }","duration":"229.172862ms","start":"2026-07-09T16:38:16.231751Z","end":"2026-07-09T16:38:16.460924Z","steps":["trace[77800063] 'process raft request' (duration: 229.12336ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:38:16.461021Z","caller":"traceutil/trace.go:171","msg":"trace[798533165] transaction","detail":"{read_only:false; response_revision:2094; number_of_response:1; }","duration":"229.41575ms","start":"2026-07-09T16:38:16.231599Z","end":"2026-07-09T16:38:16.461015Z","steps":["trace[798533165] 'process raft request' (duration: 229.231074ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:38:16.461103Z","caller":"traceutil/trace.go:171","msg":"trace[890548949] transaction","detail":"{read_only:false; response_revision:2093; number_of_response:1; }","duration":"231.320358ms","start":"2026-07-09T16:38:16.229748Z","end":"2026-07-09T16:38:16.461068Z","steps":["trace[890548949] 'process raft request' (duration: 230.758518ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:38:17.1756Z","caller":"traceutil/trace.go:171","msg":"trace[773426840] transaction","detail":"{read_only:false; response_revision:2097; number_of_response:1; }","duration":"187.599814ms","start":"2026-07-09T16:38:16.987974Z","end":"2026-07-09T16:38:17.175574Z","steps":["trace[773426840] 'process raft request' (duration: 187.370315ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:43:51.212727Z","caller":"traceutil/trace.go:171","msg":"trace[2114065395] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4601; }","duration":"109.266834ms","start":"2026-07-09T16:43:51.103443Z","end":"2026-07-09T16:43:51.212709Z","steps":["trace[2114065395] 'process raft request' (duration: 108.696767ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:44:00.562117Z","caller":"traceutil/trace.go:171","msg":"trace[584519297] transaction","detail":"{read_only:false; response_revision:4799; number_of_response:1; }","duration":"196.079088ms","start":"2026-07-09T16:44:00.366007Z","end":"2026-07-09T16:44:00.562086Z","steps":["trace[584519297] 'process raft request' (duration: 196.008756ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:44:00.56233Z","caller":"traceutil/trace.go:171","msg":"trace[1446559562] transaction","detail":"{read_only:false; response_revision:4797; number_of_response:1; }","duration":"285.49264ms","start":"2026-07-09T16:44:00.276795Z","end":"2026-07-09T16:44:00.562288Z","steps":["trace[1446559562] 'process raft request' (duration: 185.274113ms)","trace[1446559562] 'compare' (duration: 99.324951ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T16:44:00.562524Z","caller":"traceutil/trace.go:171","msg":"trace[440388740] transaction","detail":"{read_only:false; response_revision:4798; number_of_response:1; }","duration":"282.333818ms","start":"2026-07-09T16:44:00.280123Z","end":"2026-07-09T16:44:00.562457Z","steps":["trace[440388740] 'process raft request' (duration: 281.814093ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:44:00.562574Z","caller":"traceutil/trace.go:171","msg":"trace[205070719] linearizableReadLoop","detail":"{readStateIndex:4970; appliedIndex:4969; }","duration":"284.871963ms","start":"2026-07-09T16:44:00.27767Z","end":"2026-07-09T16:44:00.562542Z","steps":["trace[205070719] 'read index received' (duration: 184.404238ms)","trace[205070719] 'applied index is now lower than readState.Index' (duration: 100.465065ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T16:44:00.562821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.196172ms","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-07-09T16:44:00.562862Z","caller":"traceutil/trace.go:171","msg":"trace[233760798] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4799; }","duration":"285.409268ms","start":"2026-07-09T16:44:00.277441Z","end":"2026-07-09T16:44:00.56285Z","steps":["trace[233760798] 'agreement among raft nodes before linearized reading' (duration: 285.243853ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:44:00.562861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.034893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"warn","ts":"2026-07-09T16:44:00.56287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.212167ms","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-07-09T16:44:00.56293Z","caller":"traceutil/trace.go:171","msg":"trace[987148865] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4799; }","duration":"268.284839ms","start":"2026-07-09T16:44:00.294628Z","end":"2026-07-09T16:44:00.562913Z","steps":["trace[987148865] 'agreement among raft nodes before linearized reading' (duration: 268.096434ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:44:00.562946Z","caller":"traceutil/trace.go:171","msg":"trace[878296333] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4799; }","duration":"210.137407ms","start":"2026-07-09T16:44:00.352789Z","end":"2026-07-09T16:44:00.562926Z","steps":["trace[878296333] 'agreement among raft nodes before linearized reading' (duration: 209.962342ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:44:00.562949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.468184ms","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-07-09T16:44:00.563052Z","caller":"traceutil/trace.go:171","msg":"trace[285265440] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4799; }","duration":"247.596337ms","start":"2026-07-09T16:44:00.315433Z","end":"2026-07-09T16:44:00.563029Z","steps":["trace[285265440] 'agreement among raft nodes before linearized reading' (duration: 247.327719ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:44:00.563167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.840784ms","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-07-09T16:44:00.563247Z","caller":"traceutil/trace.go:171","msg":"trace[90935824] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4799; }","duration":"247.946758ms","start":"2026-07-09T16:44:00.315287Z","end":"2026-07-09T16:44:00.563233Z","steps":["trace[90935824] 'agreement among raft nodes before linearized reading' (duration: 247.760832ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:44:01.191246Z","caller":"traceutil/trace.go:171","msg":"trace[1449284807] transaction","detail":"{read_only:false; response_revision:4807; number_of_response:1; }","duration":"149.475634ms","start":"2026-07-09T16:44:01.041733Z","end":"2026-07-09T16:44:01.191209Z","steps":["trace[1449284807] 'process raft request' (duration: 149.234267ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:44:01.191571Z","caller":"traceutil/trace.go:171","msg":"trace[1990270263] transaction","detail":"{read_only:false; response_revision:4808; number_of_response:1; }","duration":"128.423192ms","start":"2026-07-09T16:44:01.063106Z","end":"2026-07-09T16:44:01.191529Z","steps":["trace[1990270263] 'process raft request' (duration: 128.02039ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:44:06.731323Z","caller":"traceutil/trace.go:171","msg":"trace[1064537653] transaction","detail":"{read_only:false; response_revision:4883; number_of_response:1; }","duration":"120.477666ms","start":"2026-07-09T16:44:06.610824Z","end":"2026-07-09T16:44:06.731302Z","steps":["trace[1064537653] 'process raft request' (duration: 60.4943ms)","trace[1064537653] 'compare' (duration: 59.701417ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T16:44:15.007917Z","caller":"traceutil/trace.go:171","msg":"trace[962155477] transaction","detail":"{read_only:false; response_revision:4989; number_of_response:1; }","duration":"196.962112ms","start":"2026-07-09T16:44:14.810923Z","end":"2026-07-09T16:44:15.007885Z","steps":["trace[962155477] 'process raft request' (duration: 148.620408ms)","trace[962155477] 'compare' (duration: 48.035305ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T16:44:15.150877Z","caller":"traceutil/trace.go:171","msg":"trace[49623311] linearizableReadLoop","detail":"{readStateIndex:5170; appliedIndex:5168; }","duration":"110.27466ms","start":"2026-07-09T16:44:15.040579Z","end":"2026-07-09T16:44:15.150853Z","steps":["trace[49623311] 'read index received' (duration: 110.058274ms)","trace[49623311] 'applied index is now lower than readState.Index' (duration: 215.006µs)"],"step_count":2} {"level":"info","ts":"2026-07-09T16:44:15.151168Z","caller":"traceutil/trace.go:171","msg":"trace[1254600935] transaction","detail":"{read_only:false; response_revision:4990; number_of_response:1; }","duration":"339.865924ms","start":"2026-07-09T16:44:14.811263Z","end":"2026-07-09T16:44:15.151129Z","steps":["trace[1254600935] 'process raft request' (duration: 339.404231ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:44:15.15135Z","caller":"traceutil/trace.go:171","msg":"trace[1112604798] transaction","detail":"{read_only:false; response_revision:4991; number_of_response:1; }","duration":"339.593206ms","start":"2026-07-09T16:44:14.81173Z","end":"2026-07-09T16:44:15.151323Z","steps":["trace[1112604798] 'process raft request' (duration: 339.072161ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T16:44:15.151387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:44:14.811243Z","time spent":"339.971417ms","remote":"127.0.0.1:58776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T16:44:15.151504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T16:44:14.811722Z","time spent":"339.695459ms","remote":"127.0.0.1:58776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T16:44:15.151756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.180748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-09T16:44:15.151805Z","caller":"traceutil/trace.go:171","msg":"trace[391972071] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:4991; }","duration":"111.27206ms","start":"2026-07-09T16:44:15.040521Z","end":"2026-07-09T16:44:15.151793Z","steps":["trace[391972071] 'agreement among raft nodes before linearized reading' (duration: 110.428035ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:44:15.330789Z","caller":"traceutil/trace.go:171","msg":"trace[75323708] transaction","detail":"{read_only:false; response_revision:4993; number_of_response:1; }","duration":"100.180823ms","start":"2026-07-09T16:44:15.230577Z","end":"2026-07-09T16:44:15.330757Z","steps":["trace[75323708] 'process raft request' (duration: 19.925007ms)","trace[75323708] 'compare' (duration: 80.108421ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T16:44:15.355661Z","caller":"traceutil/trace.go:171","msg":"trace[277142788] transaction","detail":"{read_only:false; response_revision:4994; number_of_response:1; }","duration":"124.609933ms","start":"2026-07-09T16:44:15.231026Z","end":"2026-07-09T16:44:15.355636Z","steps":["trace[277142788] 'process raft request' (duration: 124.417377ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:44:15.356099Z","caller":"traceutil/trace.go:171","msg":"trace[1993807606] transaction","detail":"{read_only:false; response_revision:4995; number_of_response:1; }","duration":"124.8661ms","start":"2026-07-09T16:44:15.231127Z","end":"2026-07-09T16:44:15.355993Z","steps":["trace[1993807606] 'process raft request' (duration: 124.453318ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:44:15.356129Z","caller":"traceutil/trace.go:171","msg":"trace[882399546] transaction","detail":"{read_only:false; response_revision:4997; number_of_response:1; }","duration":"112.612491ms","start":"2026-07-09T16:44:15.243493Z","end":"2026-07-09T16:44:15.356106Z","steps":["trace[882399546] 'process raft request' (duration: 112.550648ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:44:15.356129Z","caller":"traceutil/trace.go:171","msg":"trace[1136694484] transaction","detail":"{read_only:false; response_revision:4996; number_of_response:1; }","duration":"124.854271ms","start":"2026-07-09T16:44:15.231262Z","end":"2026-07-09T16:44:15.356116Z","steps":["trace[1136694484] 'process raft request' (duration: 124.645604ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:45:30.775739Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2912} {"level":"info","ts":"2026-07-09T16:45:30.846425Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2912,"took":"69.159151ms","hash":3034700792,"current-db-size-bytes":53571584,"current-db-size":"54 MB","current-db-size-in-use-bytes":29634560,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-07-09T16:45:30.846482Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3034700792,"revision":2912,"compact-revision":-1} {"level":"info","ts":"2026-07-09T16:48:13.830215Z","caller":"traceutil/trace.go:171","msg":"trace[1982772247] transaction","detail":"{read_only:false; response_revision:6732; number_of_response:1; }","duration":"101.924016ms","start":"2026-07-09T16:48:13.728259Z","end":"2026-07-09T16:48:13.830183Z","steps":["trace[1982772247] 'process raft request' (duration: 101.520228ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T16:48:16.247781Z","caller":"traceutil/trace.go:171","msg":"trace[751990454] transaction","detail":"{read_only:false; response_revision:6745; number_of_response:1; }","duration":"103.825616ms","start":"2026-07-09T16:48:16.143938Z","end":"2026-07-09T16:48:16.247764Z","steps":["trace[751990454] 'process raft request' (duration: 68.542708ms)","trace[751990454] 'compare' (duration: 34.395583ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T16:50:30.78226Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5600} {"level":"info","ts":"2026-07-09T16:50:30.857561Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5600,"took":"73.619173ms","hash":3364133392,"current-db-size-bytes":53571584,"current-db-size":"54 MB","current-db-size-in-use-bytes":18587648,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-07-09T16:50:30.857655Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3364133392,"revision":5600,"compact-revision":2912}