{"level":"warn","ts":"2026-06-15T15:41:53.886687Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-15T15:41:53.886767Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.162: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.162:2380","--initial-cluster=instance=https://199.204.45.162:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.162:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.162: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-06-15T15:41:53.886833Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-15T15:41:53.886841Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.162:2380"]} {"level":"info","ts":"2026-06-15T15:41:53.886861Z","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-06-15T15:41:53.887501Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"]} {"level":"info","ts":"2026-06-15T15:41:53.887606Z","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.204.45.162:2380"],"listen-peer-urls":["https://199.204.45.162:2380"],"advertise-client-urls":["https://199.204.45.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.162: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-06-15T15:41:53.891824Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.990264ms"} {"level":"info","ts":"2026-06-15T15:41:53.901604Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2d372260bb4c37a","cluster-id":"52bb6ec15e8722ff"} {"level":"info","ts":"2026-06-15T15:41:53.901735Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=()"} {"level":"info","ts":"2026-06-15T15:41:53.901841Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became follower at term 0"} {"level":"info","ts":"2026-06-15T15:41:53.901884Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2d372260bb4c37a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-15T15:41:53.901933Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became follower at term 1"} {"level":"info","ts":"2026-06-15T15:41:53.902025Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=(203631915892523898)"} {"level":"warn","ts":"2026-06-15T15:41:53.910114Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-15T15:41:53.911538Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-15T15:41:53.916295Z","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-06-15T15:41:53.918072Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2d372260bb4c37a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-15T15:41:53.918617Z","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-06-15T15:41:53.918699Z","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-06-15T15:41:53.918718Z","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-06-15T15:41:53.919358Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2d372260bb4c37a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-15T15:41:53.920288Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=(203631915892523898)"} {"level":"info","ts":"2026-06-15T15:41:53.921198Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"52bb6ec15e8722ff","local-member-id":"2d372260bb4c37a","added-peer-id":"2d372260bb4c37a","added-peer-peer-urls":["https://199.204.45.162:2380"]} {"level":"info","ts":"2026-06-15T15:41:53.922045Z","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-06-15T15:41:53.922258Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2d372260bb4c37a","initial-advertise-peer-urls":["https://199.204.45.162:2380"],"listen-peer-urls":["https://199.204.45.162:2380"],"advertise-client-urls":["https://199.204.45.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-15T15:41:53.922291Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-15T15:41:53.922798Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.162:2380"} {"level":"info","ts":"2026-06-15T15:41:53.92281Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.162:2380"} {"level":"info","ts":"2026-06-15T15:41:54.504512Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a is starting a new election at term 1"} {"level":"info","ts":"2026-06-15T15:41:54.504569Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became pre-candidate at term 1"} {"level":"info","ts":"2026-06-15T15:41:54.504585Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a received MsgPreVoteResp from 2d372260bb4c37a at term 1"} {"level":"info","ts":"2026-06-15T15:41:54.504596Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became candidate at term 2"} {"level":"info","ts":"2026-06-15T15:41:54.504601Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a received MsgVoteResp from 2d372260bb4c37a at term 2"} {"level":"info","ts":"2026-06-15T15:41:54.504609Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became leader at term 2"} {"level":"info","ts":"2026-06-15T15:41:54.504616Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2d372260bb4c37a elected leader 2d372260bb4c37a at term 2"} {"level":"info","ts":"2026-06-15T15:41:54.520693Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T15:41:54.522148Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2d372260bb4c37a","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.162:2379]}","request-path":"/0/members/2d372260bb4c37a/attributes","cluster-id":"52bb6ec15e8722ff","publish-timeout":"7s"} {"level":"info","ts":"2026-06-15T15:41:54.522159Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-15T15:41:54.522239Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-15T15:41:54.522486Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-15T15:41:54.522527Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-15T15:41:54.522864Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"52bb6ec15e8722ff","local-member-id":"2d372260bb4c37a","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T15:41:54.52308Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T15:41:54.523122Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T15:41:54.525982Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-15T15:41:54.530948Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.162:2379"} {"level":"info","ts":"2026-06-15T15:42:22.225377Z","caller":"traceutil/trace.go:171","msg":"trace[1967308711] linearizableReadLoop","detail":"{readStateIndex:485; appliedIndex:484; }","duration":"152.062952ms","start":"2026-06-15T15:42:22.073292Z","end":"2026-06-15T15:42:22.225355Z","steps":["trace[1967308711] 'read index received' (duration: 151.880941ms)","trace[1967308711] 'applied index is now lower than readState.Index' (duration: 181.131µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:42:22.225453Z","caller":"traceutil/trace.go:171","msg":"trace[2114853163] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"261.383271ms","start":"2026-06-15T15:42:21.964025Z","end":"2026-06-15T15:42:22.225409Z","steps":["trace[2114853163] 'process raft request' (duration: 261.195599ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:42:22.225568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.224053ms","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-06-15T15:42:22.225621Z","caller":"traceutil/trace.go:171","msg":"trace[355230683] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:470; }","duration":"152.354614ms","start":"2026-06-15T15:42:22.073255Z","end":"2026-06-15T15:42:22.225609Z","steps":["trace[355230683] 'agreement among raft nodes before linearized reading' (duration: 152.210213ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:42:25.249608Z","caller":"traceutil/trace.go:171","msg":"trace[1752360224] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"107.064652ms","start":"2026-06-15T15:42:25.142513Z","end":"2026-06-15T15:42:25.249578Z","steps":["trace[1752360224] 'process raft request' (duration: 106.920101ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:42:29.498319Z","caller":"traceutil/trace.go:171","msg":"trace[1962587969] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"233.510018ms","start":"2026-06-15T15:42:29.264783Z","end":"2026-06-15T15:42:29.498293Z","steps":["trace[1962587969] 'process raft request' (duration: 233.336506ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:42:29.52779Z","caller":"traceutil/trace.go:171","msg":"trace[1634488121] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"191.742112ms","start":"2026-06-15T15:42:29.336029Z","end":"2026-06-15T15:42:29.527771Z","steps":["trace[1634488121] 'process raft request' (duration: 191.52548ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:42:29.528109Z","caller":"traceutil/trace.go:171","msg":"trace[2093040555] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"187.555222ms","start":"2026-06-15T15:42:29.340539Z","end":"2026-06-15T15:42:29.528094Z","steps":["trace[2093040555] 'process raft request' (duration: 187.109877ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:42:29.528089Z","caller":"traceutil/trace.go:171","msg":"trace[490492631] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"179.442658ms","start":"2026-06-15T15:42:29.348619Z","end":"2026-06-15T15:42:29.528062Z","steps":["trace[490492631] 'process raft request' (duration: 179.261366ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:42:29.528086Z","caller":"traceutil/trace.go:171","msg":"trace[1286157293] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"181.377861ms","start":"2026-06-15T15:42:29.346668Z","end":"2026-06-15T15:42:29.528046Z","steps":["trace[1286157293] 'process raft request' (duration: 181.078078ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:42:29.528104Z","caller":"traceutil/trace.go:171","msg":"trace[933544046] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"181.37241ms","start":"2026-06-15T15:42:29.346704Z","end":"2026-06-15T15:42:29.528076Z","steps":["trace[933544046] 'process raft request' (duration: 181.098657ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:42:29.528276Z","caller":"traceutil/trace.go:171","msg":"trace[1907829190] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"170.542535ms","start":"2026-06-15T15:42:29.357719Z","end":"2026-06-15T15:42:29.528262Z","steps":["trace[1907829190] 'process raft request' (duration: 170.291182ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:42:29.528236Z","caller":"traceutil/trace.go:171","msg":"trace[2143214599] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"183.597968ms","start":"2026-06-15T15:42:29.34461Z","end":"2026-06-15T15:42:29.528208Z","steps":["trace[2143214599] 'process raft request' (duration: 183.084151ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:42:29.528165Z","caller":"traceutil/trace.go:171","msg":"trace[1615169610] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"175.805566ms","start":"2026-06-15T15:42:29.352355Z","end":"2026-06-15T15:42:29.528161Z","steps":["trace[1615169610] 'process raft request' (duration: 175.591293ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:42:29.528161Z","caller":"traceutil/trace.go:171","msg":"trace[723355317] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"176.15923ms","start":"2026-06-15T15:42:29.351993Z","end":"2026-06-15T15:42:29.528152Z","steps":["trace[723355317] 'process raft request' (duration: 175.920937ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:42:29.528919Z","caller":"traceutil/trace.go:171","msg":"trace[1024630018] linearizableReadLoop","detail":"{readStateIndex:550; appliedIndex:538; }","duration":"119.104776ms","start":"2026-06-15T15:42:29.409798Z","end":"2026-06-15T15:42:29.528903Z","steps":["trace[1024630018] 'read index received' (duration: 88.735503ms)","trace[1024630018] 'applied index is now lower than readState.Index' (duration: 30.368443ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T15:42:29.528996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.182457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:42:29.529027Z","caller":"traceutil/trace.go:171","msg":"trace[1785497282] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:533; }","duration":"119.243618ms","start":"2026-06-15T15:42:29.409775Z","end":"2026-06-15T15:42:29.529019Z","steps":["trace[1785497282] 'agreement among raft nodes before linearized reading' (duration: 119.182917ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:42:29.529116Z","caller":"traceutil/trace.go:171","msg":"trace[679950193] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"132.762116ms","start":"2026-06-15T15:42:29.396346Z","end":"2026-06-15T15:42:29.529108Z","steps":["trace[679950193] 'process raft request' (duration: 132.388112ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:42:29.529138Z","caller":"traceutil/trace.go:171","msg":"trace[1911115788] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"162.153608ms","start":"2026-06-15T15:42:29.366968Z","end":"2026-06-15T15:42:29.529121Z","steps":["trace[1911115788] 'process raft request' (duration: 161.245518ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:42:29.529173Z","caller":"traceutil/trace.go:171","msg":"trace[1667587220] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"122.174801ms","start":"2026-06-15T15:42:29.406988Z","end":"2026-06-15T15:42:29.529163Z","steps":["trace[1667587220] 'process raft request' (duration: 121.821997ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:42:31.098636Z","caller":"traceutil/trace.go:171","msg":"trace[1021902339] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"440.928223ms","start":"2026-06-15T15:42:30.657641Z","end":"2026-06-15T15:42:31.098569Z","steps":["trace[1021902339] 'process raft request' (duration: 440.399997ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:42:31.099415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:42:30.657607Z","time spent":"441.129856ms","remote":"127.0.0.1:53674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208461,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T15:42:31.108994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.000764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:80703"} {"level":"info","ts":"2026-06-15T15:42:31.109046Z","caller":"traceutil/trace.go:171","msg":"trace[121264355] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:598; }","duration":"438.101874ms","start":"2026-06-15T15:42:30.670936Z","end":"2026-06-15T15:42:31.109037Z","steps":["trace[121264355] 'agreement among raft nodes before linearized reading' (duration: 437.931282ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:42:31.109146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:42:30.670914Z","time spent":"438.151005ms","remote":"127.0.0.1:53674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":1,"response size":80725,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io\" "} {"level":"info","ts":"2026-06-15T15:42:31.109224Z","caller":"traceutil/trace.go:171","msg":"trace[1934216972] linearizableReadLoop","detail":"{readStateIndex:617; appliedIndex:615; }","duration":"437.84207ms","start":"2026-06-15T15:42:30.67098Z","end":"2026-06-15T15:42:31.108822Z","steps":["trace[1934216972] 'read index received' (duration: 426.867191ms)","trace[1934216972] 'applied index is now lower than readState.Index' (duration: 10.974089ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:42:31.110155Z","caller":"traceutil/trace.go:171","msg":"trace[992692937] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"444.640644ms","start":"2026-06-15T15:42:30.665489Z","end":"2026-06-15T15:42:31.11013Z","steps":["trace[992692937] 'process raft request' (duration: 439.837974ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:42:31.110275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:42:30.665466Z","time spent":"444.747495ms","remote":"127.0.0.1:53674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570090,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T15:42:32.539008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.716398ms","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-06-15T15:42:32.539078Z","caller":"traceutil/trace.go:171","msg":"trace[1696144745] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:603; }","duration":"109.820179ms","start":"2026-06-15T15:42:32.429243Z","end":"2026-06-15T15:42:32.539063Z","steps":["trace[1696144745] 'range keys from in-memory index tree' (duration: 109.591286ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:42:32.84052Z","caller":"traceutil/trace.go:171","msg":"trace[1921987051] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"112.979261ms","start":"2026-06-15T15:42:32.727518Z","end":"2026-06-15T15:42:32.840497Z","steps":["trace[1921987051] 'process raft request' (duration: 112.778768ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:42:32.972879Z","caller":"traceutil/trace.go:171","msg":"trace[271539652] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"127.905939ms","start":"2026-06-15T15:42:32.844951Z","end":"2026-06-15T15:42:32.972857Z","steps":["trace[271539652] 'process raft request' (duration: 127.835738ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:42:32.972902Z","caller":"traceutil/trace.go:171","msg":"trace[1559650666] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"128.87488ms","start":"2026-06-15T15:42:32.844Z","end":"2026-06-15T15:42:32.972875Z","steps":["trace[1559650666] 'process raft request' (duration: 50.215472ms)","trace[1559650666] 'compare' (duration: 78.390785ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:42:36.242925Z","caller":"traceutil/trace.go:171","msg":"trace[1477856471] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"132.474208ms","start":"2026-06-15T15:42:36.110425Z","end":"2026-06-15T15:42:36.242899Z","steps":["trace[1477856471] 'process raft request' (duration: 131.91322ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:42:36.469775Z","caller":"traceutil/trace.go:171","msg":"trace[1354106810] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:647; }","duration":"174.916862ms","start":"2026-06-15T15:42:36.294829Z","end":"2026-06-15T15:42:36.469745Z","steps":["trace[1354106810] 'read index received' (duration: 174.81177ms)","trace[1354106810] 'applied index is now lower than readState.Index' (duration: 103.662µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:42:36.469912Z","caller":"traceutil/trace.go:171","msg":"trace[443741582] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"210.100186ms","start":"2026-06-15T15:42:36.259776Z","end":"2026-06-15T15:42:36.469876Z","steps":["trace[443741582] 'process raft request' (duration: 209.814642ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:42:36.470565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.743265ms","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-06-15T15:42:36.470608Z","caller":"traceutil/trace.go:171","msg":"trace[1885963259] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:628; }","duration":"175.830266ms","start":"2026-06-15T15:42:36.294765Z","end":"2026-06-15T15:42:36.470595Z","steps":["trace[1885963259] 'agreement among raft nodes before linearized reading' (duration: 175.147245ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:42:36.479085Z","caller":"traceutil/trace.go:171","msg":"trace[1777930412] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"177.474682ms","start":"2026-06-15T15:42:36.301587Z","end":"2026-06-15T15:42:36.479062Z","steps":["trace[1777930412] 'process raft request' (duration: 177.244718ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:42:36.479315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.977525ms","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-06-15T15:42:36.479397Z","caller":"traceutil/trace.go:171","msg":"trace[1718900783] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:629; }","duration":"183.093486ms","start":"2026-06-15T15:42:36.296291Z","end":"2026-06-15T15:42:36.479385Z","steps":["trace[1718900783] 'agreement among raft nodes before linearized reading' (duration: 182.69068ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:42:37.247027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"650.085471ms","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-06-15T15:42:37.24711Z","caller":"traceutil/trace.go:171","msg":"trace[67871758] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:631; }","duration":"650.230684ms","start":"2026-06-15T15:42:36.596858Z","end":"2026-06-15T15:42:37.247088Z","steps":["trace[67871758] 'range keys from in-memory index tree' (duration: 649.923319ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:42:37.247154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:42:36.596838Z","time spent":"650.307676ms","remote":"127.0.0.1:53884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-15T15:42:37.247742Z","caller":"traceutil/trace.go:171","msg":"trace[847455613] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"431.69452ms","start":"2026-06-15T15:42:36.816015Z","end":"2026-06-15T15:42:37.247709Z","steps":["trace[847455613] 'process raft request' (duration: 400.438341ms)","trace[847455613] 'compare' (duration: 30.248273ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T15:42:37.247899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:42:36.815999Z","time spent":"431.827762ms","remote":"127.0.0.1:53884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T15:42:37.248134Z","caller":"traceutil/trace.go:171","msg":"trace[1531333635] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"355.886211ms","start":"2026-06-15T15:42:36.892225Z","end":"2026-06-15T15:42:37.248112Z","steps":["trace[1531333635] 'process raft request' (duration: 355.12417ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:42:37.249923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:42:36.892201Z","time spent":"355.990122ms","remote":"127.0.0.1:53720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T15:42:53.89328Z","caller":"traceutil/trace.go:171","msg":"trace[635996780] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"246.325814ms","start":"2026-06-15T15:42:53.646926Z","end":"2026-06-15T15:42:53.893252Z","steps":["trace[635996780] 'process raft request' (duration: 246.17447ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:43:21.587731Z","caller":"traceutil/trace.go:171","msg":"trace[1781502640] linearizableReadLoop","detail":"{readStateIndex:1233; appliedIndex:1232; }","duration":"111.686768ms","start":"2026-06-15T15:43:21.476002Z","end":"2026-06-15T15:43:21.587689Z","steps":["trace[1781502640] 'read index received' (duration: 111.41226ms)","trace[1781502640] 'applied index is now lower than readState.Index' (duration: 273.508µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:43:21.587833Z","caller":"traceutil/trace.go:171","msg":"trace[434607326] transaction","detail":"{read_only:false; response_revision:1198; number_of_response:1; }","duration":"113.626727ms","start":"2026-06-15T15:43:21.47417Z","end":"2026-06-15T15:43:21.587797Z","steps":["trace[434607326] 'process raft request' (duration: 113.334458ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:43:21.587928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.896174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:43:21.587968Z","caller":"traceutil/trace.go:171","msg":"trace[1580148809] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1198; }","duration":"112.004937ms","start":"2026-06-15T15:43:21.475951Z","end":"2026-06-15T15:43:21.587956Z","steps":["trace[1580148809] 'agreement among raft nodes before linearized reading' (duration: 111.915275ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:43:45.847326Z","caller":"traceutil/trace.go:171","msg":"trace[1587495558] transaction","detail":"{read_only:false; response_revision:1463; number_of_response:1; }","duration":"114.889773ms","start":"2026-06-15T15:43:45.732408Z","end":"2026-06-15T15:43:45.847298Z","steps":["trace[1587495558] 'process raft request' (duration: 109.080187ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:43:57.005259Z","caller":"traceutil/trace.go:171","msg":"trace[1997163460] linearizableReadLoop","detail":"{readStateIndex:1752; appliedIndex:1751; }","duration":"103.341485ms","start":"2026-06-15T15:43:56.901896Z","end":"2026-06-15T15:43:57.005238Z","steps":["trace[1997163460] 'read index received' (duration: 39.143281ms)","trace[1997163460] 'applied index is now lower than readState.Index' (duration: 64.196894ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:43:57.005417Z","caller":"traceutil/trace.go:171","msg":"trace[1401391803] transaction","detail":"{read_only:false; response_revision:1687; number_of_response:1; }","duration":"106.153858ms","start":"2026-06-15T15:43:56.899191Z","end":"2026-06-15T15:43:57.005345Z","steps":["trace[1401391803] 'process raft request' (duration: 41.774728ms)","trace[1401391803] 'compare' (duration: 64.142611ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T15:43:57.005493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.565993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/perconaxtradbclusterrestores.pxc.percona.com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:43:57.005613Z","caller":"traceutil/trace.go:171","msg":"trace[1979187579] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/perconaxtradbclusterrestores.pxc.percona.com; range_end:; response_count:0; response_revision:1687; }","duration":"103.739909ms","start":"2026-06-15T15:43:56.901852Z","end":"2026-06-15T15:43:57.005592Z","steps":["trace[1979187579] 'agreement among raft nodes before linearized reading' (duration: 103.525151ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:43:57.006412Z","caller":"traceutil/trace.go:171","msg":"trace[937347581] transaction","detail":"{read_only:false; response_revision:1688; number_of_response:1; }","duration":"103.634866ms","start":"2026-06-15T15:43:56.902755Z","end":"2026-06-15T15:43:57.006389Z","steps":["trace[937347581] 'process raft request' (duration: 103.155637ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:44:03.271357Z","caller":"traceutil/trace.go:171","msg":"trace[1944474147] transaction","detail":"{read_only:false; response_revision:1772; number_of_response:1; }","duration":"154.249256ms","start":"2026-06-15T15:44:03.117088Z","end":"2026-06-15T15:44:03.271337Z","steps":["trace[1944474147] 'process raft request' (duration: 119.204185ms)","trace[1944474147] 'compare' (duration: 34.968978ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:44:03.275519Z","caller":"traceutil/trace.go:171","msg":"trace[1018437570] linearizableReadLoop","detail":"{readStateIndex:1845; appliedIndex:1843; }","duration":"154.446513ms","start":"2026-06-15T15:44:03.121052Z","end":"2026-06-15T15:44:03.275499Z","steps":["trace[1018437570] 'read index received' (duration: 115.217664ms)","trace[1018437570] 'applied index is now lower than readState.Index' (duration: 39.227909ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:44:03.275571Z","caller":"traceutil/trace.go:171","msg":"trace[1567290691] transaction","detail":"{read_only:false; response_revision:1773; number_of_response:1; }","duration":"156.832264ms","start":"2026-06-15T15:44:03.118709Z","end":"2026-06-15T15:44:03.275541Z","steps":["trace[1567290691] 'process raft request' (duration: 156.680668ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:44:03.27566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.581119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:44:03.275688Z","caller":"traceutil/trace.go:171","msg":"trace[290189779] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1773; }","duration":"154.678782ms","start":"2026-06-15T15:44:03.121002Z","end":"2026-06-15T15:44:03.27568Z","steps":["trace[290189779] 'agreement among raft nodes before linearized reading' (duration: 154.607369ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:44:03.275721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.558898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:44:03.275764Z","caller":"traceutil/trace.go:171","msg":"trace[1985401157] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1773; }","duration":"154.664462ms","start":"2026-06-15T15:44:03.12109Z","end":"2026-06-15T15:44:03.275754Z","steps":["trace[1985401157] 'agreement among raft nodes before linearized reading' (duration: 154.555187ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:44:03.275887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.215878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:44:03.275905Z","caller":"traceutil/trace.go:171","msg":"trace[143053260] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1773; }","duration":"100.242279ms","start":"2026-06-15T15:44:03.175657Z","end":"2026-06-15T15:44:03.275899Z","steps":["trace[143053260] 'agreement among raft nodes before linearized reading' (duration: 100.214948ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:44:03.276043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.426516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:44:03.276067Z","caller":"traceutil/trace.go:171","msg":"trace[1078991548] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1773; }","duration":"100.472728ms","start":"2026-06-15T15:44:03.175588Z","end":"2026-06-15T15:44:03.276061Z","steps":["trace[1078991548] 'agreement among raft nodes before linearized reading' (duration: 100.431296ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:44:03.276166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.746074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:44:03.276199Z","caller":"traceutil/trace.go:171","msg":"trace[359504049] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1773; }","duration":"132.780576ms","start":"2026-06-15T15:44:03.143411Z","end":"2026-06-15T15:44:03.276191Z","steps":["trace[359504049] 'agreement among raft nodes before linearized reading' (duration: 132.732624ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:44:03.276318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.877691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:44:03.276342Z","caller":"traceutil/trace.go:171","msg":"trace[315992541] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1773; }","duration":"132.906152ms","start":"2026-06-15T15:44:03.143424Z","end":"2026-06-15T15:44:03.276331Z","steps":["trace[315992541] 'agreement among raft nodes before linearized reading' (duration: 132.871741ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:44:10.684254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.650541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:44:10.684352Z","caller":"traceutil/trace.go:171","msg":"trace[923428896] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1881; }","duration":"271.789856ms","start":"2026-06-15T15:44:10.412539Z","end":"2026-06-15T15:44:10.684329Z","steps":["trace[923428896] 'range keys from in-memory index tree' (duration: 271.588178ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:44:10.684781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.571187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-15T15:44:10.684862Z","caller":"traceutil/trace.go:171","msg":"trace[1950400082] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1881; }","duration":"419.703092ms","start":"2026-06-15T15:44:10.265141Z","end":"2026-06-15T15:44:10.684844Z","steps":["trace[1950400082] 'range keys from in-memory index tree' (duration: 419.333969ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:44:10.684899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:44:10.265116Z","time spent":"419.775425ms","remote":"127.0.0.1:53884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-15T15:44:10.685328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.809918ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T15:44:10.685772Z","caller":"traceutil/trace.go:171","msg":"trace[985516414] transaction","detail":"{read_only:false; response_revision:1882; number_of_response:1; }","duration":"223.676493ms","start":"2026-06-15T15:44:10.462079Z","end":"2026-06-15T15:44:10.685755Z","steps":["trace[985516414] 'process raft request' (duration: 119.18245ms)","trace[985516414] 'compare' (duration: 102.883461ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:44:10.685767Z","caller":"traceutil/trace.go:171","msg":"trace[1321734174] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"115.536218ms","start":"2026-06-15T15:44:10.570212Z","end":"2026-06-15T15:44:10.685749Z","steps":["trace[1321734174] 'process raft request' (duration: 115.345721ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:44:11.177189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.955053ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T15:44:11.177372Z","caller":"traceutil/trace.go:171","msg":"trace[1737611669] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"482.728647ms","start":"2026-06-15T15:44:10.694621Z","end":"2026-06-15T15:44:11.177349Z","steps":["trace[1737611669] 'process raft request' (duration: 377.451571ms)","trace[1737611669] 'compare' (duration: 104.840179ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T15:44:11.177529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:44:10.694596Z","time spent":"482.826881ms","remote":"127.0.0.1:53808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T15:44:23.501638Z","caller":"traceutil/trace.go:171","msg":"trace[638292804] linearizableReadLoop","detail":"{readStateIndex:2064; appliedIndex:2063; }","duration":"137.7603ms","start":"2026-06-15T15:44:23.363856Z","end":"2026-06-15T15:44:23.501616Z","steps":["trace[638292804] 'read index received' (duration: 137.678176ms)","trace[638292804] 'applied index is now lower than readState.Index' (duration: 80.754µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:44:23.501765Z","caller":"traceutil/trace.go:171","msg":"trace[583698901] transaction","detail":"{read_only:false; response_revision:1988; number_of_response:1; }","duration":"265.762303ms","start":"2026-06-15T15:44:23.235968Z","end":"2026-06-15T15:44:23.50173Z","steps":["trace[583698901] 'process raft request' (duration: 265.491471ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:44:23.501873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.99472ms","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-06-15T15:44:23.501937Z","caller":"traceutil/trace.go:171","msg":"trace[463007825] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1988; }","duration":"138.111234ms","start":"2026-06-15T15:44:23.363811Z","end":"2026-06-15T15:44:23.501923Z","steps":["trace[463007825] 'agreement among raft nodes before linearized reading' (duration: 137.924707ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:44:23.687305Z","caller":"traceutil/trace.go:171","msg":"trace[1298894383] transaction","detail":"{read_only:false; response_revision:1991; number_of_response:1; }","duration":"167.287485ms","start":"2026-06-15T15:44:23.52Z","end":"2026-06-15T15:44:23.687287Z","steps":["trace[1298894383] 'process raft request' (duration: 167.217672ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:44:23.687292Z","caller":"traceutil/trace.go:171","msg":"trace[569583443] transaction","detail":"{read_only:false; response_revision:1990; number_of_response:1; }","duration":"178.900057ms","start":"2026-06-15T15:44:23.508361Z","end":"2026-06-15T15:44:23.687261Z","steps":["trace[569583443] 'process raft request' (duration: 178.813914ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:44:23.687353Z","caller":"traceutil/trace.go:171","msg":"trace[2064740812] transaction","detail":"{read_only:false; response_revision:1989; number_of_response:1; }","duration":"179.766311ms","start":"2026-06-15T15:44:23.50755Z","end":"2026-06-15T15:44:23.687316Z","steps":["trace[2064740812] 'process raft request' (duration: 150.387872ms)","trace[2064740812] 'compare' (duration: 29.101598ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:44:26.423543Z","caller":"traceutil/trace.go:171","msg":"trace[172267666] transaction","detail":"{read_only:false; response_revision:2014; number_of_response:1; }","duration":"241.882154ms","start":"2026-06-15T15:44:26.181626Z","end":"2026-06-15T15:44:26.423509Z","steps":["trace[172267666] 'process raft request' (duration: 241.719997ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:44:49.926866Z","caller":"traceutil/trace.go:171","msg":"trace[1047437103] transaction","detail":"{read_only:false; response_revision:2146; number_of_response:1; }","duration":"138.160686ms","start":"2026-06-15T15:44:49.788663Z","end":"2026-06-15T15:44:49.926824Z","steps":["trace[1047437103] 'process raft request' (duration: 137.907976ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:44:50.06722Z","caller":"traceutil/trace.go:171","msg":"trace[198164902] linearizableReadLoop","detail":"{readStateIndex:2229; appliedIndex:2227; }","duration":"129.812793ms","start":"2026-06-15T15:44:49.937374Z","end":"2026-06-15T15:44:50.067187Z","steps":["trace[198164902] 'read index received' (duration: 5.944877ms)","trace[198164902] 'applied index is now lower than readState.Index' (duration: 123.866776ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:44:50.067289Z","caller":"traceutil/trace.go:171","msg":"trace[329936848] transaction","detail":"{read_only:false; response_revision:2148; number_of_response:1; }","duration":"135.120204ms","start":"2026-06-15T15:44:49.93214Z","end":"2026-06-15T15:44:50.06726Z","steps":["trace[329936848] 'process raft request' (duration: 126.593668ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:44:50.067376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.980401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:44:50.067546Z","caller":"traceutil/trace.go:171","msg":"trace[1761234256] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:2148; }","duration":"130.184749ms","start":"2026-06-15T15:44:49.937336Z","end":"2026-06-15T15:44:50.06752Z","steps":["trace[1761234256] 'agreement among raft nodes before linearized reading' (duration: 129.97942ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:44:50.302008Z","caller":"traceutil/trace.go:171","msg":"trace[192064803] transaction","detail":"{read_only:false; response_revision:2150; number_of_response:1; }","duration":"112.697112ms","start":"2026-06-15T15:44:50.189283Z","end":"2026-06-15T15:44:50.301981Z","steps":["trace[192064803] 'process raft request' (duration: 79.478686ms)","trace[192064803] 'compare' (duration: 33.032588ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:44:50.766233Z","caller":"traceutil/trace.go:171","msg":"trace[486301271] transaction","detail":"{read_only:false; response_revision:2151; number_of_response:1; }","duration":"162.954129ms","start":"2026-06-15T15:44:50.603254Z","end":"2026-06-15T15:44:50.766208Z","steps":["trace[486301271] 'process raft request' (duration: 162.831904ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:44:51.205159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.703998ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T15:44:51.205242Z","caller":"traceutil/trace.go:171","msg":"trace[1567475935] linearizableReadLoop","detail":"{readStateIndex:2235; appliedIndex:2234; }","duration":"124.804965ms","start":"2026-06-15T15:44:51.080423Z","end":"2026-06-15T15:44:51.205228Z","steps":["trace[1567475935] 'read index received' (duration: 92.884µs)","trace[1567475935] 'applied index is now lower than readState.Index' (duration: 124.711261ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:44:51.205266Z","caller":"traceutil/trace.go:171","msg":"trace[445036162] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"293.856302ms","start":"2026-06-15T15:44:50.911391Z","end":"2026-06-15T15:44:51.205247Z","steps":["trace[445036162] 'process raft request' (duration: 119.990176ms)","trace[445036162] 'compare' (duration: 173.542661ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T15:44:51.205362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.953491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-15T15:44:51.205383Z","caller":"traceutil/trace.go:171","msg":"trace[607211093] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2154; }","duration":"125.024305ms","start":"2026-06-15T15:44:51.080351Z","end":"2026-06-15T15:44:51.205376Z","steps":["trace[607211093] 'agreement among raft nodes before linearized reading' (duration: 124.91539ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:44:51.787101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.190282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-15T15:44:51.787128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.048308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:44:51.787192Z","caller":"traceutil/trace.go:171","msg":"trace[787697209] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2154; }","duration":"374.126271ms","start":"2026-06-15T15:44:51.413049Z","end":"2026-06-15T15:44:51.787176Z","steps":["trace[787697209] 'range keys from in-memory index tree' (duration: 373.905462ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:44:51.787185Z","caller":"traceutil/trace.go:171","msg":"trace[1603211253] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2154; }","duration":"131.320687ms","start":"2026-06-15T15:44:51.655844Z","end":"2026-06-15T15:44:51.787165Z","steps":["trace[1603211253] 'range keys from in-memory index tree' (duration: 130.985513ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:44:51.787229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:44:51.412993Z","time spent":"374.229445ms","remote":"127.0.0.1:53598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-15T15:44:52.151164Z","caller":"traceutil/trace.go:171","msg":"trace[534583967] transaction","detail":"{read_only:false; response_revision:2156; number_of_response:1; }","duration":"218.560809ms","start":"2026-06-15T15:44:51.932559Z","end":"2026-06-15T15:44:52.15112Z","steps":["trace[534583967] 'process raft request' (duration: 218.070979ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:44:52.151557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.478151ms","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-06-15T15:44:52.151645Z","caller":"traceutil/trace.go:171","msg":"trace[568837198] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2156; }","duration":"204.600307ms","start":"2026-06-15T15:44:51.947016Z","end":"2026-06-15T15:44:52.151617Z","steps":["trace[568837198] 'agreement among raft nodes before linearized reading' (duration: 204.390308ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:44:52.151708Z","caller":"traceutil/trace.go:171","msg":"trace[1082809684] linearizableReadLoop","detail":"{readStateIndex:2237; appliedIndex:2236; }","duration":"203.998202ms","start":"2026-06-15T15:44:51.947054Z","end":"2026-06-15T15:44:52.151052Z","steps":["trace[1082809684] 'read index received' (duration: 203.638787ms)","trace[1082809684] 'applied index is now lower than readState.Index' (duration: 357.684µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:45:49.663473Z","caller":"traceutil/trace.go:171","msg":"trace[577505108] transaction","detail":"{read_only:false; response_revision:2573; number_of_response:1; }","duration":"159.130332ms","start":"2026-06-15T15:45:49.50432Z","end":"2026-06-15T15:45:49.66345Z","steps":["trace[577505108] 'process raft request' (duration: 158.835679ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:46:23.101152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.541525ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T15:46:23.101293Z","caller":"traceutil/trace.go:171","msg":"trace[1163930552] linearizableReadLoop","detail":"{readStateIndex:2855; appliedIndex:2854; }","duration":"518.358647ms","start":"2026-06-15T15:46:22.582914Z","end":"2026-06-15T15:46:23.101273Z","steps":["trace[1163930552] 'read index received' (duration: 345.766452ms)","trace[1163930552] 'applied index is now lower than readState.Index' (duration: 172.590725ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T15:46:23.101603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.667783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18b94bb3a7590162\" ","response":"range_response_count:1 size:779"} {"level":"info","ts":"2026-06-15T15:46:23.101756Z","caller":"traceutil/trace.go:171","msg":"trace[2119547334] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18b94bb3a7590162; range_end:; response_count:1; response_revision:2753; }","duration":"518.867923ms","start":"2026-06-15T15:46:22.582864Z","end":"2026-06-15T15:46:23.101732Z","steps":["trace[2119547334] 'agreement among raft nodes before linearized reading' (duration: 518.507806ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:46:23.101898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:46:22.582844Z","time spent":"519.040411ms","remote":"127.0.0.1:53704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":801,"request content":"key:\"/registry/events/auth-system/keycloak-0.18b94bb3a7590162\" "} {"level":"info","ts":"2026-06-15T15:46:23.102065Z","caller":"traceutil/trace.go:171","msg":"trace[1630196089] transaction","detail":"{read_only:false; response_revision:2753; number_of_response:1; }","duration":"571.695218ms","start":"2026-06-15T15:46:22.530353Z","end":"2026-06-15T15:46:23.102048Z","steps":["trace[1630196089] 'process raft request' (duration: 398.152192ms)","trace[1630196089] 'compare' (duration: 171.8196ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T15:46:23.102166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:46:22.53033Z","time spent":"571.795747ms","remote":"127.0.0.1:53884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T15:46:23.767054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"661.913516ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-15T15:46:23.767343Z","caller":"traceutil/trace.go:171","msg":"trace[774537307] linearizableReadLoop","detail":"{readStateIndex:2856; appliedIndex:2855; }","duration":"665.990382ms","start":"2026-06-15T15:46:23.101329Z","end":"2026-06-15T15:46:23.76732Z","steps":["trace[774537307] 'read index received' (duration: 3.79329ms)","trace[774537307] 'applied index is now lower than readState.Index' (duration: 662.195592ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T15:46:23.767585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.081466445s","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-06-15T15:46:23.767645Z","caller":"traceutil/trace.go:171","msg":"trace[204909068] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2753; }","duration":"1.081579794s","start":"2026-06-15T15:46:22.686047Z","end":"2026-06-15T15:46:23.767627Z","steps":["trace[204909068] 'agreement among raft nodes before linearized reading' (duration: 1.081390325s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:46:23.767699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:46:22.686016Z","time spent":"1.081668783s","remote":"127.0.0.1:53884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-15T15:46:23.767714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.140606318s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-15T15:46:23.767795Z","caller":"traceutil/trace.go:171","msg":"trace[453285380] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2753; }","duration":"1.140769266s","start":"2026-06-15T15:46:22.627004Z","end":"2026-06-15T15:46:23.767773Z","steps":["trace[453285380] 'agreement among raft nodes before linearized reading' (duration: 1.140527809s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:46:23.767846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:46:22.626986Z","time spent":"1.140852056s","remote":"127.0.0.1:53884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-15T15:46:23.76786Z","caller":"traceutil/trace.go:171","msg":"trace[2094154172] transaction","detail":"{read_only:false; response_revision:2754; number_of_response:1; }","duration":"663.589232ms","start":"2026-06-15T15:46:23.104236Z","end":"2026-06-15T15:46:23.767825Z","steps":["trace[2094154172] 'process raft request' (duration: 662.950227ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:46:23.768057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:46:23.104212Z","time spent":"663.742151ms","remote":"127.0.0.1:53704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":764,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T15:46:23.826537Z","caller":"traceutil/trace.go:171","msg":"trace[415542] transaction","detail":"{read_only:false; response_revision:2755; number_of_response:1; }","duration":"587.673613ms","start":"2026-06-15T15:46:23.238835Z","end":"2026-06-15T15:46:23.826508Z","steps":["trace[415542] 'process raft request' (duration: 540.228365ms)","trace[415542] 'compare' (duration: 47.06598ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T15:46:23.826698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:46:23.238812Z","time spent":"587.798842ms","remote":"127.0.0.1:53884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T15:46:23.826943Z","caller":"traceutil/trace.go:171","msg":"trace[905439479] transaction","detail":"{read_only:false; response_revision:2756; number_of_response:1; }","duration":"586.850989ms","start":"2026-06-15T15:46:23.240075Z","end":"2026-06-15T15:46:23.826926Z","steps":["trace[905439479] 'process raft request' (duration: 586.178625ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:46:23.827076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:46:23.240068Z","time spent":"586.958638ms","remote":"127.0.0.1:53884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T15:46:23.827276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"583.993542ms","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-06-15T15:46:23.827426Z","caller":"traceutil/trace.go:171","msg":"trace[45636703] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2756; }","duration":"584.18096ms","start":"2026-06-15T15:46:23.243223Z","end":"2026-06-15T15:46:23.827404Z","steps":["trace[45636703] 'agreement among raft nodes before linearized reading' (duration: 583.709184ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:46:23.827585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:46:23.243199Z","time spent":"584.367199ms","remote":"127.0.0.1:53884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-15T15:46:23.8277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.914142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:46:23.827766Z","caller":"traceutil/trace.go:171","msg":"trace[81322310] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:2756; }","duration":"440.012351ms","start":"2026-06-15T15:46:23.387737Z","end":"2026-06-15T15:46:23.827749Z","steps":["trace[81322310] 'agreement among raft nodes before linearized reading' (duration: 439.911922ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:46:23.827821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:46:23.387723Z","time spent":"440.081891ms","remote":"127.0.0.1:34576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-06-15T15:46:23.828417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.47997ms","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-06-15T15:46:23.828901Z","caller":"traceutil/trace.go:171","msg":"trace[67208986] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2758; }","duration":"535.005606ms","start":"2026-06-15T15:46:23.293875Z","end":"2026-06-15T15:46:23.82888Z","steps":["trace[67208986] 'agreement among raft nodes before linearized reading' (duration: 534.292172ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:46:23.829133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:46:23.293847Z","time spent":"535.170446ms","remote":"127.0.0.1:53820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1391,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"info","ts":"2026-06-15T15:49:59.071239Z","caller":"traceutil/trace.go:171","msg":"trace[2100503762] transaction","detail":"{read_only:false; response_revision:4057; number_of_response:1; }","duration":"104.268592ms","start":"2026-06-15T15:49:58.966938Z","end":"2026-06-15T15:49:59.071206Z","steps":["trace[2100503762] 'process raft request' (duration: 75.622929ms)","trace[2100503762] 'compare' (duration: 28.523199ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:50:05.436616Z","caller":"traceutil/trace.go:171","msg":"trace[2070227591] transaction","detail":"{read_only:false; response_revision:4097; number_of_response:1; }","duration":"105.485481ms","start":"2026-06-15T15:50:05.331106Z","end":"2026-06-15T15:50:05.436591Z","steps":["trace[2070227591] 'process raft request' (duration: 105.1064ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:09.305745Z","caller":"traceutil/trace.go:171","msg":"trace[1348267053] transaction","detail":"{read_only:false; response_revision:4133; number_of_response:1; }","duration":"168.110803ms","start":"2026-06-15T15:50:09.137604Z","end":"2026-06-15T15:50:09.305714Z","steps":["trace[1348267053] 'process raft request' (duration: 167.775373ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:12.755132Z","caller":"traceutil/trace.go:171","msg":"trace[33425785] transaction","detail":"{read_only:false; response_revision:4241; number_of_response:1; }","duration":"115.974548ms","start":"2026-06-15T15:50:12.639119Z","end":"2026-06-15T15:50:12.755094Z","steps":["trace[33425785] 'process raft request' (duration: 82.265727ms)","trace[33425785] 'compare' (duration: 33.501625ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:50:12.755224Z","caller":"traceutil/trace.go:171","msg":"trace[1134250588] linearizableReadLoop","detail":"{readStateIndex:4410; appliedIndex:4408; }","duration":"105.283561ms","start":"2026-06-15T15:50:12.649928Z","end":"2026-06-15T15:50:12.755212Z","steps":["trace[1134250588] 'read index received' (duration: 71.467627ms)","trace[1134250588] 'applied index is now lower than readState.Index' (duration: 33.815074ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:50:12.755213Z","caller":"traceutil/trace.go:171","msg":"trace[309564549] transaction","detail":"{read_only:false; response_revision:4242; number_of_response:1; }","duration":"115.969809ms","start":"2026-06-15T15:50:12.639211Z","end":"2026-06-15T15:50:12.755181Z","steps":["trace[309564549] 'process raft request' (duration: 115.813104ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:12.755156Z","caller":"traceutil/trace.go:171","msg":"trace[228731418] transaction","detail":"{read_only:false; response_revision:4243; number_of_response:1; }","duration":"105.136127ms","start":"2026-06-15T15:50:12.649993Z","end":"2026-06-15T15:50:12.755129Z","steps":["trace[228731418] 'process raft request' (duration: 105.087875ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:12.755474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.522108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:128188"} {"level":"info","ts":"2026-06-15T15:50:12.755516Z","caller":"traceutil/trace.go:171","msg":"trace[301720330] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:4243; }","duration":"105.607991ms","start":"2026-06-15T15:50:12.649896Z","end":"2026-06-15T15:50:12.755504Z","steps":["trace[301720330] 'agreement among raft nodes before linearized reading' (duration: 105.361233ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:16.565464Z","caller":"traceutil/trace.go:171","msg":"trace[1309615076] linearizableReadLoop","detail":"{readStateIndex:4684; appliedIndex:4683; }","duration":"154.195734ms","start":"2026-06-15T15:50:16.411245Z","end":"2026-06-15T15:50:16.56544Z","steps":["trace[1309615076] 'read index received' (duration: 154.05658ms)","trace[1309615076] 'applied index is now lower than readState.Index' (duration: 138.184µs)"],"step_count":2} {"level":"warn","ts":"2026-06-15T15:50:16.565641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.35956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:50:16.565682Z","caller":"traceutil/trace.go:171","msg":"trace[1549646170] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4510; }","duration":"154.485033ms","start":"2026-06-15T15:50:16.411186Z","end":"2026-06-15T15:50:16.565671Z","steps":["trace[1549646170] 'agreement among raft nodes before linearized reading' (duration: 154.355529ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:16.565993Z","caller":"traceutil/trace.go:171","msg":"trace[713604927] transaction","detail":"{read_only:false; response_revision:4510; number_of_response:1; }","duration":"160.240151ms","start":"2026-06-15T15:50:16.405738Z","end":"2026-06-15T15:50:16.565978Z","steps":["trace[713604927] 'process raft request' (duration: 159.56508ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:22.21717Z","caller":"traceutil/trace.go:171","msg":"trace[73087367] transaction","detail":"{read_only:false; response_revision:4598; number_of_response:1; }","duration":"207.392256ms","start":"2026-06-15T15:50:22.009745Z","end":"2026-06-15T15:50:22.217138Z","steps":["trace[73087367] 'process raft request' (duration: 148.034125ms)","trace[73087367] 'compare' (duration: 58.98527ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:50:23.032011Z","caller":"traceutil/trace.go:171","msg":"trace[1132291540] transaction","detail":"{read_only:false; response_revision:4602; number_of_response:1; }","duration":"100.196057ms","start":"2026-06-15T15:50:22.931765Z","end":"2026-06-15T15:50:23.031961Z","steps":["trace[1132291540] 'process raft request' (duration: 99.96275ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:23.564085Z","caller":"traceutil/trace.go:171","msg":"trace[2078460203] transaction","detail":"{read_only:false; response_revision:4610; number_of_response:1; }","duration":"248.956725ms","start":"2026-06-15T15:50:23.315103Z","end":"2026-06-15T15:50:23.56406Z","steps":["trace[2078460203] 'process raft request' (duration: 202.306088ms)","trace[2078460203] 'compare' (duration: 46.304037ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:50:23.564204Z","caller":"traceutil/trace.go:171","msg":"trace[2010343919] linearizableReadLoop","detail":"{readStateIndex:4788; appliedIndex:4787; }","duration":"150.220252ms","start":"2026-06-15T15:50:23.413957Z","end":"2026-06-15T15:50:23.564177Z","steps":["trace[2010343919] 'read index received' (duration: 103.393809ms)","trace[2010343919] 'applied index is now lower than readState.Index' (duration: 46.815573ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T15:50:23.56437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.408587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:50:23.56441Z","caller":"traceutil/trace.go:171","msg":"trace[1006720838] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4611; }","duration":"150.518041ms","start":"2026-06-15T15:50:23.413882Z","end":"2026-06-15T15:50:23.5644Z","steps":["trace[1006720838] 'agreement among raft nodes before linearized reading' (duration: 150.431238ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:23.691528Z","caller":"traceutil/trace.go:171","msg":"trace[183879367] transaction","detail":"{read_only:false; response_revision:4612; number_of_response:1; }","duration":"123.165986ms","start":"2026-06-15T15:50:23.568332Z","end":"2026-06-15T15:50:23.691498Z","steps":["trace[183879367] 'process raft request' (duration: 121.965329ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:23.756244Z","caller":"traceutil/trace.go:171","msg":"trace[214031494] transaction","detail":"{read_only:false; response_revision:4613; number_of_response:1; }","duration":"187.500066ms","start":"2026-06-15T15:50:23.568715Z","end":"2026-06-15T15:50:23.756215Z","steps":["trace[214031494] 'process raft request' (duration: 187.260419ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:23.756635Z","caller":"traceutil/trace.go:171","msg":"trace[1242292024] transaction","detail":"{read_only:false; response_revision:4614; number_of_response:1; }","duration":"187.593639ms","start":"2026-06-15T15:50:23.569013Z","end":"2026-06-15T15:50:23.756607Z","steps":["trace[1242292024] 'process raft request' (duration: 187.129245ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:23.756804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.011409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:50:23.75686Z","caller":"traceutil/trace.go:171","msg":"trace[1974233894] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:4615; }","duration":"112.090052ms","start":"2026-06-15T15:50:23.644756Z","end":"2026-06-15T15:50:23.756846Z","steps":["trace[1974233894] 'agreement among raft nodes before linearized reading' (duration: 111.966067ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:23.75666Z","caller":"traceutil/trace.go:171","msg":"trace[2027267067] linearizableReadLoop","detail":"{readStateIndex:4793; appliedIndex:4789; }","duration":"111.868215ms","start":"2026-06-15T15:50:23.644764Z","end":"2026-06-15T15:50:23.756633Z","steps":["trace[2027267067] 'read index received' (duration: 45.788691ms)","trace[2027267067] 'applied index is now lower than readState.Index' (duration: 66.078324ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:50:23.757159Z","caller":"traceutil/trace.go:171","msg":"trace[1749896121] transaction","detail":"{read_only:false; response_revision:4615; number_of_response:1; }","duration":"183.115779ms","start":"2026-06-15T15:50:23.57403Z","end":"2026-06-15T15:50:23.757146Z","steps":["trace[1749896121] 'process raft request' (duration: 182.427147ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:23.812146Z","caller":"traceutil/trace.go:171","msg":"trace[1948139523] transaction","detail":"{read_only:false; response_revision:4616; number_of_response:1; }","duration":"116.373865ms","start":"2026-06-15T15:50:23.695742Z","end":"2026-06-15T15:50:23.812116Z","steps":["trace[1948139523] 'process raft request' (duration: 115.157697ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:25.16669Z","caller":"traceutil/trace.go:171","msg":"trace[213023920] transaction","detail":"{read_only:false; response_revision:4681; number_of_response:1; }","duration":"291.116228ms","start":"2026-06-15T15:50:24.875472Z","end":"2026-06-15T15:50:25.166588Z","steps":["trace[213023920] 'process raft request' (duration: 290.894851ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:25.176308Z","caller":"traceutil/trace.go:171","msg":"trace[1237823968] transaction","detail":"{read_only:false; response_revision:4682; number_of_response:1; }","duration":"264.246446ms","start":"2026-06-15T15:50:24.912044Z","end":"2026-06-15T15:50:25.17629Z","steps":["trace[1237823968] 'process raft request' (duration: 264.111102ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:25.176568Z","caller":"traceutil/trace.go:171","msg":"trace[1919749324] linearizableReadLoop","detail":"{readStateIndex:4863; appliedIndex:4859; }","duration":"121.326812ms","start":"2026-06-15T15:50:25.055223Z","end":"2026-06-15T15:50:25.17655Z","steps":["trace[1919749324] 'read index received' (duration: 111.137723ms)","trace[1919749324] 'applied index is now lower than readState.Index' (duration: 10.186709ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:50:25.176664Z","caller":"traceutil/trace.go:171","msg":"trace[1341073854] transaction","detail":"{read_only:false; response_revision:4683; number_of_response:1; }","duration":"149.059562ms","start":"2026-06-15T15:50:25.027598Z","end":"2026-06-15T15:50:25.176657Z","steps":["trace[1341073854] 'process raft request' (duration: 148.660759ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:25.176851Z","caller":"traceutil/trace.go:171","msg":"trace[384215915] transaction","detail":"{read_only:false; response_revision:4684; number_of_response:1; }","duration":"138.587814ms","start":"2026-06-15T15:50:25.038258Z","end":"2026-06-15T15:50:25.176846Z","steps":["trace[384215915] 'process raft request' (duration: 138.226422ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:25.176987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.750267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-40ca0b9b-b402-49e2-88ac-e37f37cd4569\" ","response":"range_response_count:1 size:3774"} {"level":"info","ts":"2026-06-15T15:50:25.177011Z","caller":"traceutil/trace.go:171","msg":"trace[1744218202] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-40ca0b9b-b402-49e2-88ac-e37f37cd4569; range_end:; response_count:1; response_revision:4684; }","duration":"121.833509ms","start":"2026-06-15T15:50:25.055171Z","end":"2026-06-15T15:50:25.177004Z","steps":["trace[1744218202] 'agreement among raft nodes before linearized reading' (duration: 121.720025ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:25.71926Z","caller":"traceutil/trace.go:171","msg":"trace[36006879] linearizableReadLoop","detail":"{readStateIndex:4870; appliedIndex:4869; }","duration":"201.95506ms","start":"2026-06-15T15:50:25.517286Z","end":"2026-06-15T15:50:25.719241Z","steps":["trace[36006879] 'read index received' (duration: 201.743533ms)","trace[36006879] 'applied index is now lower than readState.Index' (duration: 210.877µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:50:25.71937Z","caller":"traceutil/trace.go:171","msg":"trace[1131261951] transaction","detail":"{read_only:false; response_revision:4691; number_of_response:1; }","duration":"204.093867ms","start":"2026-06-15T15:50:25.515238Z","end":"2026-06-15T15:50:25.719332Z","steps":["trace[1131261951] 'process raft request' (duration: 203.819909ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:25.719509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.196957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-06-15T15:50:25.71958Z","caller":"traceutil/trace.go:171","msg":"trace[293656730] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4691; }","duration":"202.29245ms","start":"2026-06-15T15:50:25.517269Z","end":"2026-06-15T15:50:25.719562Z","steps":["trace[293656730] 'agreement among raft nodes before linearized reading' (duration: 202.083484ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:25.883324Z","caller":"traceutil/trace.go:171","msg":"trace[80009347] linearizableReadLoop","detail":"{readStateIndex:4871; appliedIndex:4870; }","duration":"163.955158ms","start":"2026-06-15T15:50:25.719347Z","end":"2026-06-15T15:50:25.883302Z","steps":["trace[80009347] 'read index received' (duration: 157.857497ms)","trace[80009347] 'applied index is now lower than readState.Index' (duration: 6.096941ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:50:25.883408Z","caller":"traceutil/trace.go:171","msg":"trace[2067314880] transaction","detail":"{read_only:false; response_revision:4692; number_of_response:1; }","duration":"314.177776ms","start":"2026-06-15T15:50:25.569194Z","end":"2026-06-15T15:50:25.883372Z","steps":["trace[2067314880] 'process raft request' (duration: 307.961142ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:25.883475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.794969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-15T15:50:25.8835Z","caller":"traceutil/trace.go:171","msg":"trace[1119400076] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:4692; }","duration":"219.886451ms","start":"2026-06-15T15:50:25.663606Z","end":"2026-06-15T15:50:25.883492Z","steps":["trace[1119400076] 'agreement among raft nodes before linearized reading' (duration: 219.809559ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:25.883605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:25.569173Z","time spent":"314.330571ms","remote":"127.0.0.1:53884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T15:50:25.883704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.46288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:50:25.883792Z","caller":"traceutil/trace.go:171","msg":"trace[1767798338] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1; range_end:; response_count:0; response_revision:4692; }","duration":"160.607504ms","start":"2026-06-15T15:50:25.72316Z","end":"2026-06-15T15:50:25.883768Z","steps":["trace[1767798338] 'agreement among raft nodes before linearized reading' (duration: 160.474878ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:25.883887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.605213ms","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":"warn","ts":"2026-06-15T15:50:25.883863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.475137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-15T15:50:25.883953Z","caller":"traceutil/trace.go:171","msg":"trace[1648541402] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4692; }","duration":"121.629573ms","start":"2026-06-15T15:50:25.762302Z","end":"2026-06-15T15:50:25.883931Z","steps":["trace[1648541402] 'agreement among raft nodes before linearized reading' (duration: 121.357943ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:25.88391Z","caller":"traceutil/trace.go:171","msg":"trace[259262572] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4692; }","duration":"122.651895ms","start":"2026-06-15T15:50:25.761253Z","end":"2026-06-15T15:50:25.883905Z","steps":["trace[259262572] 'agreement among raft nodes before linearized reading' (duration: 122.540261ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:26.415624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.209718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-06-15T15:50:26.415717Z","caller":"traceutil/trace.go:171","msg":"trace[1496061875] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4698; }","duration":"202.341182ms","start":"2026-06-15T15:50:26.213356Z","end":"2026-06-15T15:50:26.415697Z","steps":["trace[1496061875] 'range keys from in-memory index tree' (duration: 201.94123ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:26.415747Z","caller":"traceutil/trace.go:171","msg":"trace[669196290] transaction","detail":"{read_only:false; response_revision:4699; number_of_response:1; }","duration":"174.88131ms","start":"2026-06-15T15:50:26.24083Z","end":"2026-06-15T15:50:26.415711Z","steps":["trace[669196290] 'process raft request' (duration: 159.718595ms)","trace[669196290] 'compare' (duration: 14.870676ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:50:28.139013Z","caller":"traceutil/trace.go:171","msg":"trace[1946871005] linearizableReadLoop","detail":"{readStateIndex:4891; appliedIndex:4890; }","duration":"238.321263ms","start":"2026-06-15T15:50:27.900675Z","end":"2026-06-15T15:50:28.138996Z","steps":["trace[1946871005] 'read index received' (duration: 238.177028ms)","trace[1946871005] 'applied index is now lower than readState.Index' (duration: 143.715µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:50:28.139131Z","caller":"traceutil/trace.go:171","msg":"trace[731714254] transaction","detail":"{read_only:false; response_revision:4710; number_of_response:1; }","duration":"249.993369ms","start":"2026-06-15T15:50:27.889105Z","end":"2026-06-15T15:50:28.139098Z","steps":["trace[731714254] 'process raft request' (duration: 249.786853ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:28.139215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.523369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-15T15:50:28.139241Z","caller":"traceutil/trace.go:171","msg":"trace[1326589942] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4710; }","duration":"238.596161ms","start":"2026-06-15T15:50:27.900638Z","end":"2026-06-15T15:50:28.139234Z","steps":["trace[1326589942] 'agreement among raft nodes before linearized reading' (duration: 238.441846ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:28.139364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.396991ms","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-06-15T15:50:28.139381Z","caller":"traceutil/trace.go:171","msg":"trace[4321201] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4710; }","duration":"228.434083ms","start":"2026-06-15T15:50:27.910943Z","end":"2026-06-15T15:50:28.139377Z","steps":["trace[4321201] 'agreement among raft nodes before linearized reading' (duration: 228.393531ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:28.139486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.545223ms","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-06-15T15:50:28.139502Z","caller":"traceutil/trace.go:171","msg":"trace[1456214591] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4710; }","duration":"233.606224ms","start":"2026-06-15T15:50:27.905893Z","end":"2026-06-15T15:50:28.139499Z","steps":["trace[1456214591] 'agreement among raft nodes before linearized reading' (duration: 233.413177ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:28.621005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.824357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9a349e07-8270-4be0-a397-9994b73400ed\" ","response":"range_response_count:1 size:4050"} {"level":"info","ts":"2026-06-15T15:50:28.621076Z","caller":"traceutil/trace.go:171","msg":"trace[136944570] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9a349e07-8270-4be0-a397-9994b73400ed; range_end:; response_count:1; response_revision:4715; }","duration":"100.941641ms","start":"2026-06-15T15:50:28.520118Z","end":"2026-06-15T15:50:28.621059Z","steps":["trace[136944570] 'range keys from in-memory index tree' (duration: 100.65933ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:31.773887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.353923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-06833614-5648-44a2-bd45-95e34d7c2037\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-06-15T15:50:31.774016Z","caller":"traceutil/trace.go:171","msg":"trace[1456742185] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-06833614-5648-44a2-bd45-95e34d7c2037; range_end:; response_count:1; response_revision:4826; }","duration":"206.544989ms","start":"2026-06-15T15:50:31.567443Z","end":"2026-06-15T15:50:31.773988Z","steps":["trace[1456742185] 'range keys from in-memory index tree' (duration: 206.114865ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:31.774196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.314449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-76585b9f48-h8f7l.18b94bf20bf6a326\" ","response":"range_response_count:1 size:898"} {"level":"info","ts":"2026-06-15T15:50:31.774263Z","caller":"traceutil/trace.go:171","msg":"trace[1698542808] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-76585b9f48-h8f7l.18b94bf20bf6a326; range_end:; response_count:1; response_revision:4826; }","duration":"204.431833ms","start":"2026-06-15T15:50:31.569813Z","end":"2026-06-15T15:50:31.774245Z","steps":["trace[1698542808] 'range keys from in-memory index tree' (duration: 203.764081ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:31.774009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.684611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:50:31.774549Z","caller":"traceutil/trace.go:171","msg":"trace[498174375] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:4826; }","duration":"242.304432ms","start":"2026-06-15T15:50:31.532226Z","end":"2026-06-15T15:50:31.774531Z","steps":["trace[498174375] 'count revisions from in-memory index tree' (duration: 241.585818ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:31.774154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.844396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"warn","ts":"2026-06-15T15:50:31.774689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.044862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-06833614-5648-44a2-bd45-95e34d7c2037\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-06-15T15:50:31.774723Z","caller":"traceutil/trace.go:171","msg":"trace[190073341] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4826; }","duration":"265.452755ms","start":"2026-06-15T15:50:31.509232Z","end":"2026-06-15T15:50:31.774685Z","steps":["trace[190073341] 'range keys from in-memory index tree' (duration: 264.616698ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:31.774755Z","caller":"traceutil/trace.go:171","msg":"trace[1919243620] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-06833614-5648-44a2-bd45-95e34d7c2037; range_end:; response_count:1; response_revision:4826; }","duration":"193.151536ms","start":"2026-06-15T15:50:31.581579Z","end":"2026-06-15T15:50:31.774731Z","steps":["trace[1919243620] 'range keys from in-memory index tree' (duration: 192.259517ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:33.905382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.539377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-06833614-5648-44a2-bd45-95e34d7c2037\" ","response":"range_response_count:1 size:3949"} {"level":"info","ts":"2026-06-15T15:50:33.905472Z","caller":"traceutil/trace.go:171","msg":"trace[1360594725] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-06833614-5648-44a2-bd45-95e34d7c2037; range_end:; response_count:1; response_revision:4859; }","duration":"119.746054ms","start":"2026-06-15T15:50:33.785706Z","end":"2026-06-15T15:50:33.905452Z","steps":["trace[1360594725] 'range keys from in-memory index tree' (duration: 119.362772ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:35.068457Z","caller":"traceutil/trace.go:171","msg":"trace[2068932691] transaction","detail":"{read_only:false; response_revision:4875; number_of_response:1; }","duration":"150.519012ms","start":"2026-06-15T15:50:34.917912Z","end":"2026-06-15T15:50:35.068431Z","steps":["trace[2068932691] 'process raft request' (duration: 150.346586ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:38.631568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.364508ms","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-06-15T15:50:38.631676Z","caller":"traceutil/trace.go:171","msg":"trace[1198426903] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4938; }","duration":"355.507052ms","start":"2026-06-15T15:50:38.276148Z","end":"2026-06-15T15:50:38.631655Z","steps":["trace[1198426903] 'range keys from in-memory index tree' (duration: 354.949894ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:38.631722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:38.27614Z","time spent":"355.571384ms","remote":"127.0.0.1:53884","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-06-15T15:50:38.631766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.330777ms","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-06-15T15:50:38.631885Z","caller":"traceutil/trace.go:171","msg":"trace[366722501] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4938; }","duration":"355.668617ms","start":"2026-06-15T15:50:38.276189Z","end":"2026-06-15T15:50:38.631858Z","steps":["trace[366722501] 'range keys from in-memory index tree' (duration: 355.133049ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:38.631942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:38.276183Z","time spent":"355.748299ms","remote":"127.0.0.1:53884","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-06-15T15:50:38.631972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.848442ms","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-06-15T15:50:38.632006Z","caller":"traceutil/trace.go:171","msg":"trace[1560460227] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4938; }","duration":"355.898004ms","start":"2026-06-15T15:50:38.276098Z","end":"2026-06-15T15:50:38.631996Z","steps":["trace[1560460227] 'range keys from in-memory index tree' (duration: 355.75787ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:38.632033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:38.27609Z","time spent":"355.937865ms","remote":"127.0.0.1:53884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-15T15:50:38.632594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.035345ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T15:50:38.632767Z","caller":"traceutil/trace.go:171","msg":"trace[1043153731] transaction","detail":"{read_only:false; response_revision:4939; number_of_response:1; }","duration":"351.951227ms","start":"2026-06-15T15:50:38.280799Z","end":"2026-06-15T15:50:38.63275Z","steps":["trace[1043153731] 'process raft request' (duration: 245.633023ms)","trace[1043153731] 'compare' (duration: 105.825969ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T15:50:38.632873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:38.280785Z","time spent":"352.02597ms","remote":"127.0.0.1:34614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7527,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T15:50:38.633601Z","caller":"traceutil/trace.go:171","msg":"trace[1727303135] linearizableReadLoop","detail":"{readStateIndex:5127; appliedIndex:5126; }","duration":"222.183643ms","start":"2026-06-15T15:50:38.411403Z","end":"2026-06-15T15:50:38.633587Z","steps":["trace[1727303135] 'read index received' (duration: 115.111035ms)","trace[1727303135] 'applied index is now lower than readState.Index' (duration: 107.070808ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T15:50:38.633741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.329629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:50:38.633838Z","caller":"traceutil/trace.go:171","msg":"trace[690815920] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4939; }","duration":"222.466403ms","start":"2026-06-15T15:50:38.411362Z","end":"2026-06-15T15:50:38.633828Z","steps":["trace[690815920] 'agreement among raft nodes before linearized reading' (duration: 222.336069ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:38.634168Z","caller":"traceutil/trace.go:171","msg":"trace[403475450] transaction","detail":"{read_only:false; response_revision:4940; number_of_response:1; }","duration":"167.085479ms","start":"2026-06-15T15:50:38.467044Z","end":"2026-06-15T15:50:38.63413Z","steps":["trace[403475450] 'process raft request' (duration: 166.732068ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:38.635122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.441575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2206973"} {"level":"info","ts":"2026-06-15T15:50:38.635896Z","caller":"traceutil/trace.go:171","msg":"trace[1972514911] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4940; }","duration":"140.24867ms","start":"2026-06-15T15:50:38.495628Z","end":"2026-06-15T15:50:38.635877Z","steps":["trace[1972514911] 'agreement among raft nodes before linearized reading' (duration: 138.321449ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:39.5138Z","caller":"traceutil/trace.go:171","msg":"trace[1331687339] linearizableReadLoop","detail":"{readStateIndex:5137; appliedIndex:5136; }","duration":"101.127003ms","start":"2026-06-15T15:50:39.412642Z","end":"2026-06-15T15:50:39.513769Z","steps":["trace[1331687339] 'read index received' (duration: 19.042962ms)","trace[1331687339] 'applied index is now lower than readState.Index' (duration: 82.082681ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T15:50:39.51397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.315088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:50:39.514009Z","caller":"traceutil/trace.go:171","msg":"trace[200891260] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4949; }","duration":"101.425392ms","start":"2026-06-15T15:50:39.412571Z","end":"2026-06-15T15:50:39.513996Z","steps":["trace[200891260] 'agreement among raft nodes before linearized reading' (duration: 101.340649ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:39.513998Z","caller":"traceutil/trace.go:171","msg":"trace[1979276721] transaction","detail":"{read_only:false; response_revision:4949; number_of_response:1; }","duration":"188.893407ms","start":"2026-06-15T15:50:39.325039Z","end":"2026-06-15T15:50:39.513932Z","steps":["trace[1979276721] 'process raft request' (duration: 106.705722ms)","trace[1979276721] 'compare' (duration: 81.884496ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:50:42.418741Z","caller":"traceutil/trace.go:171","msg":"trace[262418147] transaction","detail":"{read_only:false; response_revision:4970; number_of_response:1; }","duration":"325.025349ms","start":"2026-06-15T15:50:42.093693Z","end":"2026-06-15T15:50:42.418719Z","steps":["trace[262418147] 'process raft request' (duration: 324.75954ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:42.418889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:42.093669Z","time spent":"325.146643ms","remote":"127.0.0.1:53884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":473,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T15:50:42.419036Z","caller":"traceutil/trace.go:171","msg":"trace[325545247] linearizableReadLoop","detail":"{readStateIndex:5158; appliedIndex:5157; }","duration":"311.350968ms","start":"2026-06-15T15:50:42.107673Z","end":"2026-06-15T15:50:42.419024Z","steps":["trace[325545247] 'read index received' (duration: 310.812791ms)","trace[325545247] 'applied index is now lower than readState.Index' (duration: 537.127µs)"],"step_count":2} {"level":"warn","ts":"2026-06-15T15:50:42.419166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.470562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:50:42.419249Z","caller":"traceutil/trace.go:171","msg":"trace[1250300442] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4970; }","duration":"311.601766ms","start":"2026-06-15T15:50:42.107626Z","end":"2026-06-15T15:50:42.419227Z","steps":["trace[1250300442] 'agreement among raft nodes before linearized reading' (duration: 311.468832ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:42.419294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:42.107607Z","time spent":"311.678779ms","remote":"127.0.0.1:54058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":27,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-06-15T15:50:42.419846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.808053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-15T15:50:42.419892Z","caller":"traceutil/trace.go:171","msg":"trace[549017996] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4971; }","duration":"261.917805ms","start":"2026-06-15T15:50:42.157964Z","end":"2026-06-15T15:50:42.419882Z","steps":["trace[549017996] 'agreement among raft nodes before linearized reading' (duration: 261.823002ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:42.419902Z","caller":"traceutil/trace.go:171","msg":"trace[357522979] transaction","detail":"{read_only:false; response_revision:4971; number_of_response:1; }","duration":"159.271501ms","start":"2026-06-15T15:50:42.260618Z","end":"2026-06-15T15:50:42.419889Z","steps":["trace[357522979] 'process raft request' (duration: 159.064524ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:47.887425Z","caller":"traceutil/trace.go:171","msg":"trace[1085708091] transaction","detail":"{read_only:false; response_revision:5023; number_of_response:1; }","duration":"610.585929ms","start":"2026-06-15T15:50:47.276803Z","end":"2026-06-15T15:50:47.887389Z","steps":["trace[1085708091] 'process raft request' (duration: 610.135064ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:47.887862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:47.27678Z","time spent":"610.725464ms","remote":"127.0.0.1:53884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T15:50:48.527713Z","caller":"traceutil/trace.go:171","msg":"trace[1852115397] transaction","detail":"{read_only:false; response_revision:5024; number_of_response:1; }","duration":"1.177841576s","start":"2026-06-15T15:50:47.349843Z","end":"2026-06-15T15:50:48.527685Z","steps":["trace[1852115397] 'process raft request' (duration: 1.109777724s)","trace[1852115397] 'compare' (duration: 67.041358ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:50:48.527772Z","caller":"traceutil/trace.go:171","msg":"trace[977428041] transaction","detail":"{read_only:false; response_revision:5025; number_of_response:1; }","duration":"1.171444048s","start":"2026-06-15T15:50:47.356297Z","end":"2026-06-15T15:50:48.527741Z","steps":["trace[977428041] 'process raft request' (duration: 1.171087367s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:48.527856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:47.349824Z","time spent":"1.177952569s","remote":"127.0.0.1:53884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T15:50:48.527786Z","caller":"traceutil/trace.go:171","msg":"trace[705640706] linearizableReadLoop","detail":"{readStateIndex:5214; appliedIndex:5212; }","duration":"1.114527471s","start":"2026-06-15T15:50:47.413221Z","end":"2026-06-15T15:50:48.527748Z","steps":["trace[705640706] 'read index received' (duration: 474.215905ms)","trace[705640706] 'applied index is now lower than readState.Index' (duration: 640.308096ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T15:50:48.527941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:47.356274Z","time spent":"1.171569423s","remote":"127.0.0.1:53884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T15:50:48.528053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.114796121s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:50:48.528119Z","caller":"traceutil/trace.go:171","msg":"trace[779992519] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5026; }","duration":"1.114921415s","start":"2026-06-15T15:50:47.41318Z","end":"2026-06-15T15:50:48.528101Z","steps":["trace[779992519] 'agreement among raft nodes before linearized reading' (duration: 1.11477475s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:48.528181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:47.413165Z","time spent":"1.115004627s","remote":"127.0.0.1:53598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-15T15:50:48.5284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"856.14065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-15T15:50:48.528453Z","caller":"traceutil/trace.go:171","msg":"trace[2118673659] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:5026; }","duration":"856.244672ms","start":"2026-06-15T15:50:47.672195Z","end":"2026-06-15T15:50:48.52844Z","steps":["trace[2118673659] 'agreement among raft nodes before linearized reading' (duration: 856.113817ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:48.52849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.004976848s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.162\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-06-15T15:50:48.528522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:47.672173Z","time spent":"856.339786ms","remote":"127.0.0.1:53976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":72,"response size":29,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"info","ts":"2026-06-15T15:50:48.528529Z","caller":"traceutil/trace.go:171","msg":"trace[849028377] range","detail":"{range_begin:/registry/masterleases/199.204.45.162; range_end:; response_count:1; response_revision:5026; }","duration":"1.00504292s","start":"2026-06-15T15:50:47.523472Z","end":"2026-06-15T15:50:48.528514Z","steps":["trace[849028377] 'agreement among raft nodes before linearized reading' (duration: 1.004881875s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:48.528564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:47.523447Z","time spent":"1.005110212s","remote":"127.0.0.1:53644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.162\" "} {"level":"warn","ts":"2026-06-15T15:50:48.528568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"972.801804ms","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-06-15T15:50:48.528619Z","caller":"traceutil/trace.go:171","msg":"trace[189334811] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5026; }","duration":"972.875527ms","start":"2026-06-15T15:50:47.555729Z","end":"2026-06-15T15:50:48.528604Z","steps":["trace[189334811] 'agreement among raft nodes before linearized reading' (duration: 972.700261ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:48.528671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:47.555718Z","time spent":"972.941018ms","remote":"127.0.0.1:53884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-15T15:50:48.528464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.073946316s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"warn","ts":"2026-06-15T15:50:48.528839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"798.52819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16400"} {"level":"warn","ts":"2026-06-15T15:50:48.528998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"794.955685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-06-15T15:50:48.528881Z","caller":"traceutil/trace.go:171","msg":"trace[2137097751] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5026; }","duration":"798.610862ms","start":"2026-06-15T15:50:47.73026Z","end":"2026-06-15T15:50:48.528871Z","steps":["trace[2137097751] 'agreement among raft nodes before linearized reading' (duration: 798.458177ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:48.529205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:47.730239Z","time spent":"798.952233ms","remote":"127.0.0.1:53808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":16422,"request content":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"info","ts":"2026-06-15T15:50:48.529157Z","caller":"traceutil/trace.go:171","msg":"trace[59242882] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5026; }","duration":"795.162481ms","start":"2026-06-15T15:50:47.733967Z","end":"2026-06-15T15:50:48.52913Z","steps":["trace[59242882] 'agreement among raft nodes before linearized reading' (duration: 794.661895ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:48.529332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:47.733936Z","time spent":"795.374768ms","remote":"127.0.0.1:53778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1887,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-06-15T15:50:48.529889Z","caller":"traceutil/trace.go:171","msg":"trace[1967550643] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5026; }","duration":"1.074365608s","start":"2026-06-15T15:50:47.454451Z","end":"2026-06-15T15:50:48.528816Z","steps":["trace[1967550643] 'agreement among raft nodes before linearized reading' (duration: 1.073851191s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:48.529967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:47.454433Z","time spent":"1.075516917s","remote":"127.0.0.1:53808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-15T15:50:48.530385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.03153964s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-15T15:50:48.530436Z","caller":"traceutil/trace.go:171","msg":"trace[2115135549] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5026; }","duration":"1.033452091s","start":"2026-06-15T15:50:47.496969Z","end":"2026-06-15T15:50:48.530421Z","steps":["trace[2115135549] 'agreement among raft nodes before linearized reading' (duration: 1.031391605s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:48.530475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:47.496947Z","time spent":"1.033514164s","remote":"127.0.0.1:53884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-15T15:50:48.528909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"759.218364ms","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-06-15T15:50:48.530807Z","caller":"traceutil/trace.go:171","msg":"trace[732375958] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:5026; }","duration":"761.116416ms","start":"2026-06-15T15:50:47.769643Z","end":"2026-06-15T15:50:48.530759Z","steps":["trace[732375958] 'agreement among raft nodes before linearized reading' (duration: 759.235075ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:48.530945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:47.769622Z","time spent":"761.297051ms","remote":"127.0.0.1:43170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":27,"request content":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true "} {"level":"info","ts":"2026-06-15T15:50:48.820123Z","caller":"traceutil/trace.go:171","msg":"trace[595005386] transaction","detail":"{read_only:false; response_revision:5027; number_of_response:1; }","duration":"284.957038ms","start":"2026-06-15T15:50:48.535109Z","end":"2026-06-15T15:50:48.820066Z","steps":["trace[595005386] 'process raft request' (duration: 251.724708ms)","trace[595005386] 'compare' (duration: 32.762495ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:50:48.820167Z","caller":"traceutil/trace.go:171","msg":"trace[1459777057] transaction","detail":"{read_only:false; response_revision:5028; number_of_response:1; }","duration":"284.467351ms","start":"2026-06-15T15:50:48.535675Z","end":"2026-06-15T15:50:48.820142Z","steps":["trace[1459777057] 'process raft request' (duration: 284.279145ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:48.820237Z","caller":"traceutil/trace.go:171","msg":"trace[654551724] transaction","detail":"{read_only:false; response_revision:5029; number_of_response:1; }","duration":"279.669106ms","start":"2026-06-15T15:50:48.54056Z","end":"2026-06-15T15:50:48.820229Z","steps":["trace[654551724] 'process raft request' (duration: 279.48414ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:48.820413Z","caller":"traceutil/trace.go:171","msg":"trace[1287873924] transaction","detail":"{read_only:false; response_revision:5031; number_of_response:1; }","duration":"134.52977ms","start":"2026-06-15T15:50:48.685862Z","end":"2026-06-15T15:50:48.820391Z","steps":["trace[1287873924] 'process raft request' (duration: 134.348215ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:48.820504Z","caller":"traceutil/trace.go:171","msg":"trace[2078917402] linearizableReadLoop","detail":"{readStateIndex:5219; appliedIndex:5216; }","duration":"219.338766ms","start":"2026-06-15T15:50:48.601154Z","end":"2026-06-15T15:50:48.820493Z","steps":["trace[2078917402] 'read index received' (duration: 185.698182ms)","trace[2078917402] 'applied index is now lower than readState.Index' (duration: 33.639574ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T15:50:48.820707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.543708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-06-15T15:50:48.821851Z","caller":"traceutil/trace.go:171","msg":"trace[1252740053] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5031; }","duration":"287.899503ms","start":"2026-06-15T15:50:48.533928Z","end":"2026-06-15T15:50:48.821827Z","steps":["trace[1252740053] 'agreement among raft nodes before linearized reading' (duration: 286.595291ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:48.822205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.63597ms","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-06-15T15:50:48.82074Z","caller":"traceutil/trace.go:171","msg":"trace[442318519] transaction","detail":"{read_only:false; response_revision:5030; number_of_response:1; }","duration":"218.286122ms","start":"2026-06-15T15:50:48.602445Z","end":"2026-06-15T15:50:48.820731Z","steps":["trace[442318519] 'process raft request' (duration: 217.719414ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:48.822257Z","caller":"traceutil/trace.go:171","msg":"trace[1136550425] 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:5031; }","duration":"217.724603ms","start":"2026-06-15T15:50:48.604516Z","end":"2026-06-15T15:50:48.822241Z","steps":["trace[1136550425] 'agreement among raft nodes before linearized reading' (duration: 217.526147ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:48.820884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.628702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T15:50:48.822451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.402618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-15T15:50:48.8225Z","caller":"traceutil/trace.go:171","msg":"trace[622893036] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5031; }","duration":"102.485231ms","start":"2026-06-15T15:50:48.720001Z","end":"2026-06-15T15:50:48.822486Z","steps":["trace[622893036] 'agreement among raft nodes before linearized reading' (duration: 102.405558ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:48.822801Z","caller":"traceutil/trace.go:171","msg":"trace[139189539] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5031; }","duration":"284.250145ms","start":"2026-06-15T15:50:48.538239Z","end":"2026-06-15T15:50:48.822489Z","steps":["trace[139189539] 'agreement among raft nodes before linearized reading' (duration: 282.622421ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:48.959759Z","caller":"traceutil/trace.go:171","msg":"trace[739381958] transaction","detail":"{read_only:false; response_revision:5033; number_of_response:1; }","duration":"132.34844ms","start":"2026-06-15T15:50:48.827362Z","end":"2026-06-15T15:50:48.95971Z","steps":["trace[739381958] 'process raft request' (duration: 104.893118ms)","trace[739381958] 'compare' (duration: 27.031587ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:50:48.960049Z","caller":"traceutil/trace.go:171","msg":"trace[1041271182] transaction","detail":"{read_only:false; response_revision:5034; number_of_response:1; }","duration":"129.436676ms","start":"2026-06-15T15:50:48.830593Z","end":"2026-06-15T15:50:48.96003Z","steps":["trace[1041271182] 'process raft request' (duration: 128.993692ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:48.960253Z","caller":"traceutil/trace.go:171","msg":"trace[1580477682] linearizableReadLoop","detail":"{readStateIndex:5224; appliedIndex:5222; }","duration":"122.170009ms","start":"2026-06-15T15:50:48.838049Z","end":"2026-06-15T15:50:48.960219Z","steps":["trace[1580477682] 'read index received' (duration: 94.107107ms)","trace[1580477682] 'applied index is now lower than readState.Index' (duration: 28.060502ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T15:50:48.960496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.21957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:17149"} {"level":"info","ts":"2026-06-15T15:50:48.960553Z","caller":"traceutil/trace.go:171","msg":"trace[910997543] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5034; }","duration":"130.326154ms","start":"2026-06-15T15:50:48.830213Z","end":"2026-06-15T15:50:48.960539Z","steps":["trace[910997543] 'agreement among raft nodes before linearized reading' (duration: 130.099897ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:48.960566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.867287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-9a349e07-8270-4be0-a397-9994b73400ed\" ","response":"range_response_count:1 size:1435"} {"level":"info","ts":"2026-06-15T15:50:48.960612Z","caller":"traceutil/trace.go:171","msg":"trace[770235946] range","detail":"{range_begin:/registry/persistentvolumes/pvc-9a349e07-8270-4be0-a397-9994b73400ed; range_end:; response_count:1; response_revision:5034; }","duration":"132.948659ms","start":"2026-06-15T15:50:48.82765Z","end":"2026-06-15T15:50:48.960598Z","steps":["trace[770235946] 'agreement among raft nodes before linearized reading' (duration: 132.719402ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:48.960877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.122495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-15T15:50:48.960955Z","caller":"traceutil/trace.go:171","msg":"trace[1251834697] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:5034; }","duration":"121.243239ms","start":"2026-06-15T15:50:48.839693Z","end":"2026-06-15T15:50:48.960936Z","steps":["trace[1251834697] 'agreement among raft nodes before linearized reading' (duration: 121.106015ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:49.374516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.292582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1988"} {"level":"info","ts":"2026-06-15T15:50:49.3746Z","caller":"traceutil/trace.go:171","msg":"trace[1239708240] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:5035; }","duration":"301.441457ms","start":"2026-06-15T15:50:49.073138Z","end":"2026-06-15T15:50:49.374579Z","steps":["trace[1239708240] 'range keys from in-memory index tree' (duration: 301.113997ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:49.374642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:49.07312Z","time spent":"301.512459ms","remote":"127.0.0.1:53820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":2010,"request content":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" "} {"level":"warn","ts":"2026-06-15T15:50:49.375248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.749426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:50:49.375378Z","caller":"traceutil/trace.go:171","msg":"trace[273053331] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:5035; }","duration":"151.936373ms","start":"2026-06-15T15:50:49.223401Z","end":"2026-06-15T15:50:49.375338Z","steps":["trace[273053331] 'count revisions from in-memory index tree' (duration: 150.810527ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:49.762089Z","caller":"traceutil/trace.go:171","msg":"trace[1517527369] transaction","detail":"{read_only:false; response_revision:5040; number_of_response:1; }","duration":"339.998372ms","start":"2026-06-15T15:50:49.422062Z","end":"2026-06-15T15:50:49.762061Z","steps":["trace[1517527369] 'process raft request' (duration: 250.463089ms)","trace[1517527369] 'compare' (duration: 89.183501ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T15:50:49.762236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:49.422047Z","time spent":"340.110945ms","remote":"127.0.0.1:53704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":736,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T15:50:56.659428Z","caller":"traceutil/trace.go:171","msg":"trace[907896321] transaction","detail":"{read_only:false; response_revision:5076; number_of_response:1; }","duration":"101.235405ms","start":"2026-06-15T15:50:56.558171Z","end":"2026-06-15T15:50:56.659407Z","steps":["trace[907896321] 'process raft request' (duration: 101.09187ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:56.708383Z","caller":"traceutil/trace.go:171","msg":"trace[1599022978] transaction","detail":"{read_only:false; response_revision:5077; number_of_response:1; }","duration":"150.042337ms","start":"2026-06-15T15:50:56.558304Z","end":"2026-06-15T15:50:56.708347Z","steps":["trace[1599022978] 'process raft request' (duration: 149.846021ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:56.708567Z","caller":"traceutil/trace.go:171","msg":"trace[1471429859] transaction","detail":"{read_only:false; response_revision:5078; number_of_response:1; }","duration":"149.564872ms","start":"2026-06-15T15:50:56.558976Z","end":"2026-06-15T15:50:56.708541Z","steps":["trace[1471429859] 'process raft request' (duration: 149.303574ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:51:19.036298Z","caller":"traceutil/trace.go:171","msg":"trace[1153890265] transaction","detail":"{read_only:false; response_revision:5216; number_of_response:1; }","duration":"156.63002ms","start":"2026-06-15T15:51:18.879645Z","end":"2026-06-15T15:51:19.036275Z","steps":["trace[1153890265] 'process raft request' (duration: 156.318199ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:51:27.196258Z","caller":"traceutil/trace.go:171","msg":"trace[318543563] transaction","detail":"{read_only:false; response_revision:5353; number_of_response:1; }","duration":"222.335011ms","start":"2026-06-15T15:51:26.973903Z","end":"2026-06-15T15:51:27.196238Z","steps":["trace[318543563] 'process raft request' (duration: 222.155125ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:51:27.378931Z","caller":"traceutil/trace.go:171","msg":"trace[346150483] transaction","detail":"{read_only:false; response_revision:5354; number_of_response:1; }","duration":"387.601744ms","start":"2026-06-15T15:51:26.991299Z","end":"2026-06-15T15:51:27.3789Z","steps":["trace[346150483] 'process raft request' (duration: 339.671384ms)","trace[346150483] 'compare' (duration: 47.654051ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T15:51:27.3791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:51:26.991264Z","time spent":"387.740569ms","remote":"127.0.0.1:53884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T15:51:27.379204Z","caller":"traceutil/trace.go:171","msg":"trace[806104424] linearizableReadLoop","detail":"{readStateIndex:5555; appliedIndex:5551; }","duration":"279.503548ms","start":"2026-06-15T15:51:27.09967Z","end":"2026-06-15T15:51:27.379174Z","steps":["trace[806104424] 'read index received' (duration: 96.464711ms)","trace[806104424] 'applied index is now lower than readState.Index' (duration: 183.037516ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:51:27.379359Z","caller":"traceutil/trace.go:171","msg":"trace[569891746] transaction","detail":"{read_only:false; response_revision:5356; number_of_response:1; }","duration":"310.661087ms","start":"2026-06-15T15:51:27.068682Z","end":"2026-06-15T15:51:27.379343Z","steps":["trace[569891746] 'process raft request' (duration: 310.389508ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:51:27.379348Z","caller":"traceutil/trace.go:171","msg":"trace[616555684] transaction","detail":"{read_only:false; response_revision:5355; number_of_response:1; }","duration":"311.120282ms","start":"2026-06-15T15:51:27.0682Z","end":"2026-06-15T15:51:27.37932Z","steps":["trace[616555684] 'process raft request' (duration: 310.610135ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:51:27.379488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:51:27.068174Z","time spent":"311.235586ms","remote":"127.0.0.1:53884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T15:51:27.379495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:51:27.068652Z","time spent":"310.74494ms","remote":"127.0.0.1:53884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T15:51:27.379546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.915237ms","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-06-15T15:51:27.379586Z","caller":"traceutil/trace.go:171","msg":"trace[687219215] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5356; }","duration":"234.00186ms","start":"2026-06-15T15:51:27.145572Z","end":"2026-06-15T15:51:27.379573Z","steps":["trace[687219215] 'agreement among raft nodes before linearized reading' (duration: 233.862045ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:51:27.379724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.053297ms","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-06-15T15:51:27.379747Z","caller":"traceutil/trace.go:171","msg":"trace[1600273488] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5356; }","duration":"280.099807ms","start":"2026-06-15T15:51:27.09964Z","end":"2026-06-15T15:51:27.37974Z","steps":["trace[1600273488] 'agreement among raft nodes before linearized reading' (duration: 280.018705ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:51:27.379769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.120449ms","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-06-15T15:51:27.379803Z","caller":"traceutil/trace.go:171","msg":"trace[1776148207] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5356; }","duration":"228.153721ms","start":"2026-06-15T15:51:27.15164Z","end":"2026-06-15T15:51:27.379793Z","steps":["trace[1776148207] 'agreement among raft nodes before linearized reading' (duration: 228.028166ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:51:27.379855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.989934ms","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-06-15T15:51:27.379879Z","caller":"traceutil/trace.go:171","msg":"trace[2080670589] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5356; }","duration":"230.036286ms","start":"2026-06-15T15:51:27.149836Z","end":"2026-06-15T15:51:27.379872Z","steps":["trace[2080670589] 'agreement among raft nodes before linearized reading' (duration: 229.969143ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:51:27.379929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.570015ms","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-06-15T15:51:27.379954Z","caller":"traceutil/trace.go:171","msg":"trace[2126486673] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5356; }","duration":"223.608486ms","start":"2026-06-15T15:51:27.156338Z","end":"2026-06-15T15:51:27.379946Z","steps":["trace[2126486673] 'agreement among raft nodes before linearized reading' (duration: 223.531894ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:51:27.600135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.064096ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T15:51:27.600255Z","caller":"traceutil/trace.go:171","msg":"trace[98348565] linearizableReadLoop","detail":"{readStateIndex:5561; appliedIndex:5560; }","duration":"133.429398ms","start":"2026-06-15T15:51:27.466803Z","end":"2026-06-15T15:51:27.600233Z","steps":["trace[98348565] 'read index received' (duration: 30.110964ms)","trace[98348565] 'applied index is now lower than readState.Index' (duration: 103.316384ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:51:27.600378Z","caller":"traceutil/trace.go:171","msg":"trace[1211153648] transaction","detail":"{read_only:false; response_revision:5362; number_of_response:1; }","duration":"143.430628ms","start":"2026-06-15T15:51:27.456926Z","end":"2026-06-15T15:51:27.600357Z","steps":["trace[1211153648] 'process raft request' (duration: 40.034881ms)","trace[1211153648] 'compare' (duration: 102.212657ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T15:51:27.601004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.179673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:51:27.602697Z","caller":"traceutil/trace.go:171","msg":"trace[835905080] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5362; }","duration":"135.904243ms","start":"2026-06-15T15:51:27.46677Z","end":"2026-06-15T15:51:27.602674Z","steps":["trace[835905080] 'agreement among raft nodes before linearized reading' (duration: 134.181053ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:51:27.898478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.598939ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T15:51:27.898587Z","caller":"traceutil/trace.go:171","msg":"trace[930749494] transaction","detail":"{read_only:false; response_revision:5363; number_of_response:1; }","duration":"204.705773ms","start":"2026-06-15T15:51:27.693862Z","end":"2026-06-15T15:51:27.898567Z","steps":["trace[930749494] 'process raft request' (duration: 74.921018ms)","trace[930749494] 'compare' (duration: 129.475865ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:51:48.354671Z","caller":"traceutil/trace.go:171","msg":"trace[1897003780] transaction","detail":"{read_only:false; response_revision:5502; number_of_response:1; }","duration":"138.44899ms","start":"2026-06-15T15:51:48.216186Z","end":"2026-06-15T15:51:48.354635Z","steps":["trace[1897003780] 'process raft request' (duration: 110.313265ms)","trace[1897003780] 'compare' (duration: 27.856355ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:51:54.558371Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2919} {"level":"info","ts":"2026-06-15T15:51:54.694299Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2919,"took":"133.624494ms","hash":76456411,"current-db-size-bytes":54091776,"current-db-size":"54 MB","current-db-size-in-use-bytes":28905472,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-15T15:51:54.694385Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":76456411,"revision":2919,"compact-revision":-1} {"level":"info","ts":"2026-06-15T15:53:34.257146Z","caller":"traceutil/trace.go:171","msg":"trace[1814965094] linearizableReadLoop","detail":"{readStateIndex:6380; appliedIndex:6377; }","duration":"148.670968ms","start":"2026-06-15T15:53:34.108447Z","end":"2026-06-15T15:53:34.257118Z","steps":["trace[1814965094] 'read index received' (duration: 42.032463ms)","trace[1814965094] 'applied index is now lower than readState.Index' (duration: 106.636905ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:53:34.257634Z","caller":"traceutil/trace.go:171","msg":"trace[1947091215] transaction","detail":"{read_only:false; response_revision:6152; number_of_response:1; }","duration":"172.251943ms","start":"2026-06-15T15:53:34.085363Z","end":"2026-06-15T15:53:34.257615Z","steps":["trace[1947091215] 'process raft request' (duration: 93.73673ms)","trace[1947091215] 'compare' (duration: 77.785737ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:53:34.258082Z","caller":"traceutil/trace.go:171","msg":"trace[1692275113] transaction","detail":"{read_only:false; response_revision:6153; number_of_response:1; }","duration":"172.607247ms","start":"2026-06-15T15:53:34.085462Z","end":"2026-06-15T15:53:34.258069Z","steps":["trace[1692275113] 'process raft request' (duration: 171.564849ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:53:34.258055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.502448ms","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-06-15T15:53:34.258935Z","caller":"traceutil/trace.go:171","msg":"trace[253269135] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6153; }","duration":"150.40137ms","start":"2026-06-15T15:53:34.10851Z","end":"2026-06-15T15:53:34.258912Z","steps":["trace[253269135] 'agreement among raft nodes before linearized reading' (duration: 149.418015ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:53:34.25857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.10021ms","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-06-15T15:53:34.25959Z","caller":"traceutil/trace.go:171","msg":"trace[1361778565] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6153; }","duration":"151.149228ms","start":"2026-06-15T15:53:34.108402Z","end":"2026-06-15T15:53:34.259551Z","steps":["trace[1361778565] 'agreement among raft nodes before linearized reading' (duration: 150.097739ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:54:24.702603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.330997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-15T15:54:24.702691Z","caller":"traceutil/trace.go:171","msg":"trace[892714212] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6593; }","duration":"142.465433ms","start":"2026-06-15T15:54:24.560206Z","end":"2026-06-15T15:54:24.702671Z","steps":["trace[892714212] 'range keys from in-memory index tree' (duration: 142.163981ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:54:24.702716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.819639ms","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-06-15T15:54:24.70328Z","caller":"traceutil/trace.go:171","msg":"trace[443285894] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6593; }","duration":"142.415981ms","start":"2026-06-15T15:54:24.560843Z","end":"2026-06-15T15:54:24.703258Z","steps":["trace[443285894] 'range keys from in-memory index tree' (duration: 141.658212ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:54:24.703033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.802569ms","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-06-15T15:54:24.703042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.78544ms","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-06-15T15:54:24.703735Z","caller":"traceutil/trace.go:171","msg":"trace[784124008] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6593; }","duration":"145.478245ms","start":"2026-06-15T15:54:24.558225Z","end":"2026-06-15T15:54:24.703703Z","steps":["trace[784124008] 'range keys from in-memory index tree' (duration: 144.659475ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:54:24.703907Z","caller":"traceutil/trace.go:171","msg":"trace[1585247571] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6593; }","duration":"167.643409ms","start":"2026-06-15T15:54:24.53618Z","end":"2026-06-15T15:54:24.703824Z","steps":["trace[1585247571] 'range keys from in-memory index tree' (duration: 166.632482ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:54:38.717735Z","caller":"traceutil/trace.go:171","msg":"trace[332360854] transaction","detail":"{read_only:false; response_revision:6669; number_of_response:1; }","duration":"116.869254ms","start":"2026-06-15T15:54:38.60084Z","end":"2026-06-15T15:54:38.717709Z","steps":["trace[332360854] 'process raft request' (duration: 116.701815ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:54:39.038489Z","caller":"traceutil/trace.go:171","msg":"trace[1355275711] transaction","detail":"{read_only:false; response_revision:6673; number_of_response:1; }","duration":"197.887217ms","start":"2026-06-15T15:54:38.840581Z","end":"2026-06-15T15:54:39.038468Z","steps":["trace[1355275711] 'process raft request' (duration: 105.429761ms)","trace[1355275711] 'compare' (duration: 92.300737ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:54:49.189069Z","caller":"traceutil/trace.go:171","msg":"trace[2111747618] transaction","detail":"{read_only:false; response_revision:6778; number_of_response:1; }","duration":"105.765652ms","start":"2026-06-15T15:54:49.083272Z","end":"2026-06-15T15:54:49.189037Z","steps":["trace[2111747618] 'process raft request' (duration: 105.459683ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:54:49.189719Z","caller":"traceutil/trace.go:171","msg":"trace[763030270] transaction","detail":"{read_only:false; response_revision:6779; number_of_response:1; }","duration":"104.215436ms","start":"2026-06-15T15:54:49.085481Z","end":"2026-06-15T15:54:49.189696Z","steps":["trace[763030270] 'process raft request' (duration: 103.327837ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:54:56.082321Z","caller":"traceutil/trace.go:171","msg":"trace[590135980] linearizableReadLoop","detail":"{readStateIndex:7062; appliedIndex:7061; }","duration":"294.086296ms","start":"2026-06-15T15:54:55.788213Z","end":"2026-06-15T15:54:56.082299Z","steps":["trace[590135980] 'read index received' (duration: 293.880386ms)","trace[590135980] 'applied index is now lower than readState.Index' (duration: 204.95µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:54:56.08247Z","caller":"traceutil/trace.go:171","msg":"trace[1281724235] transaction","detail":"{read_only:false; response_revision:6812; number_of_response:1; }","duration":"312.113082ms","start":"2026-06-15T15:54:55.770338Z","end":"2026-06-15T15:54:56.082451Z","steps":["trace[1281724235] 'process raft request' (duration: 311.806753ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:54:56.08261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:54:55.770318Z","time spent":"312.208422ms","remote":"127.0.0.1:53884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T15:54:56.082758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.519705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-15T15:54:56.082834Z","caller":"traceutil/trace.go:171","msg":"trace[1467298692] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:6812; }","duration":"294.640585ms","start":"2026-06-15T15:54:55.788175Z","end":"2026-06-15T15:54:56.082816Z","steps":["trace[1467298692] 'agreement among raft nodes before linearized reading' (duration: 294.483065ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:54:56.083186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.795233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/ingress-nginx/\" range_end:\"/registry/secrets/ingress-nginx0\" ","response":"range_response_count:2 size:107255"} {"level":"info","ts":"2026-06-15T15:54:56.083229Z","caller":"traceutil/trace.go:171","msg":"trace[1524999905] range","detail":"{range_begin:/registry/secrets/ingress-nginx/; range_end:/registry/secrets/ingress-nginx0; response_count:2; response_revision:6812; }","duration":"257.879793ms","start":"2026-06-15T15:54:55.825338Z","end":"2026-06-15T15:54:56.083218Z","steps":["trace[1524999905] 'agreement among raft nodes before linearized reading' (duration: 257.745634ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:56:54.56449Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5554} {"level":"info","ts":"2026-06-15T15:56:54.651605Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5554,"took":"85.324135ms","hash":3865653836,"current-db-size-bytes":54091776,"current-db-size":"54 MB","current-db-size-in-use-bytes":18460672,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-15T15:56:54.651663Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3865653836,"revision":5554,"compact-revision":2919}