{"level":"warn","ts":"2026-06-28T19:48:53.384368Z","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-28T19:48:53.384457Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.216: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.216:2380","--initial-cluster=instance=https://199.204.45.216:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.216:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.216: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-28T19:48:53.384539Z","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-28T19:48:53.38455Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.216:2380"]} {"level":"info","ts":"2026-06-28T19:48:53.384567Z","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-28T19:48:53.385161Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"]} {"level":"info","ts":"2026-06-28T19:48:53.385238Z","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.216:2380"],"listen-peer-urls":["https://199.204.45.216:2380"],"advertise-client-urls":["https://199.204.45.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.216: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-28T19:48:53.469889Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"84.437524ms"} {"level":"info","ts":"2026-06-28T19:48:53.654942Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4e98569549cc430c","cluster-id":"65d70b4d1d4a8bf9"} {"level":"info","ts":"2026-06-28T19:48:53.655175Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=()"} {"level":"info","ts":"2026-06-28T19:48:53.655229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became follower at term 0"} {"level":"info","ts":"2026-06-28T19:48:53.655251Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4e98569549cc430c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-28T19:48:53.65526Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became follower at term 1"} {"level":"info","ts":"2026-06-28T19:48:53.655352Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=(5663371730606637836)"} {"level":"warn","ts":"2026-06-28T19:48:53.699016Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-28T19:48:53.70527Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-28T19:48:53.708989Z","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-28T19:48:53.714574Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4e98569549cc430c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-28T19:48:53.714789Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4e98569549cc430c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-28T19:48:53.715044Z","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-28T19:48:53.71512Z","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-28T19:48:53.715271Z","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-28T19:48:53.71735Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=(5663371730606637836)"} {"level":"info","ts":"2026-06-28T19:48:53.72164Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"65d70b4d1d4a8bf9","local-member-id":"4e98569549cc430c","added-peer-id":"4e98569549cc430c","added-peer-peer-urls":["https://199.204.45.216:2380"]} {"level":"info","ts":"2026-06-28T19:48:53.723072Z","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-28T19:48:53.723202Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.216:2380"} {"level":"info","ts":"2026-06-28T19:48:53.723228Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.216:2380"} {"level":"info","ts":"2026-06-28T19:48:53.723337Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4e98569549cc430c","initial-advertise-peer-urls":["https://199.204.45.216:2380"],"listen-peer-urls":["https://199.204.45.216:2380"],"advertise-client-urls":["https://199.204.45.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-28T19:48:53.723375Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-28T19:48:54.564822Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c is starting a new election at term 1"} {"level":"info","ts":"2026-06-28T19:48:54.564863Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became pre-candidate at term 1"} {"level":"info","ts":"2026-06-28T19:48:54.564883Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c received MsgPreVoteResp from 4e98569549cc430c at term 1"} {"level":"info","ts":"2026-06-28T19:48:54.564894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became candidate at term 2"} {"level":"info","ts":"2026-06-28T19:48:54.564899Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c received MsgVoteResp from 4e98569549cc430c at term 2"} {"level":"info","ts":"2026-06-28T19:48:54.564911Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became leader at term 2"} {"level":"info","ts":"2026-06-28T19:48:54.564921Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4e98569549cc430c elected leader 4e98569549cc430c at term 2"} {"level":"info","ts":"2026-06-28T19:48:54.586141Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-28T19:48:54.606435Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4e98569549cc430c","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.216:2379]}","request-path":"/0/members/4e98569549cc430c/attributes","cluster-id":"65d70b4d1d4a8bf9","publish-timeout":"7s"} {"level":"info","ts":"2026-06-28T19:48:54.60645Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-28T19:48:54.606699Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-28T19:48:54.607031Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-28T19:48:54.607059Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-28T19:48:54.607399Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"65d70b4d1d4a8bf9","local-member-id":"4e98569549cc430c","cluster-version":"3.5"} {"level":"info","ts":"2026-06-28T19:48:54.607563Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-28T19:48:54.607624Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-28T19:48:54.608371Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.216:2379"} {"level":"info","ts":"2026-06-28T19:48:54.610265Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-28T19:48:56.4436Z","caller":"traceutil/trace.go:171","msg":"trace[154980196] transaction","detail":"{read_only:false; response_revision:65; number_of_response:1; }","duration":"100.155718ms","start":"2026-06-28T19:48:56.343394Z","end":"2026-06-28T19:48:56.44355Z","steps":["trace[154980196] 'process raft request' (duration: 75.703855ms)","trace[154980196] 'compare' (duration: 24.254455ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:48:57.906842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.846529ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:48:57.907074Z","caller":"traceutil/trace.go:171","msg":"trace[241685222] transaction","detail":"{read_only:false; response_revision:189; number_of_response:1; }","duration":"140.731826ms","start":"2026-06-28T19:48:57.766318Z","end":"2026-06-28T19:48:57.90705Z","steps":["trace[241685222] 'process raft request' (duration: 14.993897ms)","trace[241685222] 'compare' (duration: 124.649151ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:49:13.485223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.984897ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-28T19:49:30.336858Z","caller":"traceutil/trace.go:171","msg":"trace[822481375] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"100.157933ms","start":"2026-06-28T19:49:30.236674Z","end":"2026-06-28T19:49:30.336832Z","steps":["trace[822481375] 'process raft request' (duration: 100.110382ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:49:30.337442Z","caller":"traceutil/trace.go:171","msg":"trace[1145834538] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"137.750169ms","start":"2026-06-28T19:49:30.199678Z","end":"2026-06-28T19:49:30.337428Z","steps":["trace[1145834538] 'process raft request' (duration: 136.727988ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:49:30.337568Z","caller":"traceutil/trace.go:171","msg":"trace[306569278] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"144.285061ms","start":"2026-06-28T19:49:30.193271Z","end":"2026-06-28T19:49:30.337556Z","steps":["trace[306569278] 'process raft request' (duration: 142.920938ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:49:30.337598Z","caller":"traceutil/trace.go:171","msg":"trace[1309145264] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"144.214179ms","start":"2026-06-28T19:49:30.193377Z","end":"2026-06-28T19:49:30.337591Z","steps":["trace[1309145264] 'process raft request' (duration: 142.907048ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:49:30.337624Z","caller":"traceutil/trace.go:171","msg":"trace[697384156] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"137.978825ms","start":"2026-06-28T19:49:30.199638Z","end":"2026-06-28T19:49:30.337616Z","steps":["trace[697384156] 'process raft request' (duration: 136.725337ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:49:30.337766Z","caller":"traceutil/trace.go:171","msg":"trace[211630959] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"131.418612ms","start":"2026-06-28T19:49:30.206282Z","end":"2026-06-28T19:49:30.337701Z","steps":["trace[211630959] 'process raft request' (duration: 130.264627ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:49:30.337872Z","caller":"traceutil/trace.go:171","msg":"trace[696373771] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"133.530038ms","start":"2026-06-28T19:49:30.20432Z","end":"2026-06-28T19:49:30.33785Z","steps":["trace[696373771] 'process raft request' (duration: 132.126475ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:49:30.337919Z","caller":"traceutil/trace.go:171","msg":"trace[322271394] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"132.163156ms","start":"2026-06-28T19:49:30.205743Z","end":"2026-06-28T19:49:30.337906Z","steps":["trace[322271394] 'process raft request' (duration: 130.766803ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:49:30.337964Z","caller":"traceutil/trace.go:171","msg":"trace[1185805020] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"127.221202ms","start":"2026-06-28T19:49:30.210734Z","end":"2026-06-28T19:49:30.337955Z","steps":["trace[1185805020] 'process raft request' (duration: 125.888261ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:49:30.338003Z","caller":"traceutil/trace.go:171","msg":"trace[795097670] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"121.732673ms","start":"2026-06-28T19:49:30.21626Z","end":"2026-06-28T19:49:30.337993Z","steps":["trace[795097670] 'process raft request' (duration: 120.436342ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:49:31.533759Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831411390375207795,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-28T19:49:31.814386Z","caller":"traceutil/trace.go:171","msg":"trace[2048738759] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"806.43976ms","start":"2026-06-28T19:49:31.007915Z","end":"2026-06-28T19:49:31.814355Z","steps":["trace[2048738759] 'process raft request' (duration: 789.903442ms)","trace[2048738759] 'compare' (duration: 15.712693ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:49:31.814627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:49:31.00789Z","time spent":"806.557754ms","remote":"127.0.0.1:57852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":74745,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:49:31.816366Z","caller":"traceutil/trace.go:171","msg":"trace[450764734] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"796.814976ms","start":"2026-06-28T19:49:31.019541Z","end":"2026-06-28T19:49:31.816356Z","steps":["trace[450764734] 'process raft request' (duration: 795.910767ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:49:31.816416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:49:31.019502Z","time spent":"796.890108ms","remote":"127.0.0.1:57852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98698,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:49:31.816914Z","caller":"traceutil/trace.go:171","msg":"trace[194658277] linearizableReadLoop","detail":"{readStateIndex:569; appliedIndex:566; }","duration":"783.724233ms","start":"2026-06-28T19:49:31.033153Z","end":"2026-06-28T19:49:31.816878Z","steps":["trace[194658277] 'read index received' (duration: 764.676939ms)","trace[194658277] 'applied index is now lower than readState.Index' (duration: 19.045774ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:49:31.817056Z","caller":"traceutil/trace.go:171","msg":"trace[1693626921] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"690.037048ms","start":"2026-06-28T19:49:31.127006Z","end":"2026-06-28T19:49:31.817043Z","steps":["trace[1693626921] 'process raft request' (duration: 689.205532ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:49:31.81715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:49:31.126986Z","time spent":"690.10261ms","remote":"127.0.0.1:57852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-28T19:49:31.817409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"784.255039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:49:31.817431Z","caller":"traceutil/trace.go:171","msg":"trace[998201999] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:547; }","duration":"784.324391ms","start":"2026-06-28T19:49:31.033101Z","end":"2026-06-28T19:49:31.817425Z","steps":["trace[998201999] 'agreement among raft nodes before linearized reading' (duration: 784.230638ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:49:31.817445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:49:31.033045Z","time spent":"784.397134ms","remote":"127.0.0.1:53964","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-28T19:49:31.817572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"763.45108ms","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-28T19:49:31.817588Z","caller":"traceutil/trace.go:171","msg":"trace[1370545680] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:547; }","duration":"763.489932ms","start":"2026-06-28T19:49:31.054093Z","end":"2026-06-28T19:49:31.817583Z","steps":["trace[1370545680] 'agreement among raft nodes before linearized reading' (duration: 763.42185ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:49:31.8176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:49:31.054082Z","time spent":"763.516052ms","remote":"127.0.0.1:58066","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-28T19:49:37.910483Z","caller":"traceutil/trace.go:171","msg":"trace[617726999] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"309.264815ms","start":"2026-06-28T19:49:37.601185Z","end":"2026-06-28T19:49:37.910449Z","steps":["trace[617726999] 'process raft request' (duration: 309.131602ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:49:37.910652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:49:37.601156Z","time spent":"309.402509ms","remote":"127.0.0.1:58050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-28T19:49:38.780005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.965056ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:49:38.780144Z","caller":"traceutil/trace.go:171","msg":"trace[405318022] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:594; }","duration":"573.10818ms","start":"2026-06-28T19:49:38.207009Z","end":"2026-06-28T19:49:38.780117Z","steps":["trace[405318022] 'range keys from in-memory index tree' (duration: 572.947496ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:49:38.780166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.109444ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:49:38.780266Z","caller":"traceutil/trace.go:171","msg":"trace[1887174792] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:617; }","duration":"832.914846ms","start":"2026-06-28T19:49:37.94733Z","end":"2026-06-28T19:49:38.780245Z","steps":["trace[1887174792] 'read index received' (duration: 391.628006ms)","trace[1887174792] 'applied index is now lower than readState.Index' (duration: 441.28559ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:49:38.780346Z","caller":"traceutil/trace.go:171","msg":"trace[736694713] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"850.59214ms","start":"2026-06-28T19:49:37.929739Z","end":"2026-06-28T19:49:38.780331Z","steps":["trace[736694713] 'process raft request' (duration: 409.204007ms)","trace[736694713] 'compare' (duration: 440.614091ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:49:38.780382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"833.0524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:49:38.780452Z","caller":"traceutil/trace.go:171","msg":"trace[280160776] range","detail":"{range_begin:/registry/limitranges/envoy-gateway-system/; range_end:/registry/limitranges/envoy-gateway-system0; response_count:0; response_revision:595; }","duration":"833.142613ms","start":"2026-06-28T19:49:37.94726Z","end":"2026-06-28T19:49:38.780403Z","steps":["trace[280160776] 'agreement among raft nodes before linearized reading' (duration: 833.066951ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:49:38.780482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:49:37.929722Z","time spent":"850.656931ms","remote":"127.0.0.1:57982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:49:38.782237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"777.275172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.216\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-28T19:49:38.782276Z","caller":"traceutil/trace.go:171","msg":"trace[1245494866] range","detail":"{range_begin:/registry/masterleases/199.204.45.216; range_end:; response_count:1; response_revision:595; }","duration":"777.349304ms","start":"2026-06-28T19:49:38.004917Z","end":"2026-06-28T19:49:38.782266Z","steps":["trace[1245494866] 'agreement among raft nodes before linearized reading' (duration: 775.601474ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:49:38.782683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:49:38.004893Z","time spent":"777.780736ms","remote":"127.0.0.1:57844","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.216\" "} {"level":"warn","ts":"2026-06-28T19:49:38.780487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:49:37.947243Z","time spent":"833.234436ms","remote":"127.0.0.1:57930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" "} {"level":"warn","ts":"2026-06-28T19:49:38.7828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.535486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-28T19:49:38.782842Z","caller":"traceutil/trace.go:171","msg":"trace[1223544586] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:595; }","duration":"377.604478ms","start":"2026-06-28T19:49:38.405226Z","end":"2026-06-28T19:49:38.78283Z","steps":["trace[1223544586] 'agreement among raft nodes before linearized reading' (duration: 377.460834ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:49:38.782852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"739.044101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-28T19:49:38.782874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:49:38.405209Z","time spent":"377.658149ms","remote":"127.0.0.1:58066","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-28T19:49:38.7829Z","caller":"traceutil/trace.go:171","msg":"trace[791847842] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:595; }","duration":"739.119534ms","start":"2026-06-28T19:49:38.043766Z","end":"2026-06-28T19:49:38.782885Z","steps":["trace[791847842] 'agreement among raft nodes before linearized reading' (duration: 739.051512ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:49:38.782897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"668.282217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-28T19:49:38.782934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:49:38.043747Z","time spent":"739.180526ms","remote":"127.0.0.1:53964","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-28T19:49:38.782956Z","caller":"traceutil/trace.go:171","msg":"trace[2109526292] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:595; }","duration":"668.38438ms","start":"2026-06-28T19:49:38.114553Z","end":"2026-06-28T19:49:38.782938Z","steps":["trace[2109526292] 'agreement among raft nodes before linearized reading' (duration: 668.148144ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:49:38.782997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:49:38.114522Z","time spent":"668.466553ms","remote":"127.0.0.1:58066","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-28T19:49:38.783057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.393571ms","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-28T19:49:38.783091Z","caller":"traceutil/trace.go:171","msg":"trace[1071764430] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:595; }","duration":"330.472533ms","start":"2026-06-28T19:49:38.452608Z","end":"2026-06-28T19:49:38.783081Z","steps":["trace[1071764430] 'agreement among raft nodes before linearized reading' (duration: 330.37943ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:49:38.783117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:49:38.452569Z","time spent":"330.542415ms","remote":"127.0.0.1:58066","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-28T19:49:38.941784Z","caller":"traceutil/trace.go:171","msg":"trace[1083411152] linearizableReadLoop","detail":"{readStateIndex:619; appliedIndex:618; }","duration":"155.83059ms","start":"2026-06-28T19:49:38.785928Z","end":"2026-06-28T19:49:38.941758Z","steps":["trace[1083411152] 'read index received' (duration: 105.818773ms)","trace[1083411152] 'applied index is now lower than readState.Index' (duration: 50.010837ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:49:38.94199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.027727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:49:38.942101Z","caller":"traceutil/trace.go:171","msg":"trace[995073732] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:596; }","duration":"156.350806ms","start":"2026-06-28T19:49:38.785733Z","end":"2026-06-28T19:49:38.942084Z","steps":["trace[995073732] 'agreement among raft nodes before linearized reading' (duration: 156.120469ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:49:38.942162Z","caller":"traceutil/trace.go:171","msg":"trace[1595832872] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"156.848981ms","start":"2026-06-28T19:49:38.785287Z","end":"2026-06-28T19:49:38.942136Z","steps":["trace[1595832872] 'process raft request' (duration: 106.445861ms)","trace[1595832872] 'compare' (duration: 49.885185ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:49:38.958458Z","caller":"traceutil/trace.go:171","msg":"trace[598677337] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"170.885504ms","start":"2026-06-28T19:49:38.787551Z","end":"2026-06-28T19:49:38.958436Z","steps":["trace[598677337] 'process raft request' (duration: 170.707569ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:49:38.958537Z","caller":"traceutil/trace.go:171","msg":"trace[1182348109] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"170.882044ms","start":"2026-06-28T19:49:38.787618Z","end":"2026-06-28T19:49:38.9585Z","steps":["trace[1182348109] 'process raft request' (duration: 170.719929ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:49:38.958488Z","caller":"traceutil/trace.go:171","msg":"trace[398834217] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"170.621897ms","start":"2026-06-28T19:49:38.787846Z","end":"2026-06-28T19:49:38.958468Z","steps":["trace[398834217] 'process raft request' (duration: 170.560195ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:49:40.408995Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.450788371s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-28T19:49:40.526502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.100587ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:49:40.526787Z","caller":"traceutil/trace.go:171","msg":"trace[1654005211] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"1.578539363s","start":"2026-06-28T19:49:38.948231Z","end":"2026-06-28T19:49:40.52677Z","steps":["trace[1654005211] 'process raft request' (duration: 1.578453611s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:49:40.526873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:49:38.948213Z","time spent":"1.578614816s","remote":"127.0.0.1:58050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:49:40.526961Z","caller":"traceutil/trace.go:171","msg":"trace[1019840405] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"1.579832031s","start":"2026-06-28T19:49:38.947076Z","end":"2026-06-28T19:49:40.526908Z","steps":["trace[1019840405] 'process raft request' (duration: 1.462263891s)","trace[1019840405] 'compare' (duration: 117.013015ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:49:40.527046Z","caller":"traceutil/trace.go:171","msg":"trace[1237000438] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"1.579135071s","start":"2026-06-28T19:49:38.947901Z","end":"2026-06-28T19:49:40.527036Z","steps":["trace[1237000438] 'process raft request' (duration: 1.578734459s)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:49:40.527081Z","caller":"traceutil/trace.go:171","msg":"trace[388434459] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"1.579206523s","start":"2026-06-28T19:49:38.947867Z","end":"2026-06-28T19:49:40.527074Z","steps":["trace[388434459] 'process raft request' (duration: 1.578717299s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:49:40.527147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:49:38.947839Z","time spent":"1.579291226s","remote":"127.0.0.1:57894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-28T19:49:40.527106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:49:38.947883Z","time spent":"1.579193383s","remote":"127.0.0.1:57982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:49:40.527332Z","caller":"traceutil/trace.go:171","msg":"trace[1049524385] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:623; }","duration":"585.47721ms","start":"2026-06-28T19:49:39.941843Z","end":"2026-06-28T19:49:40.52732Z","steps":["trace[1049524385] 'read index received' (duration: 467.417735ms)","trace[1049524385] 'applied index is now lower than readState.Index' (duration: 118.058345ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:49:40.527519Z","caller":"traceutil/trace.go:171","msg":"trace[1289857667] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"1.56798812s","start":"2026-06-28T19:49:38.95952Z","end":"2026-06-28T19:49:40.527508Z","steps":["trace[1289857667] 'process raft request' (duration: 1.567210108s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:49:40.527578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:49:38.959505Z","time spent":"1.568042882s","remote":"127.0.0.1:57844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:49:40.527052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:49:38.947053Z","time spent":"1.579940625s","remote":"127.0.0.1:57894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-28T19:49:40.527783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.942394ms","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-28T19:49:40.527816Z","caller":"traceutil/trace.go:171","msg":"trace[14358655] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:604; }","duration":"586.011706ms","start":"2026-06-28T19:49:39.941796Z","end":"2026-06-28T19:49:40.527808Z","steps":["trace[14358655] 'agreement among raft nodes before linearized reading' (duration: 585.897933ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:49:40.527843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:49:39.941778Z","time spent":"586.058457ms","remote":"127.0.0.1:58066","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-28T19:49:40.527974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.499157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:49:40.528013Z","caller":"traceutil/trace.go:171","msg":"trace[29581198] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:604; }","duration":"493.572489ms","start":"2026-06-28T19:49:40.034432Z","end":"2026-06-28T19:49:40.528004Z","steps":["trace[29581198] 'agreement among raft nodes before linearized reading' (duration: 493.520038ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:49:40.528035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:49:40.034409Z","time spent":"493.620471ms","remote":"127.0.0.1:53964","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-28T19:49:42.293377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.177563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:49:42.29346Z","caller":"traceutil/trace.go:171","msg":"trace[779752322] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:639; }","duration":"116.311747ms","start":"2026-06-28T19:49:42.177128Z","end":"2026-06-28T19:49:42.29344Z","steps":["trace[779752322] 'range keys from in-memory index tree' (duration: 116.090851ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:49:45.456618Z","caller":"traceutil/trace.go:171","msg":"trace[73220239] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"452.284843ms","start":"2026-06-28T19:49:45.004302Z","end":"2026-06-28T19:49:45.456587Z","steps":["trace[73220239] 'process raft request' (duration: 452.003295ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:49:45.456747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.267323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:49:45.456803Z","caller":"traceutil/trace.go:171","msg":"trace[1167834368] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:675; }","duration":"411.363086ms","start":"2026-06-28T19:49:45.045427Z","end":"2026-06-28T19:49:45.45679Z","steps":["trace[1167834368] 'agreement among raft nodes before linearized reading' (duration: 411.237912ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:49:45.456804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:49:45.003684Z","time spent":"453.047843ms","remote":"127.0.0.1:57852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187246,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-28T19:49:45.456833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:49:45.045412Z","time spent":"411.414997ms","remote":"127.0.0.1:53964","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-28T19:49:45.457144Z","caller":"traceutil/trace.go:171","msg":"trace[1292336899] linearizableReadLoop","detail":"{readStateIndex:701; appliedIndex:700; }","duration":"410.991926ms","start":"2026-06-28T19:49:45.045461Z","end":"2026-06-28T19:49:45.456453Z","steps":["trace[1292336899] 'read index received' (duration: 410.966015ms)","trace[1292336899] 'applied index is now lower than readState.Index' (duration: 24.521µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:49:45.81284Z","caller":"traceutil/trace.go:171","msg":"trace[1799728072] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"481.737019ms","start":"2026-06-28T19:49:45.331043Z","end":"2026-06-28T19:49:45.81278Z","steps":["trace[1799728072] 'process raft request' (duration: 481.499741ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:49:45.812995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:49:45.331015Z","time spent":"481.906103ms","remote":"127.0.0.1:57894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-28T19:49:45.813007Z","caller":"traceutil/trace.go:171","msg":"trace[352987758] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"411.426218ms","start":"2026-06-28T19:49:45.401546Z","end":"2026-06-28T19:49:45.812972Z","steps":["trace[352987758] 'process raft request' (duration: 411.148371ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:49:45.813123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:49:45.40152Z","time spent":"411.550462ms","remote":"127.0.0.1:57852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187455,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-28T19:49:45.813284Z","caller":"traceutil/trace.go:171","msg":"trace[1879031212] linearizableReadLoop","detail":"{readStateIndex:703; appliedIndex:701; }","duration":"355.670902ms","start":"2026-06-28T19:49:45.457192Z","end":"2026-06-28T19:49:45.812863Z","steps":["trace[1879031212] 'read index received' (duration: 355.314822ms)","trace[1879031212] 'applied index is now lower than readState.Index' (duration: 355.06µs)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:49:45.813331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.489083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:1 size:4333"} {"level":"info","ts":"2026-06-28T19:49:45.813504Z","caller":"traceutil/trace.go:171","msg":"trace[1734909328] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:1; response_revision:677; }","duration":"625.72452ms","start":"2026-06-28T19:49:45.187761Z","end":"2026-06-28T19:49:45.813485Z","steps":["trace[1734909328] 'agreement among raft nodes before linearized reading' (duration: 625.361789ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:49:45.813612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:49:45.187744Z","time spent":"625.857312ms","remote":"127.0.0.1:57852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4355,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" "} {"level":"warn","ts":"2026-06-28T19:49:45.820803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.190835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:49:45.820865Z","caller":"traceutil/trace.go:171","msg":"trace[1776207407] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:678; }","duration":"363.291708ms","start":"2026-06-28T19:49:45.457559Z","end":"2026-06-28T19:49:45.820851Z","steps":["trace[1776207407] 'agreement among raft nodes before linearized reading' (duration: 363.182535ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:49:45.820889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:49:45.457542Z","time spent":"363.342929ms","remote":"127.0.0.1:53976","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-28T19:49:45.821172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.375664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"} {"level":"info","ts":"2026-06-28T19:49:45.821201Z","caller":"traceutil/trace.go:171","msg":"trace[1045462467] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:678; }","duration":"244.429596ms","start":"2026-06-28T19:49:45.576763Z","end":"2026-06-28T19:49:45.821193Z","steps":["trace[1045462467] 'agreement among raft nodes before linearized reading' (duration: 244.368624ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:49:45.821544Z","caller":"traceutil/trace.go:171","msg":"trace[195955485] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"293.091199ms","start":"2026-06-28T19:49:45.528438Z","end":"2026-06-28T19:49:45.821529Z","steps":["trace[195955485] 'process raft request' (duration: 292.107023ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:49:52.761003Z","caller":"traceutil/trace.go:171","msg":"trace[51634368] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"147.536558ms","start":"2026-06-28T19:49:52.613445Z","end":"2026-06-28T19:49:52.760982Z","steps":["trace[51634368] 'process raft request' (duration: 147.406235ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:49:54.796187Z","caller":"traceutil/trace.go:171","msg":"trace[1549419255] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"109.111824ms","start":"2026-06-28T19:49:54.687048Z","end":"2026-06-28T19:49:54.79616Z","steps":["trace[1549419255] 'process raft request' (duration: 108.95818ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:49:59.126648Z","caller":"traceutil/trace.go:171","msg":"trace[961975042] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"314.950412ms","start":"2026-06-28T19:49:58.811674Z","end":"2026-06-28T19:49:59.126625Z","steps":["trace[961975042] 'process raft request' (duration: 314.770058ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:49:59.126961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:49:58.811648Z","time spent":"315.076664ms","remote":"127.0.0.1:58066","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:49:59.328953Z","caller":"traceutil/trace.go:171","msg":"trace[139209666] linearizableReadLoop","detail":"{readStateIndex:799; appliedIndex:798; }","duration":"202.339903ms","start":"2026-06-28T19:49:59.12659Z","end":"2026-06-28T19:49:59.32893Z","steps":["trace[139209666] 'read index received' (duration: 202.132038ms)","trace[139209666] 'applied index is now lower than readState.Index' (duration: 206.915µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:49:59.329239Z","caller":"traceutil/trace.go:171","msg":"trace[1453355077] transaction","detail":"{read_only:false; response_revision:769; number_of_response:1; }","duration":"292.585666ms","start":"2026-06-28T19:49:59.036642Z","end":"2026-06-28T19:49:59.329228Z","steps":["trace[1453355077] 'process raft request' (duration: 292.151827ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:49:59.32951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.697451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-28T19:49:59.329554Z","caller":"traceutil/trace.go:171","msg":"trace[1663141603] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:769; }","duration":"219.790434ms","start":"2026-06-28T19:49:59.109752Z","end":"2026-06-28T19:49:59.329542Z","steps":["trace[1663141603] 'agreement among raft nodes before linearized reading' (duration: 219.658491ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:49:59.329721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.868191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:49:59.329756Z","caller":"traceutil/trace.go:171","msg":"trace[1390354296] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:769; }","duration":"201.921102ms","start":"2026-06-28T19:49:59.127826Z","end":"2026-06-28T19:49:59.329748Z","steps":["trace[1390354296] 'agreement among raft nodes before linearized reading' (duration: 201.855561ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:49:59.330024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.020169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-28T19:49:59.330061Z","caller":"traceutil/trace.go:171","msg":"trace[1401806977] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:769; }","duration":"105.098972ms","start":"2026-06-28T19:49:59.224954Z","end":"2026-06-28T19:49:59.330053Z","steps":["trace[1401806977] 'agreement among raft nodes before linearized reading' (duration: 105.009369ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:49:59.330215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.056144ms","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-28T19:49:59.330251Z","caller":"traceutil/trace.go:171","msg":"trace[1386420249] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:769; }","duration":"128.128195ms","start":"2026-06-28T19:49:59.202113Z","end":"2026-06-28T19:49:59.330242Z","steps":["trace[1386420249] 'agreement among raft nodes before linearized reading' (duration: 128.048724ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:50:06.865869Z","caller":"traceutil/trace.go:171","msg":"trace[1080939922] transaction","detail":"{read_only:false; response_revision:848; number_of_response:1; }","duration":"138.909772ms","start":"2026-06-28T19:50:06.726932Z","end":"2026-06-28T19:50:06.865842Z","steps":["trace[1080939922] 'process raft request' (duration: 117.098484ms)","trace[1080939922] 'compare' (duration: 21.468641ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:50:10.331577Z","caller":"traceutil/trace.go:171","msg":"trace[1345471629] linearizableReadLoop","detail":"{readStateIndex:923; appliedIndex:922; }","duration":"163.18951ms","start":"2026-06-28T19:50:10.168364Z","end":"2026-06-28T19:50:10.331553Z","steps":["trace[1345471629] 'read index received' (duration: 163.009686ms)","trace[1345471629] 'applied index is now lower than readState.Index' (duration: 178.764µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:50:10.331636Z","caller":"traceutil/trace.go:171","msg":"trace[1661353636] transaction","detail":"{read_only:false; response_revision:890; number_of_response:1; }","duration":"217.522516ms","start":"2026-06-28T19:50:10.114077Z","end":"2026-06-28T19:50:10.3316Z","steps":["trace[1661353636] 'process raft request' (duration: 217.277141ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:50:10.331819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.439476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-28T19:50:10.331864Z","caller":"traceutil/trace.go:171","msg":"trace[2088936761] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:890; }","duration":"163.538057ms","start":"2026-06-28T19:50:10.168315Z","end":"2026-06-28T19:50:10.331853Z","steps":["trace[2088936761] 'agreement among raft nodes before linearized reading' (duration: 163.378014ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:50:10.33186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.353064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:50:10.331964Z","caller":"traceutil/trace.go:171","msg":"trace[1211961684] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:0; response_revision:890; }","duration":"154.480067ms","start":"2026-06-28T19:50:10.177458Z","end":"2026-06-28T19:50:10.331938Z","steps":["trace[1211961684] 'agreement among raft nodes before linearized reading' (duration: 154.333904ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:50:13.370845Z","caller":"traceutil/trace.go:171","msg":"trace[1407243265] transaction","detail":"{read_only:false; response_revision:931; number_of_response:1; }","duration":"168.01572ms","start":"2026-06-28T19:50:13.202791Z","end":"2026-06-28T19:50:13.370806Z","steps":["trace[1407243265] 'process raft request' (duration: 162.234585ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:50:21.574515Z","caller":"traceutil/trace.go:171","msg":"trace[236993545] transaction","detail":"{read_only:false; response_revision:1102; number_of_response:1; }","duration":"160.081126ms","start":"2026-06-28T19:50:21.414407Z","end":"2026-06-28T19:50:21.574488Z","steps":["trace[236993545] 'process raft request' (duration: 159.894513ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:50:21.723213Z","caller":"traceutil/trace.go:171","msg":"trace[313296959] transaction","detail":"{read_only:false; response_revision:1103; number_of_response:1; }","duration":"144.264911ms","start":"2026-06-28T19:50:21.578913Z","end":"2026-06-28T19:50:21.723177Z","steps":["trace[313296959] 'process raft request' (duration: 77.530357ms)","trace[313296959] 'compare' (duration: 66.424158ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:50:21.730689Z","caller":"traceutil/trace.go:171","msg":"trace[1469835135] transaction","detail":"{read_only:false; response_revision:1104; number_of_response:1; }","duration":"150.862946ms","start":"2026-06-28T19:50:21.579803Z","end":"2026-06-28T19:50:21.730666Z","steps":["trace[1469835135] 'process raft request' (duration: 150.685433ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:50:21.730806Z","caller":"traceutil/trace.go:171","msg":"trace[1249072434] transaction","detail":"{read_only:false; response_revision:1105; number_of_response:1; }","duration":"150.388776ms","start":"2026-06-28T19:50:21.580391Z","end":"2026-06-28T19:50:21.730779Z","steps":["trace[1249072434] 'process raft request' (duration: 150.183182ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:50:21.730839Z","caller":"traceutil/trace.go:171","msg":"trace[195790324] transaction","detail":"{read_only:false; response_revision:1106; number_of_response:1; }","duration":"110.349952ms","start":"2026-06-28T19:50:21.620477Z","end":"2026-06-28T19:50:21.730827Z","steps":["trace[195790324] 'process raft request' (duration: 110.123008ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:50:31.520604Z","caller":"traceutil/trace.go:171","msg":"trace[1134854988] transaction","detail":"{read_only:false; response_revision:1175; number_of_response:1; }","duration":"161.631859ms","start":"2026-06-28T19:50:31.358944Z","end":"2026-06-28T19:50:31.520576Z","steps":["trace[1134854988] 'process raft request' (duration: 161.395745ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:50:41.342761Z","caller":"traceutil/trace.go:171","msg":"trace[401416836] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"118.100693ms","start":"2026-06-28T19:50:41.224622Z","end":"2026-06-28T19:50:41.342722Z","steps":["trace[401416836] 'process raft request' (duration: 84.376405ms)","trace[401416836] 'compare' (duration: 33.477413ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:50:41.526567Z","caller":"traceutil/trace.go:171","msg":"trace[1766803704] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"176.687885ms","start":"2026-06-28T19:50:41.349823Z","end":"2026-06-28T19:50:41.526511Z","steps":["trace[1766803704] 'process raft request' (duration: 143.301774ms)","trace[1766803704] 'compare' (duration: 32.869302ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:50:43.501484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.152786ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-28T19:50:44.566713Z","caller":"traceutil/trace.go:171","msg":"trace[375829537] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"136.894739ms","start":"2026-06-28T19:50:44.429786Z","end":"2026-06-28T19:50:44.566681Z","steps":["trace[375829537] 'process raft request' (duration: 136.713426ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:50:45.195045Z","caller":"traceutil/trace.go:171","msg":"trace[2002493005] linearizableReadLoop","detail":"{readStateIndex:1332; appliedIndex:1331; }","duration":"159.151185ms","start":"2026-06-28T19:50:45.035855Z","end":"2026-06-28T19:50:45.195007Z","steps":["trace[2002493005] 'read index received' (duration: 127.611029ms)","trace[2002493005] 'applied index is now lower than readState.Index' (duration: 31.538656ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:50:45.195062Z","caller":"traceutil/trace.go:171","msg":"trace[597208635] transaction","detail":"{read_only:false; response_revision:1287; number_of_response:1; }","duration":"203.36533ms","start":"2026-06-28T19:50:44.991652Z","end":"2026-06-28T19:50:45.195017Z","steps":["trace[597208635] 'process raft request' (duration: 171.779933ms)","trace[597208635] 'compare' (duration: 31.223471ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:50:45.195257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.38751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:50:45.195367Z","caller":"traceutil/trace.go:171","msg":"trace[1071998929] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1287; }","duration":"159.573903ms","start":"2026-06-28T19:50:45.035775Z","end":"2026-06-28T19:50:45.195349Z","steps":["trace[1071998929] 'agreement among raft nodes before linearized reading' (duration: 159.36017ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:50:45.449064Z","caller":"traceutil/trace.go:171","msg":"trace[1779339362] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"199.574941ms","start":"2026-06-28T19:50:45.249435Z","end":"2026-06-28T19:50:45.44901Z","steps":["trace[1779339362] 'process raft request' (duration: 116.905888ms)","trace[1779339362] 'compare' (duration: 82.398539ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:50:45.918337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.255579ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:50:45.918458Z","caller":"traceutil/trace.go:171","msg":"trace[601200866] linearizableReadLoop","detail":"{readStateIndex:1335; appliedIndex:1334; }","duration":"230.656648ms","start":"2026-06-28T19:50:45.687782Z","end":"2026-06-28T19:50:45.918439Z","steps":["trace[601200866] 'read index received' (duration: 58.551µs)","trace[601200866] 'applied index is now lower than readState.Index' (duration: 230.597047ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:50:45.918804Z","caller":"traceutil/trace.go:171","msg":"trace[191198191] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"369.10109ms","start":"2026-06-28T19:50:45.54969Z","end":"2026-06-28T19:50:45.918791Z","steps":["trace[191198191] 'process raft request' (duration: 123.278511ms)","trace[191198191] 'compare' (duration: 245.044926ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:50:45.918872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:50:45.549659Z","time spent":"369.181731ms","remote":"127.0.0.1:57904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105407,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:50:45.919034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.247158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-28T19:50:45.919079Z","caller":"traceutil/trace.go:171","msg":"trace[2006950161] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1290; }","duration":"231.3344ms","start":"2026-06-28T19:50:45.687733Z","end":"2026-06-28T19:50:45.919067Z","steps":["trace[2006950161] 'agreement among raft nodes before linearized reading' (duration: 231.246038ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:50:45.919628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.019504ms","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-28T19:50:45.919767Z","caller":"traceutil/trace.go:171","msg":"trace[1349636878] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1290; }","duration":"153.212148ms","start":"2026-06-28T19:50:45.766533Z","end":"2026-06-28T19:50:45.919745Z","steps":["trace[1349636878] 'agreement among raft nodes before linearized reading' (duration: 152.536446ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:50:46.739691Z","caller":"traceutil/trace.go:171","msg":"trace[773623604] transaction","detail":"{read_only:false; response_revision:1304; number_of_response:1; }","duration":"152.41039ms","start":"2026-06-28T19:50:46.587251Z","end":"2026-06-28T19:50:46.739662Z","steps":["trace[773623604] 'process raft request' (duration: 152.193796ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:02.402043Z","caller":"traceutil/trace.go:171","msg":"trace[246517643] transaction","detail":"{read_only:false; number_of_response:0; response_revision:1543; }","duration":"112.805ms","start":"2026-06-28T19:51:02.289213Z","end":"2026-06-28T19:51:02.402018Z","steps":["trace[246517643] 'process raft request' (duration: 112.724419ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:02.438907Z","caller":"traceutil/trace.go:171","msg":"trace[1889931421] transaction","detail":"{read_only:false; response_revision:1544; number_of_response:1; }","duration":"108.049831ms","start":"2026-06-28T19:51:02.330825Z","end":"2026-06-28T19:51:02.438875Z","steps":["trace[1889931421] 'process raft request' (duration: 107.540853ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:04.961944Z","caller":"traceutil/trace.go:171","msg":"trace[1334127870] transaction","detail":"{read_only:false; response_revision:1552; number_of_response:1; }","duration":"190.779827ms","start":"2026-06-28T19:51:04.771145Z","end":"2026-06-28T19:51:04.961924Z","steps":["trace[1334127870] 'process raft request' (duration: 190.663625ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:05.149055Z","caller":"traceutil/trace.go:171","msg":"trace[238089894] linearizableReadLoop","detail":"{readStateIndex:1617; appliedIndex:1615; }","duration":"256.308586ms","start":"2026-06-28T19:51:04.89272Z","end":"2026-06-28T19:51:05.149028Z","steps":["trace[238089894] 'read index received' (duration: 69.137547ms)","trace[238089894] 'applied index is now lower than readState.Index' (duration: 187.169709ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:51:05.149132Z","caller":"traceutil/trace.go:171","msg":"trace[1760103702] transaction","detail":"{read_only:false; response_revision:1553; number_of_response:1; }","duration":"352.394216ms","start":"2026-06-28T19:51:04.796723Z","end":"2026-06-28T19:51:05.149117Z","steps":["trace[1760103702] 'process raft request' (duration: 351.944978ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:05.149223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:04.796706Z","time spent":"352.462167ms","remote":"127.0.0.1:58066","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-28T19:51:05.149287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.566711ms","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-28T19:51:05.149327Z","caller":"traceutil/trace.go:171","msg":"trace[59299505] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1553; }","duration":"256.648681ms","start":"2026-06-28T19:51:04.892669Z","end":"2026-06-28T19:51:05.149317Z","steps":["trace[59299505] 'agreement among raft nodes before linearized reading' (duration: 256.500909ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:05.160344Z","caller":"traceutil/trace.go:171","msg":"trace[1871142836] transaction","detail":"{read_only:false; response_revision:1554; number_of_response:1; }","duration":"195.491906ms","start":"2026-06-28T19:51:04.964836Z","end":"2026-06-28T19:51:05.160328Z","steps":["trace[1871142836] 'process raft request' (duration: 195.296822ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:05.160576Z","caller":"traceutil/trace.go:171","msg":"trace[1078303411] transaction","detail":"{read_only:false; response_revision:1555; number_of_response:1; }","duration":"195.525715ms","start":"2026-06-28T19:51:04.965001Z","end":"2026-06-28T19:51:05.160526Z","steps":["trace[1078303411] 'process raft request' (duration: 195.239501ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:05.16095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.739203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-28T19:51:05.160988Z","caller":"traceutil/trace.go:171","msg":"trace[460773177] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1556; }","duration":"208.826435ms","start":"2026-06-28T19:51:04.952154Z","end":"2026-06-28T19:51:05.16098Z","steps":["trace[460773177] 'agreement among raft nodes before linearized reading' (duration: 208.730762ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:05.161075Z","caller":"traceutil/trace.go:171","msg":"trace[1026563267] transaction","detail":"{read_only:false; response_revision:1556; number_of_response:1; }","duration":"112.620455ms","start":"2026-06-28T19:51:05.048435Z","end":"2026-06-28T19:51:05.161056Z","steps":["trace[1026563267] 'process raft request' (duration: 112.249388ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:05.161253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.289985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:51:05.161287Z","caller":"traceutil/trace.go:171","msg":"trace[818885599] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1556; }","duration":"127.338036ms","start":"2026-06-28T19:51:05.03394Z","end":"2026-06-28T19:51:05.161278Z","steps":["trace[818885599] 'agreement among raft nodes before linearized reading' (duration: 127.291895ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:06.59258Z","caller":"traceutil/trace.go:171","msg":"trace[1361115734] transaction","detail":"{read_only:false; response_revision:1662; number_of_response:1; }","duration":"105.985329ms","start":"2026-06-28T19:51:06.486566Z","end":"2026-06-28T19:51:06.592552Z","steps":["trace[1361115734] 'process raft request' (duration: 105.829146ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:06.721646Z","caller":"traceutil/trace.go:171","msg":"trace[1513496386] transaction","detail":"{read_only:false; response_revision:1663; number_of_response:1; }","duration":"109.200791ms","start":"2026-06-28T19:51:06.612418Z","end":"2026-06-28T19:51:06.721619Z","steps":["trace[1513496386] 'process raft request' (duration: 109.044779ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:06.784912Z","caller":"traceutil/trace.go:171","msg":"trace[502128341] transaction","detail":"{read_only:false; response_revision:1664; number_of_response:1; }","duration":"164.273839ms","start":"2026-06-28T19:51:06.620618Z","end":"2026-06-28T19:51:06.784892Z","steps":["trace[502128341] 'process raft request' (duration: 154.292496ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:08.476387Z","caller":"traceutil/trace.go:171","msg":"trace[1767407602] transaction","detail":"{read_only:false; response_revision:1684; number_of_response:1; }","duration":"265.448955ms","start":"2026-06-28T19:51:08.210916Z","end":"2026-06-28T19:51:08.476365Z","steps":["trace[1767407602] 'process raft request' (duration: 231.658039ms)","trace[1767407602] 'compare' (duration: 33.488302ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:51:26.759065Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831411390375210553,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-28T19:51:27.259908Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831411390375210553,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-28T19:51:27.26967Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.044462272s","expected-duration":"1s"} {"level":"info","ts":"2026-06-28T19:51:27.270134Z","caller":"traceutil/trace.go:171","msg":"trace[144663334] transaction","detail":"{read_only:false; response_revision:1886; number_of_response:1; }","duration":"1.044994301s","start":"2026-06-28T19:51:26.225092Z","end":"2026-06-28T19:51:27.270087Z","steps":["trace[144663334] 'process raft request' (duration: 1.044783848s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:27.270384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:26.225069Z","time spent":"1.045174313s","remote":"127.0.0.1:58066","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:51:27.277592Z","caller":"traceutil/trace.go:171","msg":"trace[401265340] linearizableReadLoop","detail":"{readStateIndex:1962; appliedIndex:1960; }","duration":"1.018568609s","start":"2026-06-28T19:51:26.258964Z","end":"2026-06-28T19:51:27.277533Z","steps":["trace[401265340] 'read index received' (duration: 1.010893413s)","trace[401265340] 'applied index is now lower than readState.Index' (duration: 7.673656ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:51:27.277891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"664.946817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-28T19:51:27.277909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"950.892531ms","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-28T19:51:27.27794Z","caller":"traceutil/trace.go:171","msg":"trace[76009616] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:1887; }","duration":"665.082069ms","start":"2026-06-28T19:51:26.612845Z","end":"2026-06-28T19:51:27.277927Z","steps":["trace[76009616] 'agreement among raft nodes before linearized reading' (duration: 664.999988ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:27.277982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:26.612823Z","time spent":"665.15093ms","remote":"127.0.0.1:57014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":29,"request content":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true "} {"level":"warn","ts":"2026-06-28T19:51:27.278062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"852.061559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c3ccd096-9452-4f2d-8663-5a8be31e2fdd\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-06-28T19:51:27.27806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"718.827145ms","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-28T19:51:27.278082Z","caller":"traceutil/trace.go:171","msg":"trace[2032990966] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c3ccd096-9452-4f2d-8663-5a8be31e2fdd; range_end:; response_count:1; response_revision:1887; }","duration":"852.10608ms","start":"2026-06-28T19:51:26.42597Z","end":"2026-06-28T19:51:27.278077Z","steps":["trace[2032990966] 'agreement among raft nodes before linearized reading' (duration: 852.027988ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:27.277911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.018916383s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-28T19:51:27.278073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"627.049661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-06-28T19:51:27.278104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:26.425958Z","time spent":"852.140992ms","remote":"127.0.0.1:57982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c3ccd096-9452-4f2d-8663-5a8be31e2fdd\" "} {"level":"info","ts":"2026-06-28T19:51:27.278113Z","caller":"traceutil/trace.go:171","msg":"trace[240409507] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1887; }","duration":"1.019172188s","start":"2026-06-28T19:51:26.258932Z","end":"2026-06-28T19:51:27.278105Z","steps":["trace[240409507] 'agreement among raft nodes before linearized reading' (duration: 1.018791181s)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:27.278108Z","caller":"traceutil/trace.go:171","msg":"trace[1414414363] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1887; }","duration":"718.905696ms","start":"2026-06-28T19:51:26.559187Z","end":"2026-06-28T19:51:27.278093Z","steps":["trace[1414414363] 'agreement among raft nodes before linearized reading' (duration: 718.770974ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:27.278141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:26.258922Z","time spent":"1.019210918s","remote":"127.0.0.1:58066","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":"info","ts":"2026-06-28T19:51:27.278141Z","caller":"traceutil/trace.go:171","msg":"trace[1131655175] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1887; }","duration":"627.178874ms","start":"2026-06-28T19:51:26.650938Z","end":"2026-06-28T19:51:27.278117Z","steps":["trace[1131655175] 'agreement among raft nodes before linearized reading' (duration: 627.00063ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:27.278162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:26.559167Z","time spent":"718.983538ms","remote":"127.0.0.1:58066","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-28T19:51:27.277981Z","caller":"traceutil/trace.go:171","msg":"trace[479610935] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1887; }","duration":"951.005192ms","start":"2026-06-28T19:51:26.32696Z","end":"2026-06-28T19:51:27.277965Z","steps":["trace[479610935] 'agreement among raft nodes before linearized reading' (duration: 950.821239ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:27.278187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:26.650917Z","time spent":"627.255945ms","remote":"127.0.0.1:40548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-28T19:51:27.278207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:26.326946Z","time spent":"951.254186ms","remote":"127.0.0.1:58066","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":"info","ts":"2026-06-28T19:51:27.582752Z","caller":"traceutil/trace.go:171","msg":"trace[1267183309] linearizableReadLoop","detail":"{readStateIndex:1966; appliedIndex:1965; }","duration":"103.797703ms","start":"2026-06-28T19:51:27.478923Z","end":"2026-06-28T19:51:27.58272Z","steps":["trace[1267183309] 'read index received' (duration: 6.127283ms)","trace[1267183309] 'applied index is now lower than readState.Index' (duration: 97.668499ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:51:27.582984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.042426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:51:27.583024Z","caller":"traceutil/trace.go:171","msg":"trace[914942089] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:1891; }","duration":"104.139248ms","start":"2026-06-28T19:51:27.478873Z","end":"2026-06-28T19:51:27.583012Z","steps":["trace[914942089] 'agreement among raft nodes before linearized reading' (duration: 103.977495ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:27.583566Z","caller":"traceutil/trace.go:171","msg":"trace[1555860466] transaction","detail":"{read_only:false; response_revision:1891; number_of_response:1; }","duration":"284.466037ms","start":"2026-06-28T19:51:27.299051Z","end":"2026-06-28T19:51:27.583517Z","steps":["trace[1555860466] 'process raft request' (duration: 185.998716ms)","trace[1555860466] 'compare' (duration: 97.536037ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:51:27.980655Z","caller":"traceutil/trace.go:171","msg":"trace[1180730766] transaction","detail":"{read_only:false; response_revision:1892; number_of_response:1; }","duration":"300.467899ms","start":"2026-06-28T19:51:27.680147Z","end":"2026-06-28T19:51:27.980615Z","steps":["trace[1180730766] 'process raft request' (duration: 296.502339ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:27.980843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:27.680125Z","time spent":"300.618832ms","remote":"127.0.0.1:58066","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:51:27.983083Z","caller":"traceutil/trace.go:171","msg":"trace[2095649661] transaction","detail":"{read_only:false; response_revision:1893; number_of_response:1; }","duration":"291.376053ms","start":"2026-06-28T19:51:27.691676Z","end":"2026-06-28T19:51:27.983052Z","steps":["trace[2095649661] 'process raft request' (duration: 291.22476ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:27.983104Z","caller":"traceutil/trace.go:171","msg":"trace[654479040] transaction","detail":"{read_only:false; response_revision:1894; number_of_response:1; }","duration":"110.94136ms","start":"2026-06-28T19:51:27.872146Z","end":"2026-06-28T19:51:27.983087Z","steps":["trace[654479040] 'process raft request' (duration: 110.834198ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:34.134097Z","caller":"traceutil/trace.go:171","msg":"trace[727503451] linearizableReadLoop","detail":"{readStateIndex:2025; appliedIndex:2022; }","duration":"102.630673ms","start":"2026-06-28T19:51:34.031443Z","end":"2026-06-28T19:51:34.134073Z","steps":["trace[727503451] 'read index received' (duration: 72.321962ms)","trace[727503451] 'applied index is now lower than readState.Index' (duration: 30.307611ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:51:34.134148Z","caller":"traceutil/trace.go:171","msg":"trace[1277011853] transaction","detail":"{read_only:false; response_revision:1946; number_of_response:1; }","duration":"128.518876ms","start":"2026-06-28T19:51:34.005602Z","end":"2026-06-28T19:51:34.134121Z","steps":["trace[1277011853] 'process raft request' (duration: 128.289852ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:34.134242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.799754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:51:34.134284Z","caller":"traceutil/trace.go:171","msg":"trace[2070257607] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1947; }","duration":"102.884846ms","start":"2026-06-28T19:51:34.031387Z","end":"2026-06-28T19:51:34.134272Z","steps":["trace[2070257607] 'agreement among raft nodes before linearized reading' (duration: 102.807445ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:34.135068Z","caller":"traceutil/trace.go:171","msg":"trace[2106750033] transaction","detail":"{read_only:false; response_revision:1947; number_of_response:1; }","duration":"129.300397ms","start":"2026-06-28T19:51:34.005743Z","end":"2026-06-28T19:51:34.135043Z","steps":["trace[2106750033] 'process raft request' (duration: 128.291553ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:40.361592Z","caller":"traceutil/trace.go:171","msg":"trace[1296009373] transaction","detail":"{read_only:false; response_revision:2010; number_of_response:1; }","duration":"206.100936ms","start":"2026-06-28T19:51:40.155459Z","end":"2026-06-28T19:51:40.36156Z","steps":["trace[1296009373] 'process raft request' (duration: 185.400933ms)","trace[1296009373] 'compare' (duration: 20.51627ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:51:40.361827Z","caller":"traceutil/trace.go:171","msg":"trace[627440577] transaction","detail":"{read_only:false; response_revision:2011; number_of_response:1; }","duration":"205.503057ms","start":"2026-06-28T19:51:40.156285Z","end":"2026-06-28T19:51:40.361788Z","steps":["trace[627440577] 'process raft request' (duration: 205.222763ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:44.05182Z","caller":"traceutil/trace.go:171","msg":"trace[862017888] transaction","detail":"{read_only:false; response_revision:2029; number_of_response:1; }","duration":"171.525921ms","start":"2026-06-28T19:51:43.880274Z","end":"2026-06-28T19:51:44.0518Z","steps":["trace[862017888] 'process raft request' (duration: 171.40175ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:44.41999Z","caller":"traceutil/trace.go:171","msg":"trace[567749069] linearizableReadLoop","detail":"{readStateIndex:2110; appliedIndex:2109; }","duration":"238.120398ms","start":"2026-06-28T19:51:44.181845Z","end":"2026-06-28T19:51:44.419965Z","steps":["trace[567749069] 'read index received' (duration: 237.990246ms)","trace[567749069] 'applied index is now lower than readState.Index' (duration: 128.762µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:51:44.420031Z","caller":"traceutil/trace.go:171","msg":"trace[420937223] transaction","detail":"{read_only:false; response_revision:2030; number_of_response:1; }","duration":"278.34316ms","start":"2026-06-28T19:51:44.141662Z","end":"2026-06-28T19:51:44.420005Z","steps":["trace[420937223] 'process raft request' (duration: 278.153017ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:44.420284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.423403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11986"} {"level":"info","ts":"2026-06-28T19:51:44.420373Z","caller":"traceutil/trace.go:171","msg":"trace[2108369256] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2030; }","duration":"238.564184ms","start":"2026-06-28T19:51:44.18179Z","end":"2026-06-28T19:51:44.420354Z","steps":["trace[2108369256] 'agreement among raft nodes before linearized reading' (duration: 238.305191ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:07.187311Z","caller":"traceutil/trace.go:171","msg":"trace[1239713157] linearizableReadLoop","detail":"{readStateIndex:2240; appliedIndex:2239; }","duration":"153.665033ms","start":"2026-06-28T19:52:07.033575Z","end":"2026-06-28T19:52:07.18724Z","steps":["trace[1239713157] 'read index received' (duration: 153.4536ms)","trace[1239713157] 'applied index is now lower than readState.Index' (duration: 210.303µs)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:52:07.187501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.901196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:52:07.187575Z","caller":"traceutil/trace.go:171","msg":"trace[96880630] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2156; }","duration":"154.027458ms","start":"2026-06-28T19:52:07.033533Z","end":"2026-06-28T19:52:07.18756Z","steps":["trace[96880630] 'agreement among raft nodes before linearized reading' (duration: 153.862996ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:07.187634Z","caller":"traceutil/trace.go:171","msg":"trace[54056935] transaction","detail":"{read_only:false; response_revision:2156; number_of_response:1; }","duration":"245.224963ms","start":"2026-06-28T19:52:06.942331Z","end":"2026-06-28T19:52:07.187556Z","steps":["trace[54056935] 'process raft request' (duration: 244.620295ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:07.6259Z","caller":"traceutil/trace.go:171","msg":"trace[825451946] linearizableReadLoop","detail":"{readStateIndex:2241; appliedIndex:2240; }","duration":"168.642569ms","start":"2026-06-28T19:52:07.457236Z","end":"2026-06-28T19:52:07.625878Z","steps":["trace[825451946] 'read index received' (duration: 168.536347ms)","trace[825451946] 'applied index is now lower than readState.Index' (duration: 104.952µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:52:07.625947Z","caller":"traceutil/trace.go:171","msg":"trace[2049890236] transaction","detail":"{read_only:false; response_revision:2157; number_of_response:1; }","duration":"211.271775ms","start":"2026-06-28T19:52:07.414648Z","end":"2026-06-28T19:52:07.62592Z","steps":["trace[2049890236] 'process raft request' (duration: 211.087733ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:07.626092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.848241ms","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-28T19:52:07.626127Z","caller":"traceutil/trace.go:171","msg":"trace[1380115124] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2157; }","duration":"168.934251ms","start":"2026-06-28T19:52:07.457183Z","end":"2026-06-28T19:52:07.626118Z","steps":["trace[1380115124] 'agreement among raft nodes before linearized reading' (duration: 168.80492ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:07.631117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.904345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-28T19:52:07.631184Z","caller":"traceutil/trace.go:171","msg":"trace[1844948893] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2158; }","duration":"166.992456ms","start":"2026-06-28T19:52:07.464174Z","end":"2026-06-28T19:52:07.631166Z","steps":["trace[1844948893] 'agreement among raft nodes before linearized reading' (duration: 166.788162ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:07.631181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.37839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-28T19:52:07.631207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.249448ms","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-28T19:52:07.631237Z","caller":"traceutil/trace.go:171","msg":"trace[1133617308] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2158; }","duration":"148.455031ms","start":"2026-06-28T19:52:07.482774Z","end":"2026-06-28T19:52:07.631229Z","steps":["trace[1133617308] 'agreement among raft nodes before linearized reading' (duration: 148.348819ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:07.631265Z","caller":"traceutil/trace.go:171","msg":"trace[555159244] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2158; }","duration":"148.34989ms","start":"2026-06-28T19:52:07.482901Z","end":"2026-06-28T19:52:07.631251Z","steps":["trace[555159244] 'agreement among raft nodes before linearized reading' (duration: 148.153838ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:07.753003Z","caller":"traceutil/trace.go:171","msg":"trace[250638450] transaction","detail":"{read_only:false; response_revision:2160; number_of_response:1; }","duration":"118.481679ms","start":"2026-06-28T19:52:07.634484Z","end":"2026-06-28T19:52:07.752966Z","steps":["trace[250638450] 'process raft request' (duration: 118.154034ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:07.753492Z","caller":"traceutil/trace.go:171","msg":"trace[231334739] transaction","detail":"{read_only:false; response_revision:2161; number_of_response:1; }","duration":"118.759282ms","start":"2026-06-28T19:52:07.6347Z","end":"2026-06-28T19:52:07.75346Z","steps":["trace[231334739] 'process raft request' (duration: 118.091333ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:07.753576Z","caller":"traceutil/trace.go:171","msg":"trace[1993421874] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"117.926801ms","start":"2026-06-28T19:52:07.635628Z","end":"2026-06-28T19:52:07.753555Z","steps":["trace[1993421874] 'process raft request' (duration: 117.678997ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:08.207503Z","caller":"traceutil/trace.go:171","msg":"trace[310124726] linearizableReadLoop","detail":"{readStateIndex:2248; appliedIndex:2247; }","duration":"173.103185ms","start":"2026-06-28T19:52:08.034373Z","end":"2026-06-28T19:52:08.207476Z","steps":["trace[310124726] 'read index received' (duration: 172.945473ms)","trace[310124726] 'applied index is now lower than readState.Index' (duration: 156.532µs)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:52:08.207643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.244367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:52:08.207682Z","caller":"traceutil/trace.go:171","msg":"trace[543251667] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2163; }","duration":"173.329308ms","start":"2026-06-28T19:52:08.034342Z","end":"2026-06-28T19:52:08.207671Z","steps":["trace[543251667] 'agreement among raft nodes before linearized reading' (duration: 173.236977ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:08.421889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.932857ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:52:08.422031Z","caller":"traceutil/trace.go:171","msg":"trace[1896869818] linearizableReadLoop","detail":"{readStateIndex:2249; appliedIndex:2248; }","duration":"212.715059ms","start":"2026-06-28T19:52:08.209294Z","end":"2026-06-28T19:52:08.422009Z","steps":["trace[1896869818] 'read index received' (duration: 62.548919ms)","trace[1896869818] 'applied index is now lower than readState.Index' (duration: 150.16433ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:52:08.422348Z","caller":"traceutil/trace.go:171","msg":"trace[997737954] transaction","detail":"{read_only:false; response_revision:2164; number_of_response:1; }","duration":"213.912366ms","start":"2026-06-28T19:52:08.208417Z","end":"2026-06-28T19:52:08.422329Z","steps":["trace[997737954] 'process raft request' (duration: 63.441771ms)","trace[997737954] 'compare' (duration: 149.790825ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:52:08.422664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.354849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:52:08.422744Z","caller":"traceutil/trace.go:171","msg":"trace[2107765584] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2164; }","duration":"213.47365ms","start":"2026-06-28T19:52:08.209251Z","end":"2026-06-28T19:52:08.422725Z","steps":["trace[2107765584] 'agreement among raft nodes before linearized reading' (duration: 213.231307ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:08.716312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.721691ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:52:08.716383Z","caller":"traceutil/trace.go:171","msg":"trace[2141069236] transaction","detail":"{read_only:false; response_revision:2165; number_of_response:1; }","duration":"223.66626ms","start":"2026-06-28T19:52:08.492701Z","end":"2026-06-28T19:52:08.716368Z","steps":["trace[2141069236] 'process raft request' (duration: 66.836998ms)","trace[2141069236] 'compare' (duration: 156.279494ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:52:08.739262Z","caller":"traceutil/trace.go:171","msg":"trace[2116012419] transaction","detail":"{read_only:false; response_revision:2166; number_of_response:1; }","duration":"241.226049ms","start":"2026-06-28T19:52:08.498011Z","end":"2026-06-28T19:52:08.739237Z","steps":["trace[2116012419] 'process raft request' (duration: 241.064927ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:08.739548Z","caller":"traceutil/trace.go:171","msg":"trace[1714691186] transaction","detail":"{read_only:false; response_revision:2167; number_of_response:1; }","duration":"228.72991ms","start":"2026-06-28T19:52:08.510791Z","end":"2026-06-28T19:52:08.739521Z","steps":["trace[1714691186] 'process raft request' (duration: 228.395275ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:08.741145Z","caller":"traceutil/trace.go:171","msg":"trace[1826158042] linearizableReadLoop","detail":"{readStateIndex:2252; appliedIndex:2252; }","duration":"100.890054ms","start":"2026-06-28T19:52:08.640237Z","end":"2026-06-28T19:52:08.741127Z","steps":["trace[1826158042] 'read index received' (duration: 100.881834ms)","trace[1826158042] 'applied index is now lower than readState.Index' (duration: 6.65µs)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:52:08.74143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.181149ms","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-28T19:52:08.741476Z","caller":"traceutil/trace.go:171","msg":"trace[1246067488] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2167; }","duration":"101.285921ms","start":"2026-06-28T19:52:08.640177Z","end":"2026-06-28T19:52:08.741463Z","steps":["trace[1246067488] 'agreement among raft nodes before linearized reading' (duration: 101.048007ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:08.907053Z","caller":"traceutil/trace.go:171","msg":"trace[772832543] linearizableReadLoop","detail":"{readStateIndex:2254; appliedIndex:2253; }","duration":"116.363977ms","start":"2026-06-28T19:52:08.790662Z","end":"2026-06-28T19:52:08.907026Z","steps":["trace[772832543] 'read index received' (duration: 114.851536ms)","trace[772832543] 'applied index is now lower than readState.Index' (duration: 1.511581ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:52:08.907222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.548399ms","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-28T19:52:08.907256Z","caller":"traceutil/trace.go:171","msg":"trace[2060931187] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:2168; }","duration":"116.623509ms","start":"2026-06-28T19:52:08.790614Z","end":"2026-06-28T19:52:08.907238Z","steps":["trace[2060931187] 'agreement among raft nodes before linearized reading' (duration: 116.488128ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:08.907405Z","caller":"traceutil/trace.go:171","msg":"trace[1303215546] transaction","detail":"{read_only:false; response_revision:2168; number_of_response:1; }","duration":"153.04293ms","start":"2026-06-28T19:52:08.754355Z","end":"2026-06-28T19:52:08.907398Z","steps":["trace[1303215546] 'process raft request' (duration: 151.220995ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:53:26.338953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.516711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-28T19:53:26.339054Z","caller":"traceutil/trace.go:171","msg":"trace[861606098] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2691; }","duration":"126.659746ms","start":"2026-06-28T19:53:26.212371Z","end":"2026-06-28T19:53:26.339031Z","steps":["trace[861606098] 'range keys from in-memory index tree' (duration: 126.303444ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:53:26.339307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.276798ms","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-28T19:53:26.339427Z","caller":"traceutil/trace.go:171","msg":"trace[1054648793] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2691; }","duration":"121.529437ms","start":"2026-06-28T19:53:26.217878Z","end":"2026-06-28T19:53:26.339408Z","steps":["trace[1054648793] 'range keys from in-memory index tree' (duration: 120.994418ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:53:26.3396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.87674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:53:26.339675Z","caller":"traceutil/trace.go:171","msg":"trace[151162952] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:2691; }","duration":"165.992824ms","start":"2026-06-28T19:53:26.173671Z","end":"2026-06-28T19:53:26.339664Z","steps":["trace[151162952] 'count revisions from in-memory index tree' (duration: 165.750746ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:53:26.33968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.277918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-28T19:53:26.340117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.189236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-28T19:53:26.339923Z","caller":"traceutil/trace.go:171","msg":"trace[1898287010] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2691; }","duration":"129.538986ms","start":"2026-06-28T19:53:26.210355Z","end":"2026-06-28T19:53:26.339894Z","steps":["trace[1898287010] 'range keys from in-memory index tree' (duration: 129.156414ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:53:26.340206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.033143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-06-28T19:53:26.340187Z","caller":"traceutil/trace.go:171","msg":"trace[478051942] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2691; }","duration":"157.288719ms","start":"2026-06-28T19:53:26.182879Z","end":"2026-06-28T19:53:26.340168Z","steps":["trace[478051942] 'range keys from in-memory index tree' (duration: 156.987767ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:53:26.340382Z","caller":"traceutil/trace.go:171","msg":"trace[614196784] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2691; }","duration":"265.683546ms","start":"2026-06-28T19:53:26.074672Z","end":"2026-06-28T19:53:26.340356Z","steps":["trace[614196784] 'range keys from in-memory index tree' (duration: 264.875787ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:53:26.625763Z","caller":"traceutil/trace.go:171","msg":"trace[1012061122] transaction","detail":"{read_only:false; response_revision:2693; number_of_response:1; }","duration":"280.279467ms","start":"2026-06-28T19:53:26.34546Z","end":"2026-06-28T19:53:26.62574Z","steps":["trace[1012061122] 'process raft request' (duration: 280.035178ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:53:26.626Z","caller":"traceutil/trace.go:171","msg":"trace[1608894414] transaction","detail":"{read_only:false; response_revision:2695; number_of_response:1; }","duration":"280.10913ms","start":"2026-06-28T19:53:26.345868Z","end":"2026-06-28T19:53:26.625977Z","steps":["trace[1608894414] 'process raft request' (duration: 280.027467ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:53:26.626005Z","caller":"traceutil/trace.go:171","msg":"trace[1464679431] transaction","detail":"{read_only:false; response_revision:2694; number_of_response:1; }","duration":"280.470024ms","start":"2026-06-28T19:53:26.34552Z","end":"2026-06-28T19:53:26.62599Z","steps":["trace[1464679431] 'process raft request' (duration: 280.179404ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:53:26.627201Z","caller":"traceutil/trace.go:171","msg":"trace[175374429] linearizableReadLoop","detail":"{readStateIndex:2799; appliedIndex:2795; }","duration":"151.945572ms","start":"2026-06-28T19:53:26.475244Z","end":"2026-06-28T19:53:26.627189Z","steps":["trace[175374429] 'read index received' (duration: 150.163539ms)","trace[175374429] 'applied index is now lower than readState.Index' (duration: 1.781503ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:53:26.627937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.567203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:53:26.628135Z","caller":"traceutil/trace.go:171","msg":"trace[321051000] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:2696; }","duration":"152.933896ms","start":"2026-06-28T19:53:26.475173Z","end":"2026-06-28T19:53:26.628107Z","steps":["trace[321051000] 'agreement among raft nodes before linearized reading' (duration: 152.49019ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:53:26.628459Z","caller":"traceutil/trace.go:171","msg":"trace[1005869082] transaction","detail":"{read_only:false; response_revision:2696; number_of_response:1; }","duration":"248.853345ms","start":"2026-06-28T19:53:26.379588Z","end":"2026-06-28T19:53:26.628442Z","steps":["trace[1005869082] 'process raft request' (duration: 247.53381ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:53:32.267839Z","caller":"traceutil/trace.go:171","msg":"trace[944490025] transaction","detail":"{read_only:false; response_revision:2724; number_of_response:1; }","duration":"193.909994ms","start":"2026-06-28T19:53:32.073895Z","end":"2026-06-28T19:53:32.267805Z","steps":["trace[944490025] 'process raft request' (duration: 168.503756ms)","trace[944490025] 'compare' (duration: 25.111357ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:55:45.035466Z","caller":"traceutil/trace.go:171","msg":"trace[974188297] transaction","detail":"{read_only:false; response_revision:3511; number_of_response:1; }","duration":"112.980677ms","start":"2026-06-28T19:55:44.922463Z","end":"2026-06-28T19:55:45.035444Z","steps":["trace[974188297] 'process raft request' (duration: 112.69007ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:03.973709Z","caller":"traceutil/trace.go:171","msg":"trace[147402762] transaction","detail":"{read_only:false; response_revision:3619; number_of_response:1; }","duration":"238.012758ms","start":"2026-06-28T19:56:03.735665Z","end":"2026-06-28T19:56:03.973677Z","steps":["trace[147402762] 'process raft request' (duration: 170.409224ms)","trace[147402762] 'compare' (duration: 67.41573ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:56:09.819043Z","caller":"traceutil/trace.go:171","msg":"trace[1187499435] linearizableReadLoop","detail":"{readStateIndex:3795; appliedIndex:3793; }","duration":"102.883184ms","start":"2026-06-28T19:56:09.716144Z","end":"2026-06-28T19:56:09.819028Z","steps":["trace[1187499435] 'read index received' (duration: 17.408819ms)","trace[1187499435] 'applied index is now lower than readState.Index' (duration: 85.473755ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:56:09.819134Z","caller":"traceutil/trace.go:171","msg":"trace[213725956] transaction","detail":"{read_only:false; response_revision:3653; number_of_response:1; }","duration":"145.422641ms","start":"2026-06-28T19:56:09.673702Z","end":"2026-06-28T19:56:09.819125Z","steps":["trace[213725956] 'process raft request' (duration: 59.852495ms)","trace[213725956] 'compare' (duration: 85.25592ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:56:09.819469Z","caller":"traceutil/trace.go:171","msg":"trace[482949828] transaction","detail":"{read_only:false; response_revision:3654; number_of_response:1; }","duration":"145.144756ms","start":"2026-06-28T19:56:09.674311Z","end":"2026-06-28T19:56:09.819455Z","steps":["trace[482949828] 'process raft request' (duration: 144.687606ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:09.819464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.310313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:56:09.819754Z","caller":"traceutil/trace.go:171","msg":"trace[1484070933] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:3654; }","duration":"103.619819ms","start":"2026-06-28T19:56:09.716117Z","end":"2026-06-28T19:56:09.819737Z","steps":["trace[1484070933] 'agreement among raft nodes before linearized reading' (duration: 103.264252ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:12.726446Z","caller":"traceutil/trace.go:171","msg":"trace[1945975113] transaction","detail":"{read_only:false; response_revision:3666; number_of_response:1; }","duration":"101.35962ms","start":"2026-06-28T19:56:12.625062Z","end":"2026-06-28T19:56:12.726422Z","steps":["trace[1945975113] 'process raft request' (duration: 101.204377ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:13.521808Z","caller":"traceutil/trace.go:171","msg":"trace[1342664128] linearizableReadLoop","detail":"{readStateIndex:3810; appliedIndex:3808; }","duration":"213.715375ms","start":"2026-06-28T19:56:13.308074Z","end":"2026-06-28T19:56:13.52179Z","steps":["trace[1342664128] 'read index received' (duration: 40.381437ms)","trace[1342664128] 'applied index is now lower than readState.Index' (duration: 173.333228ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:56:13.522012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.875499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-28T19:56:13.522063Z","caller":"traceutil/trace.go:171","msg":"trace[2141312826] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:3668; }","duration":"214.021182ms","start":"2026-06-28T19:56:13.308034Z","end":"2026-06-28T19:56:13.522055Z","steps":["trace[2141312826] 'agreement among raft nodes before linearized reading' (duration: 213.838537ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:13.52229Z","caller":"traceutil/trace.go:171","msg":"trace[628474751] transaction","detail":"{read_only:false; response_revision:3668; number_of_response:1; }","duration":"247.62013ms","start":"2026-06-28T19:56:13.27466Z","end":"2026-06-28T19:56:13.52228Z","steps":["trace[628474751] 'process raft request' (duration: 236.38622ms)","trace[628474751] 'compare' (duration: 10.669858ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:56:18.992639Z","caller":"traceutil/trace.go:171","msg":"trace[1901985175] transaction","detail":"{read_only:false; response_revision:3757; number_of_response:1; }","duration":"103.670942ms","start":"2026-06-28T19:56:18.888944Z","end":"2026-06-28T19:56:18.992615Z","steps":["trace[1901985175] 'process raft request' (duration: 47.559504ms)","trace[1901985175] 'compare' (duration: 55.845892ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:56:19.268197Z","caller":"traceutil/trace.go:171","msg":"trace[1470248710] transaction","detail":"{read_only:false; response_revision:3758; number_of_response:1; }","duration":"100.949272ms","start":"2026-06-28T19:56:19.167226Z","end":"2026-06-28T19:56:19.268175Z","steps":["trace[1470248710] 'process raft request' (duration: 100.704087ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:21.687524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.969174ms","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-28T19:56:21.687637Z","caller":"traceutil/trace.go:171","msg":"trace[1204235410] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3772; }","duration":"101.102856ms","start":"2026-06-28T19:56:21.586485Z","end":"2026-06-28T19:56:21.687588Z","steps":["trace[1204235410] 'range keys from in-memory index tree' (duration: 100.774411ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:24.832624Z","caller":"traceutil/trace.go:171","msg":"trace[1969451285] transaction","detail":"{read_only:false; response_revision:3792; number_of_response:1; }","duration":"157.707139ms","start":"2026-06-28T19:56:24.674891Z","end":"2026-06-28T19:56:24.832599Z","steps":["trace[1969451285] 'process raft request' (duration: 157.435233ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:25.051593Z","caller":"traceutil/trace.go:171","msg":"trace[673015751] transaction","detail":"{read_only:false; response_revision:3793; number_of_response:1; }","duration":"250.380802ms","start":"2026-06-28T19:56:24.80119Z","end":"2026-06-28T19:56:25.051571Z","steps":["trace[673015751] 'process raft request' (duration: 231.319101ms)","trace[673015751] 'compare' (duration: 18.804166ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:56:30.054636Z","caller":"traceutil/trace.go:171","msg":"trace[715904684] transaction","detail":"{read_only:false; response_revision:3823; number_of_response:1; }","duration":"169.715026ms","start":"2026-06-28T19:56:29.884904Z","end":"2026-06-28T19:56:30.054619Z","steps":["trace[715904684] 'process raft request' (duration: 169.664815ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:30.054644Z","caller":"traceutil/trace.go:171","msg":"trace[543567887] transaction","detail":"{read_only:false; response_revision:3822; number_of_response:1; }","duration":"171.137264ms","start":"2026-06-28T19:56:29.883483Z","end":"2026-06-28T19:56:30.05462Z","steps":["trace[543567887] 'process raft request' (duration: 114.560093ms)","trace[543567887] 'compare' (duration: 56.449498ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:56:45.843021Z","caller":"traceutil/trace.go:171","msg":"trace[446117876] transaction","detail":"{read_only:false; response_revision:3907; number_of_response:1; }","duration":"138.550391ms","start":"2026-06-28T19:56:45.704451Z","end":"2026-06-28T19:56:45.843001Z","steps":["trace[446117876] 'process raft request' (duration: 138.426618ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:46.142897Z","caller":"traceutil/trace.go:171","msg":"trace[1641577796] transaction","detail":"{read_only:false; response_revision:3910; number_of_response:1; }","duration":"149.990797ms","start":"2026-06-28T19:56:45.992878Z","end":"2026-06-28T19:56:46.142868Z","steps":["trace[1641577796] 'process raft request' (duration: 93.155883ms)","trace[1641577796] 'compare' (duration: 56.413445ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:56:46.143126Z","caller":"traceutil/trace.go:171","msg":"trace[380901835] linearizableReadLoop","detail":"{readStateIndex:4073; appliedIndex:4071; }","duration":"112.020536ms","start":"2026-06-28T19:56:46.031076Z","end":"2026-06-28T19:56:46.143097Z","steps":["trace[380901835] 'read index received' (duration: 54.963488ms)","trace[380901835] 'applied index is now lower than readState.Index' (duration: 57.055728ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:56:46.143168Z","caller":"traceutil/trace.go:171","msg":"trace[333474499] transaction","detail":"{read_only:false; response_revision:3911; number_of_response:1; }","duration":"140.438783ms","start":"2026-06-28T19:56:46.002723Z","end":"2026-06-28T19:56:46.143162Z","steps":["trace[333474499] 'process raft request' (duration: 140.205869ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:46.143231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.144328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:56:46.143257Z","caller":"traceutil/trace.go:171","msg":"trace[971555212] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3911; }","duration":"112.215659ms","start":"2026-06-28T19:56:46.031035Z","end":"2026-06-28T19:56:46.14325Z","steps":["trace[971555212] 'agreement among raft nodes before linearized reading' (duration: 112.157088ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:56:46.338337Z","caller":"traceutil/trace.go:171","msg":"trace[1551271275] transaction","detail":"{read_only:false; response_revision:3914; number_of_response:1; }","duration":"100.27769ms","start":"2026-06-28T19:56:46.238021Z","end":"2026-06-28T19:56:46.338299Z","steps":["trace[1551271275] 'process raft request' (duration: 55.115891ms)","trace[1551271275] 'compare' (duration: 44.802022ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:56:50.271733Z","caller":"traceutil/trace.go:171","msg":"trace[1426049345] transaction","detail":"{read_only:false; response_revision:3929; number_of_response:1; }","duration":"117.711781ms","start":"2026-06-28T19:56:50.153994Z","end":"2026-06-28T19:56:50.271706Z","steps":["trace[1426049345] 'process raft request' (duration: 36.381866ms)","trace[1426049345] 'compare' (duration: 81.156372ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:56:58.396507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.000907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.216\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-28T19:56:58.396596Z","caller":"traceutil/trace.go:171","msg":"trace[1525839992] range","detail":"{range_begin:/registry/masterleases/199.204.45.216; range_end:; response_count:1; response_revision:3994; }","duration":"368.153919ms","start":"2026-06-28T19:56:58.028425Z","end":"2026-06-28T19:56:58.396579Z","steps":["trace[1525839992] 'range keys from in-memory index tree' (duration: 367.824323ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:58.396529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.044118ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-28T19:56:58.396641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:58.028401Z","time spent":"368.23158ms","remote":"127.0.0.1:57844","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.216\" "} {"level":"info","ts":"2026-06-28T19:56:58.396662Z","caller":"traceutil/trace.go:171","msg":"trace[1684966641] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:3994; }","duration":"189.194421ms","start":"2026-06-28T19:56:58.207448Z","end":"2026-06-28T19:56:58.396642Z","steps":["trace[1684966641] 'range keys from in-memory index tree' (duration: 188.998217ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:58.396888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.905187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:56:58.397046Z","caller":"traceutil/trace.go:171","msg":"trace[1898866733] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3994; }","duration":"364.115693ms","start":"2026-06-28T19:56:58.032905Z","end":"2026-06-28T19:56:58.39702Z","steps":["trace[1898866733] 'range keys from in-memory index tree' (duration: 363.766955ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:58.397139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:58.032888Z","time spent":"364.231845ms","remote":"127.0.0.1:53976","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-28T19:56:58.397317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.021305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-28T19:56:58.397449Z","caller":"traceutil/trace.go:171","msg":"trace[1826991126] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:3994; }","duration":"361.195397ms","start":"2026-06-28T19:56:58.036225Z","end":"2026-06-28T19:56:58.39742Z","steps":["trace[1826991126] 'count revisions from in-memory index tree' (duration: 360.957913ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:56:58.397516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.942924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-28T19:56:58.397523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:56:58.036214Z","time spent":"361.290599ms","remote":"127.0.0.1:58336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":316,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"info","ts":"2026-06-28T19:56:58.397557Z","caller":"traceutil/trace.go:171","msg":"trace[1375479378] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3994; }","duration":"271.019575ms","start":"2026-06-28T19:56:58.126524Z","end":"2026-06-28T19:56:58.397544Z","steps":["trace[1375479378] 'range keys from in-memory index tree' (duration: 270.779921ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:02.210049Z","caller":"traceutil/trace.go:171","msg":"trace[888066694] linearizableReadLoop","detail":"{readStateIndex:4185; appliedIndex:4184; }","duration":"175.614424ms","start":"2026-06-28T19:57:02.034395Z","end":"2026-06-28T19:57:02.210009Z","steps":["trace[888066694] 'read index received' (duration: 170.803123ms)","trace[888066694] 'applied index is now lower than readState.Index' (duration: 4.806671ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:57:02.210054Z","caller":"traceutil/trace.go:171","msg":"trace[184384135] transaction","detail":"{read_only:false; response_revision:4019; number_of_response:1; }","duration":"250.825797ms","start":"2026-06-28T19:57:01.959196Z","end":"2026-06-28T19:57:02.210022Z","steps":["trace[184384135] 'process raft request' (duration: 246.042507ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:02.210328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.904559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:57:02.210419Z","caller":"traceutil/trace.go:171","msg":"trace[1265621738] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4019; }","duration":"176.049192ms","start":"2026-06-28T19:57:02.034349Z","end":"2026-06-28T19:57:02.210398Z","steps":["trace[1265621738] 'agreement among raft nodes before linearized reading' (duration: 175.914739ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:02.475937Z","caller":"traceutil/trace.go:171","msg":"trace[353861034] transaction","detail":"{read_only:false; response_revision:4021; number_of_response:1; }","duration":"204.055388ms","start":"2026-06-28T19:57:02.27186Z","end":"2026-06-28T19:57:02.475915Z","steps":["trace[353861034] 'process raft request' (duration: 203.257293ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:02.825799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.872287ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:57:02.826059Z","caller":"traceutil/trace.go:171","msg":"trace[280439698] linearizableReadLoop","detail":"{readStateIndex:4191; appliedIndex:4187; }","duration":"344.922789ms","start":"2026-06-28T19:57:02.48112Z","end":"2026-06-28T19:57:02.826043Z","steps":["trace[280439698] 'read index received' (duration: 231.727656ms)","trace[280439698] 'applied index is now lower than readState.Index' (duration: 113.194153ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:57:02.826364Z","caller":"traceutil/trace.go:171","msg":"trace[1858651937] transaction","detail":"{read_only:false; response_revision:4024; number_of_response:1; }","duration":"355.813403ms","start":"2026-06-28T19:57:02.470522Z","end":"2026-06-28T19:57:02.826335Z","steps":["trace[1858651937] 'process raft request' (duration: 355.442537ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:02.826415Z","caller":"traceutil/trace.go:171","msg":"trace[1181428200] transaction","detail":"{read_only:false; response_revision:4022; number_of_response:1; }","duration":"386.827115ms","start":"2026-06-28T19:57:02.439572Z","end":"2026-06-28T19:57:02.826399Z","steps":["trace[1181428200] 'process raft request' (duration: 273.265435ms)","trace[1181428200] 'compare' (duration: 112.734654ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:57:02.82645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:02.470507Z","time spent":"355.902815ms","remote":"127.0.0.1:58066","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-28T19:57:02.82661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.47089ms","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-28T19:57:02.826326Z","caller":"traceutil/trace.go:171","msg":"trace[530402237] transaction","detail":"{read_only:false; response_revision:4023; number_of_response:1; }","duration":"356.087398ms","start":"2026-06-28T19:57:02.470209Z","end":"2026-06-28T19:57:02.826297Z","steps":["trace[530402237] 'process raft request' (duration: 355.695401ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:02.826665Z","caller":"traceutil/trace.go:171","msg":"trace[463620498] transaction","detail":"{read_only:false; response_revision:4025; number_of_response:1; }","duration":"346.996849ms","start":"2026-06-28T19:57:02.479645Z","end":"2026-06-28T19:57:02.826641Z","steps":["trace[463620498] 'process raft request' (duration: 346.359117ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:02.82673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:02.470182Z","time spent":"356.520847ms","remote":"127.0.0.1:58066","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:57:02.826664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.424207ms","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-28T19:57:02.82689Z","caller":"traceutil/trace.go:171","msg":"trace[508233897] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4025; }","duration":"330.668361ms","start":"2026-06-28T19:57:02.496211Z","end":"2026-06-28T19:57:02.826879Z","steps":["trace[508233897] 'agreement among raft nodes before linearized reading' (duration: 330.357706ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:02.82711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.510658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1261"} {"level":"warn","ts":"2026-06-28T19:57:02.826715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:02.439542Z","time spent":"387.04756ms","remote":"127.0.0.1:58066","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:57:02.827154Z","caller":"traceutil/trace.go:171","msg":"trace[176173132] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4025; }","duration":"323.581089ms","start":"2026-06-28T19:57:02.50356Z","end":"2026-06-28T19:57:02.827141Z","steps":["trace[176173132] 'agreement among raft nodes before linearized reading' (duration: 323.426356ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:02.827131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.995038ms","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-28T19:57:02.827185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:02.503551Z","time spent":"323.62582ms","remote":"127.0.0.1:58002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1283,"request content":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-admission\" "} {"level":"warn","ts":"2026-06-28T19:57:02.827024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:02.496201Z","time spent":"330.776754ms","remote":"127.0.0.1:58066","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":"info","ts":"2026-06-28T19:57:02.827247Z","caller":"traceutil/trace.go:171","msg":"trace[629449707] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4025; }","duration":"330.220804ms","start":"2026-06-28T19:57:02.497Z","end":"2026-06-28T19:57:02.82722Z","steps":["trace[629449707] 'agreement among raft nodes before linearized reading' (duration: 329.824556ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:02.826705Z","caller":"traceutil/trace.go:171","msg":"trace[1471088692] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4025; }","duration":"345.590493ms","start":"2026-06-28T19:57:02.481098Z","end":"2026-06-28T19:57:02.826688Z","steps":["trace[1471088692] 'agreement among raft nodes before linearized reading' (duration: 345.268216ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:02.827335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:02.496992Z","time spent":"330.332856ms","remote":"127.0.0.1:58066","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-28T19:57:02.827394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:02.48109Z","time spent":"346.284305ms","remote":"127.0.0.1:58066","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-28T19:57:02.827401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.11222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-28T19:57:02.827467Z","caller":"traceutil/trace.go:171","msg":"trace[1365564668] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4025; }","duration":"331.196012ms","start":"2026-06-28T19:57:02.496252Z","end":"2026-06-28T19:57:02.827448Z","steps":["trace[1365564668] 'agreement among raft nodes before linearized reading' (duration: 331.013749ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:02.82751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:02.496247Z","time spent":"331.251133ms","remote":"127.0.0.1:58066","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-28T19:57:02.828227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:02.479626Z","time spent":"348.494246ms","remote":"127.0.0.1:57894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":711,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-28T19:57:03.102918Z","caller":"traceutil/trace.go:171","msg":"trace[1042981420] transaction","detail":"{read_only:false; response_revision:4027; number_of_response:1; }","duration":"271.358549ms","start":"2026-06-28T19:57:02.831531Z","end":"2026-06-28T19:57:03.102889Z","steps":["trace[1042981420] 'process raft request' (duration: 228.07677ms)","trace[1042981420] 'compare' (duration: 42.937713ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:57:03.103175Z","caller":"traceutil/trace.go:171","msg":"trace[940801966] linearizableReadLoop","detail":"{readStateIndex:4196; appliedIndex:4192; }","duration":"191.852867ms","start":"2026-06-28T19:57:02.911304Z","end":"2026-06-28T19:57:03.103157Z","steps":["trace[940801966] 'read index received' (duration: 148.317072ms)","trace[940801966] 'applied index is now lower than readState.Index' (duration: 43.534885ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:57:03.103658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.356256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1370"} {"level":"info","ts":"2026-06-28T19:57:03.103725Z","caller":"traceutil/trace.go:171","msg":"trace[1426978835] range","detail":"{range_begin:/registry/clusterroles/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4030; }","duration":"192.459258ms","start":"2026-06-28T19:57:02.911248Z","end":"2026-06-28T19:57:03.103707Z","steps":["trace[1426978835] 'agreement among raft nodes before linearized reading' (duration: 192.242934ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:03.103402Z","caller":"traceutil/trace.go:171","msg":"trace[365682574] transaction","detail":"{read_only:false; response_revision:4028; number_of_response:1; }","duration":"271.674175ms","start":"2026-06-28T19:57:02.831693Z","end":"2026-06-28T19:57:03.103367Z","steps":["trace[365682574] 'process raft request' (duration: 271.107235ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:03.103422Z","caller":"traceutil/trace.go:171","msg":"trace[1293214560] transaction","detail":"{read_only:false; response_revision:4029; number_of_response:1; }","duration":"271.023473ms","start":"2026-06-28T19:57:02.832386Z","end":"2026-06-28T19:57:03.103409Z","steps":["trace[1293214560] 'process raft request' (duration: 270.685747ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:03.103474Z","caller":"traceutil/trace.go:171","msg":"trace[936120392] transaction","detail":"{read_only:false; response_revision:4030; number_of_response:1; }","duration":"271.007233ms","start":"2026-06-28T19:57:02.832458Z","end":"2026-06-28T19:57:03.103465Z","steps":["trace[936120392] 'process raft request' (duration: 270.662587ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:03.416026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.681402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1294"} {"level":"info","ts":"2026-06-28T19:57:03.416108Z","caller":"traceutil/trace.go:171","msg":"trace[452157287] range","detail":"{range_begin:/registry/roles/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4032; }","duration":"206.816385ms","start":"2026-06-28T19:57:03.209272Z","end":"2026-06-28T19:57:03.416089Z","steps":["trace[452157287] 'range keys from in-memory index tree' (duration: 206.524709ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:03.416202Z","caller":"traceutil/trace.go:171","msg":"trace[856195312] transaction","detail":"{read_only:false; response_revision:4033; number_of_response:1; }","duration":"125.941379ms","start":"2026-06-28T19:57:03.290241Z","end":"2026-06-28T19:57:03.416183Z","steps":["trace[856195312] 'process raft request' (duration: 125.534731ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:03.680749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.661503ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-28T19:57:03.681487Z","caller":"traceutil/trace.go:171","msg":"trace[1576355199] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4034; }","duration":"263.794941ms","start":"2026-06-28T19:57:03.417668Z","end":"2026-06-28T19:57:03.681463Z","steps":["trace[1576355199] 'process raft request' (duration: 263.24069ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:06.960826Z","caller":"traceutil/trace.go:171","msg":"trace[1117050191] transaction","detail":"{read_only:false; response_revision:4374; number_of_response:1; }","duration":"109.747657ms","start":"2026-06-28T19:57:06.851058Z","end":"2026-06-28T19:57:06.960806Z","steps":["trace[1117050191] 'process raft request' (duration: 109.710047ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:06.961229Z","caller":"traceutil/trace.go:171","msg":"trace[1091432206] transaction","detail":"{read_only:false; response_revision:4373; number_of_response:1; }","duration":"112.727652ms","start":"2026-06-28T19:57:06.848468Z","end":"2026-06-28T19:57:06.961196Z","steps":["trace[1091432206] 'process raft request' (duration: 112.162931ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:08.348611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.127883ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:57:08.348741Z","caller":"traceutil/trace.go:171","msg":"trace[145661273] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:4417; }","duration":"141.297976ms","start":"2026-06-28T19:57:08.207425Z","end":"2026-06-28T19:57:08.348723Z","steps":["trace[145661273] 'range keys from in-memory index tree' (duration: 141.099952ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:08.349209Z","caller":"traceutil/trace.go:171","msg":"trace[995224135] linearizableReadLoop","detail":"{readStateIndex:4589; appliedIndex:4588; }","duration":"328.766692ms","start":"2026-06-28T19:57:08.020429Z","end":"2026-06-28T19:57:08.349195Z","steps":["trace[995224135] 'read index received' (duration: 299.890735ms)","trace[995224135] 'applied index is now lower than readState.Index' (duration: 28.875286ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:57:08.349297Z","caller":"traceutil/trace.go:171","msg":"trace[1326842385] transaction","detail":"{read_only:false; response_revision:4418; number_of_response:1; }","duration":"329.458364ms","start":"2026-06-28T19:57:08.019819Z","end":"2026-06-28T19:57:08.349277Z","steps":["trace[1326842385] 'process raft request' (duration: 300.485806ms)","trace[1326842385] 'compare' (duration: 28.248524ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:57:08.34949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:08.019796Z","time spent":"329.593776ms","remote":"127.0.0.1:48190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4722,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:57:08.349967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.502425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-78d0bf95-fa4c-4e9a-9f59-454722fe102d\" ","response":"range_response_count:1 size:2708"} {"level":"info","ts":"2026-06-28T19:57:08.350107Z","caller":"traceutil/trace.go:171","msg":"trace[1665676161] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-78d0bf95-fa4c-4e9a-9f59-454722fe102d; range_end:; response_count:1; response_revision:4418; }","duration":"329.684188ms","start":"2026-06-28T19:57:08.020402Z","end":"2026-06-28T19:57:08.350086Z","steps":["trace[1665676161] 'agreement among raft nodes before linearized reading' (duration: 329.348602ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:08.350173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:08.020389Z","time spent":"329.774971ms","remote":"127.0.0.1:57982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":2730,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-78d0bf95-fa4c-4e9a-9f59-454722fe102d\" "} {"level":"info","ts":"2026-06-28T19:57:08.370282Z","caller":"traceutil/trace.go:171","msg":"trace[1827290765] transaction","detail":"{read_only:false; response_revision:4419; number_of_response:1; }","duration":"349.264823ms","start":"2026-06-28T19:57:08.020992Z","end":"2026-06-28T19:57:08.370257Z","steps":["trace[1827290765] 'process raft request' (duration: 349.116651ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:08.37054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:08.020969Z","time spent":"349.474956ms","remote":"127.0.0.1:58276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11966,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:57:08.370859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.868954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-28T19:57:08.37095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.047788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:11981"} {"level":"info","ts":"2026-06-28T19:57:08.370982Z","caller":"traceutil/trace.go:171","msg":"trace[32555333] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4419; }","duration":"336.048027ms","start":"2026-06-28T19:57:08.034906Z","end":"2026-06-28T19:57:08.370954Z","steps":["trace[32555333] 'agreement among raft nodes before linearized reading' (duration: 335.731452ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:08.370987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.739823ms","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-28T19:57:08.371031Z","caller":"traceutil/trace.go:171","msg":"trace[1449384484] range","detail":"{range_begin:/registry/statefulsets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4419; }","duration":"350.158539ms","start":"2026-06-28T19:57:08.020859Z","end":"2026-06-28T19:57:08.371018Z","steps":["trace[1449384484] 'agreement among raft nodes before linearized reading' (duration: 349.549438ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:08.371035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:08.034894Z","time spent":"336.132868ms","remote":"127.0.0.1:53964","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-28T19:57:08.371039Z","caller":"traceutil/trace.go:171","msg":"trace[1689052819] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4419; }","duration":"305.825845ms","start":"2026-06-28T19:57:08.0652Z","end":"2026-06-28T19:57:08.371026Z","steps":["trace[1689052819] 'agreement among raft nodes before linearized reading' (duration: 305.253395ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:08.371078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:08.065182Z","time spent":"305.888776ms","remote":"127.0.0.1:58066","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-28T19:57:08.371051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.632769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"warn","ts":"2026-06-28T19:57:08.371084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.784003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.216\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-28T19:57:08.371204Z","caller":"traceutil/trace.go:171","msg":"trace[911129859] range","detail":"{range_begin:/registry/masterleases/199.204.45.216; range_end:; response_count:1; response_revision:4419; }","duration":"341.925017ms","start":"2026-06-28T19:57:08.029269Z","end":"2026-06-28T19:57:08.371194Z","steps":["trace[911129859] 'agreement among raft nodes before linearized reading' (duration: 341.666142ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:08.371297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:08.029258Z","time spent":"342.030119ms","remote":"127.0.0.1:57844","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.216\" "} {"level":"info","ts":"2026-06-28T19:57:08.371138Z","caller":"traceutil/trace.go:171","msg":"trace[992164471] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:4419; }","duration":"129.757892ms","start":"2026-06-28T19:57:08.241363Z","end":"2026-06-28T19:57:08.371121Z","steps":["trace[992164471] 'agreement among raft nodes before linearized reading' (duration: 129.153522ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:08.371795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.111071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:46 size:1954238"} {"level":"info","ts":"2026-06-28T19:57:08.371828Z","caller":"traceutil/trace.go:171","msg":"trace[639093383] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:46; response_revision:4419; }","duration":"213.200833ms","start":"2026-06-28T19:57:08.15862Z","end":"2026-06-28T19:57:08.371821Z","steps":["trace[639093383] 'agreement among raft nodes before linearized reading' (duration: 212.547742ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:08.372953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:08.020839Z","time spent":"352.098896ms","remote":"127.0.0.1:58276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":12003,"request content":"key:\"/registry/statefulsets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" "} {"level":"info","ts":"2026-06-28T19:57:12.212495Z","caller":"traceutil/trace.go:171","msg":"trace[1607193016] linearizableReadLoop","detail":"{readStateIndex:4679; appliedIndex:4678; }","duration":"180.395963ms","start":"2026-06-28T19:57:12.032079Z","end":"2026-06-28T19:57:12.212475Z","steps":["trace[1607193016] 'read index received' (duration: 180.243761ms)","trace[1607193016] 'applied index is now lower than readState.Index' (duration: 151.232µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:57:12.212794Z","caller":"traceutil/trace.go:171","msg":"trace[816445827] transaction","detail":"{read_only:false; response_revision:4507; number_of_response:1; }","duration":"187.165269ms","start":"2026-06-28T19:57:12.02562Z","end":"2026-06-28T19:57:12.212785Z","steps":["trace[816445827] 'process raft request' (duration: 186.754321ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:12.212958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.865602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:57:12.21303Z","caller":"traceutil/trace.go:171","msg":"trace[915396283] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4507; }","duration":"180.974145ms","start":"2026-06-28T19:57:12.032049Z","end":"2026-06-28T19:57:12.213023Z","steps":["trace[915396283] 'agreement among raft nodes before linearized reading' (duration: 180.874843ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:12.213157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.94378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-78d0bf95-fa4c-4e9a-9f59-454722fe102d\" ","response":"range_response_count:1 size:4079"} {"level":"info","ts":"2026-06-28T19:57:12.213181Z","caller":"traceutil/trace.go:171","msg":"trace[734027007] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-78d0bf95-fa4c-4e9a-9f59-454722fe102d; range_end:; response_count:1; response_revision:4507; }","duration":"170.96852ms","start":"2026-06-28T19:57:12.042206Z","end":"2026-06-28T19:57:12.213175Z","steps":["trace[734027007] 'agreement among raft nodes before linearized reading' (duration: 170.929379ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:14.99258Z","caller":"traceutil/trace.go:171","msg":"trace[193616608] transaction","detail":"{read_only:false; response_revision:4580; number_of_response:1; }","duration":"391.628196ms","start":"2026-06-28T19:57:14.600923Z","end":"2026-06-28T19:57:14.992551Z","steps":["trace[193616608] 'process raft request' (duration: 332.835842ms)","trace[193616608] 'compare' (duration: 58.160763ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:57:14.992707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:14.600902Z","time spent":"391.744438ms","remote":"127.0.0.1:57894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":876,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-28T19:57:14.992996Z","caller":"traceutil/trace.go:171","msg":"trace[2057750377] linearizableReadLoop","detail":"{readStateIndex:4757; appliedIndex:4756; }","duration":"377.331173ms","start":"2026-06-28T19:57:14.615595Z","end":"2026-06-28T19:57:14.992926Z","steps":["trace[2057750377] 'read index received' (duration: 318.108441ms)","trace[2057750377] 'applied index is now lower than readState.Index' (duration: 59.220372ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:57:14.993137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.237978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:57:14.993211Z","caller":"traceutil/trace.go:171","msg":"trace[310684442] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:4583; }","duration":"353.35021ms","start":"2026-06-28T19:57:14.639851Z","end":"2026-06-28T19:57:14.993201Z","steps":["trace[310684442] 'agreement among raft nodes before linearized reading' (duration: 353.246578ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:14.993244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:14.639834Z","time spent":"353.396511ms","remote":"127.0.0.1:58108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-28T19:57:14.993716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.114467ms","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-28T19:57:14.993757Z","caller":"traceutil/trace.go:171","msg":"trace[1867785573] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4583; }","duration":"378.156868ms","start":"2026-06-28T19:57:14.61559Z","end":"2026-06-28T19:57:14.993746Z","steps":["trace[1867785573] 'agreement among raft nodes before linearized reading' (duration: 377.462445ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:14.993786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:14.615546Z","time spent":"378.230369ms","remote":"127.0.0.1:57908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":47,"response size":2206995,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"info","ts":"2026-06-28T19:57:20.413752Z","caller":"traceutil/trace.go:171","msg":"trace[971931286] transaction","detail":"{read_only:false; response_revision:4672; number_of_response:1; }","duration":"315.373443ms","start":"2026-06-28T19:57:20.098359Z","end":"2026-06-28T19:57:20.413732Z","steps":["trace[971931286] 'process raft request' (duration: 315.110069ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:20.41386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:20.098337Z","time spent":"315.461775ms","remote":"127.0.0.1:57982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3748,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:57:20.823424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.395822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-06-28T19:57:20.823506Z","caller":"traceutil/trace.go:171","msg":"trace[1883467728] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4672; }","duration":"271.542835ms","start":"2026-06-28T19:57:20.551946Z","end":"2026-06-28T19:57:20.823489Z","steps":["trace[1883467728] 'range keys from in-memory index tree' (duration: 271.160547ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:20.823875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.885681ms","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-28T19:57:20.823854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.258667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:57:20.823917Z","caller":"traceutil/trace.go:171","msg":"trace[344392061] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4672; }","duration":"294.967802ms","start":"2026-06-28T19:57:20.52894Z","end":"2026-06-28T19:57:20.823908Z","steps":["trace[344392061] 'range keys from in-memory index tree' (duration: 294.757729ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:20.823956Z","caller":"traceutil/trace.go:171","msg":"trace[1414674865] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:4672; }","duration":"290.39047ms","start":"2026-06-28T19:57:20.533547Z","end":"2026-06-28T19:57:20.823937Z","steps":["trace[1414674865] 'count revisions from in-memory index tree' (duration: 290.147056ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:20.824208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.663657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:57:20.824268Z","caller":"traceutil/trace.go:171","msg":"trace[1663759663] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:4672; }","duration":"143.765768ms","start":"2026-06-28T19:57:20.68049Z","end":"2026-06-28T19:57:20.824255Z","steps":["trace[1663759663] 'count revisions from in-memory index tree' (duration: 143.597506ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:21.862022Z","caller":"traceutil/trace.go:171","msg":"trace[340699184] linearizableReadLoop","detail":"{readStateIndex:4863; appliedIndex:4862; }","duration":"457.577232ms","start":"2026-06-28T19:57:21.404424Z","end":"2026-06-28T19:57:21.862001Z","steps":["trace[340699184] 'read index received' (duration: 457.440089ms)","trace[340699184] 'applied index is now lower than readState.Index' (duration: 136.243µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:57:21.86212Z","caller":"traceutil/trace.go:171","msg":"trace[1951869130] transaction","detail":"{read_only:false; response_revision:4684; number_of_response:1; }","duration":"458.100361ms","start":"2026-06-28T19:57:21.404012Z","end":"2026-06-28T19:57:21.862113Z","steps":["trace[1951869130] 'process raft request' (duration: 457.840495ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:21.862207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:21.404001Z","time spent":"458.142062ms","remote":"127.0.0.1:57894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":725,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:57:21.862814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.366016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1451"} {"level":"info","ts":"2026-06-28T19:57:21.8629Z","caller":"traceutil/trace.go:171","msg":"trace[1091713506] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4684; }","duration":"458.473787ms","start":"2026-06-28T19:57:21.404404Z","end":"2026-06-28T19:57:21.862878Z","steps":["trace[1091713506] 'agreement among raft nodes before linearized reading' (duration: 457.934577ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:21.863266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:21.404392Z","time spent":"458.773152ms","remote":"127.0.0.1:57956","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1473,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-06-28T19:57:21.891082Z","caller":"traceutil/trace.go:171","msg":"trace[1158325927] transaction","detail":"{read_only:false; response_revision:4686; number_of_response:1; }","duration":"351.81637ms","start":"2026-06-28T19:57:21.539238Z","end":"2026-06-28T19:57:21.891054Z","steps":["trace[1158325927] 'process raft request' (duration: 351.687948ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:21.891239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:21.539213Z","time spent":"351.948042ms","remote":"127.0.0.1:58066","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:57:21.891076Z","caller":"traceutil/trace.go:171","msg":"trace[191158119] transaction","detail":"{read_only:false; response_revision:4685; number_of_response:1; }","duration":"462.899238ms","start":"2026-06-28T19:57:21.428131Z","end":"2026-06-28T19:57:21.89103Z","steps":["trace[191158119] 'process raft request' (duration: 462.662244ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:21.891405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:21.428109Z","time spent":"463.260695ms","remote":"127.0.0.1:57894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":787,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-28T19:57:21.891099Z","caller":"traceutil/trace.go:171","msg":"trace[126893215] transaction","detail":"{read_only:false; response_revision:4687; number_of_response:1; }","duration":"306.791689ms","start":"2026-06-28T19:57:21.584283Z","end":"2026-06-28T19:57:21.891075Z","steps":["trace[126893215] 'process raft request' (duration: 306.702707ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:21.891515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.885539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-927161ef-7b92-4f6e-9c43-8d51f276fed9\" ","response":"range_response_count:1 size:3763"} {"level":"info","ts":"2026-06-28T19:57:21.891581Z","caller":"traceutil/trace.go:171","msg":"trace[203056171] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-927161ef-7b92-4f6e-9c43-8d51f276fed9; range_end:; response_count:1; response_revision:4687; }","duration":"473.985501ms","start":"2026-06-28T19:57:21.417578Z","end":"2026-06-28T19:57:21.891564Z","steps":["trace[203056171] 'agreement among raft nodes before linearized reading' (duration: 473.819028ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:21.891623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:21.417567Z","time spent":"474.046562ms","remote":"127.0.0.1:57982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3785,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-927161ef-7b92-4f6e-9c43-8d51f276fed9\" "} {"level":"warn","ts":"2026-06-28T19:57:21.891735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:21.584258Z","time spent":"307.314679ms","remote":"127.0.0.1:58066","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:57:22.002908Z","caller":"traceutil/trace.go:171","msg":"trace[242795857] transaction","detail":"{read_only:false; response_revision:4688; number_of_response:1; }","duration":"105.597418ms","start":"2026-06-28T19:57:21.897288Z","end":"2026-06-28T19:57:22.002885Z","steps":["trace[242795857] 'process raft request' (duration: 69.425657ms)","trace[242795857] 'compare' (duration: 36.067119ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:57:23.179566Z","caller":"traceutil/trace.go:171","msg":"trace[166754034] linearizableReadLoop","detail":"{readStateIndex:4879; appliedIndex:4878; }","duration":"144.784095ms","start":"2026-06-28T19:57:23.034751Z","end":"2026-06-28T19:57:23.179535Z","steps":["trace[166754034] 'read index received' (duration: 143.207546ms)","trace[166754034] 'applied index is now lower than readState.Index' (duration: 1.574179ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:57:23.179594Z","caller":"traceutil/trace.go:171","msg":"trace[762051452] transaction","detail":"{read_only:false; response_revision:4700; number_of_response:1; }","duration":"150.394578ms","start":"2026-06-28T19:57:23.029165Z","end":"2026-06-28T19:57:23.17956Z","steps":["trace[762051452] 'process raft request' (duration: 148.781808ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:23.180627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.855155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:57:23.18068Z","caller":"traceutil/trace.go:171","msg":"trace[1485794891] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4700; }","duration":"145.963126ms","start":"2026-06-28T19:57:23.034702Z","end":"2026-06-28T19:57:23.180666Z","steps":["trace[1485794891] 'agreement among raft nodes before linearized reading' (duration: 145.001039ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:23.18307Z","caller":"traceutil/trace.go:171","msg":"trace[1654639353] transaction","detail":"{read_only:false; response_revision:4701; number_of_response:1; }","duration":"120.345411ms","start":"2026-06-28T19:57:23.062705Z","end":"2026-06-28T19:57:23.183051Z","steps":["trace[1654639353] 'process raft request' (duration: 120.134977ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:23.183171Z","caller":"traceutil/trace.go:171","msg":"trace[203290581] transaction","detail":"{read_only:false; response_revision:4702; number_of_response:1; }","duration":"110.93703ms","start":"2026-06-28T19:57:23.072163Z","end":"2026-06-28T19:57:23.1831Z","steps":["trace[203290581] 'process raft request' (duration: 110.796548ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:25.261117Z","caller":"traceutil/trace.go:171","msg":"trace[2050699065] transaction","detail":"{read_only:false; response_revision:4736; number_of_response:1; }","duration":"108.5374ms","start":"2026-06-28T19:57:25.152538Z","end":"2026-06-28T19:57:25.261075Z","steps":["trace[2050699065] 'process raft request' (duration: 108.271736ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:26.28767Z","caller":"traceutil/trace.go:171","msg":"trace[730421005] linearizableReadLoop","detail":"{readStateIndex:4930; appliedIndex:4929; }","duration":"380.172165ms","start":"2026-06-28T19:57:25.907469Z","end":"2026-06-28T19:57:26.287641Z","steps":["trace[730421005] 'read index received' (duration: 380.008353ms)","trace[730421005] 'applied index is now lower than readState.Index' (duration: 160.402µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:57:26.287736Z","caller":"traceutil/trace.go:171","msg":"trace[2113815774] transaction","detail":"{read_only:false; response_revision:4750; number_of_response:1; }","duration":"383.502274ms","start":"2026-06-28T19:57:25.904185Z","end":"2026-06-28T19:57:26.287687Z","steps":["trace[2113815774] 'process raft request' (duration: 383.288971ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:26.287927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:25.904166Z","time spent":"383.66873ms","remote":"127.0.0.1:58066","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-28T19:57:26.287947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.647491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"warn","ts":"2026-06-28T19:57:26.287952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.460201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-927161ef-7b92-4f6e-9c43-8d51f276fed9\" ","response":"range_response_count:1 size:3951"} {"level":"info","ts":"2026-06-28T19:57:26.288005Z","caller":"traceutil/trace.go:171","msg":"trace[1902663231] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4750; }","duration":"327.743983ms","start":"2026-06-28T19:57:25.960244Z","end":"2026-06-28T19:57:26.287988Z","steps":["trace[1902663231] 'agreement among raft nodes before linearized reading' (duration: 327.553879ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:26.288017Z","caller":"traceutil/trace.go:171","msg":"trace[1113572009] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-927161ef-7b92-4f6e-9c43-8d51f276fed9; range_end:; response_count:1; response_revision:4750; }","duration":"380.569572ms","start":"2026-06-28T19:57:25.90743Z","end":"2026-06-28T19:57:26.287999Z","steps":["trace[1113572009] 'agreement among raft nodes before linearized reading' (duration: 380.361518ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:26.288066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:25.96023Z","time spent":"327.822414ms","remote":"127.0.0.1:57982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12235,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-28T19:57:26.288066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:25.90742Z","time spent":"380.632183ms","remote":"127.0.0.1:57982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3973,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-927161ef-7b92-4f6e-9c43-8d51f276fed9\" "} {"level":"warn","ts":"2026-06-28T19:57:26.290334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.927241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:57:26.290402Z","caller":"traceutil/trace.go:171","msg":"trace[1460201898] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4750; }","duration":"256.049732ms","start":"2026-06-28T19:57:26.034336Z","end":"2026-06-28T19:57:26.290386Z","steps":["trace[1460201898] 'agreement among raft nodes before linearized reading' (duration: 253.894883ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:26.446941Z","caller":"traceutil/trace.go:171","msg":"trace[517811224] transaction","detail":"{read_only:false; response_revision:4751; number_of_response:1; }","duration":"149.157724ms","start":"2026-06-28T19:57:26.297759Z","end":"2026-06-28T19:57:26.446917Z","steps":["trace[517811224] 'process raft request' (duration: 148.021763ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:26.744282Z","caller":"traceutil/trace.go:171","msg":"trace[2139260230] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4752; }","duration":"203.627541ms","start":"2026-06-28T19:57:26.540636Z","end":"2026-06-28T19:57:26.744264Z","steps":["trace[2139260230] 'process raft request' (duration: 122.873498ms)","trace[2139260230] 'compare' (duration: 80.441998ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:57:26.744331Z","caller":"traceutil/trace.go:171","msg":"trace[2085268050] linearizableReadLoop","detail":"{readStateIndex:4933; appliedIndex:4932; }","duration":"202.033143ms","start":"2026-06-28T19:57:26.542269Z","end":"2026-06-28T19:57:26.744302Z","steps":["trace[2085268050] 'read index received' (duration: 121.249968ms)","trace[2085268050] 'applied index is now lower than readState.Index' (duration: 80.781055ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:57:26.744619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.333159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-06-28T19:57:26.744708Z","caller":"traceutil/trace.go:171","msg":"trace[1256580960] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4753; }","duration":"202.46027ms","start":"2026-06-28T19:57:26.542213Z","end":"2026-06-28T19:57:26.744673Z","steps":["trace[1256580960] 'agreement among raft nodes before linearized reading' (duration: 202.232966ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:26.745557Z","caller":"traceutil/trace.go:171","msg":"trace[441321036] transaction","detail":"{read_only:false; response_revision:4753; number_of_response:1; }","duration":"191.976111ms","start":"2026-06-28T19:57:26.552326Z","end":"2026-06-28T19:57:26.744302Z","steps":["trace[441321036] 'process raft request' (duration: 191.890688ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:26.964074Z","caller":"traceutil/trace.go:171","msg":"trace[1819181938] transaction","detail":"{read_only:false; response_revision:4755; number_of_response:1; }","duration":"162.921813ms","start":"2026-06-28T19:57:26.80112Z","end":"2026-06-28T19:57:26.964042Z","steps":["trace[1819181938] 'process raft request' (duration: 161.521208ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:26.964727Z","caller":"traceutil/trace.go:171","msg":"trace[714727237] transaction","detail":"{read_only:false; response_revision:4756; number_of_response:1; }","duration":"163.116227ms","start":"2026-06-28T19:57:26.801581Z","end":"2026-06-28T19:57:26.964697Z","steps":["trace[714727237] 'process raft request' (duration: 162.559428ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:27.522928Z","caller":"traceutil/trace.go:171","msg":"trace[1718180785] linearizableReadLoop","detail":"{readStateIndex:4947; appliedIndex:4944; }","duration":"100.409938ms","start":"2026-06-28T19:57:27.422502Z","end":"2026-06-28T19:57:27.522912Z","steps":["trace[1718180785] 'read index received' (duration: 44.633748ms)","trace[1718180785] 'applied index is now lower than readState.Index' (duration: 55.77562ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:57:27.522942Z","caller":"traceutil/trace.go:171","msg":"trace[408450685] transaction","detail":"{read_only:false; response_revision:4764; number_of_response:1; }","duration":"102.232741ms","start":"2026-06-28T19:57:27.420679Z","end":"2026-06-28T19:57:27.522912Z","steps":["trace[408450685] 'process raft request' (duration: 46.447431ms)","trace[408450685] 'compare' (duration: 55.604796ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:57:27.523249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.720573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:9225"} {"level":"info","ts":"2026-06-28T19:57:27.523403Z","caller":"traceutil/trace.go:171","msg":"trace[470889468] transaction","detail":"{read_only:false; response_revision:4765; number_of_response:1; }","duration":"101.762142ms","start":"2026-06-28T19:57:27.421634Z","end":"2026-06-28T19:57:27.523396Z","steps":["trace[470889468] 'process raft request' (duration: 101.190103ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:27.523447Z","caller":"traceutil/trace.go:171","msg":"trace[287341573] transaction","detail":"{read_only:false; response_revision:4766; number_of_response:1; }","duration":"101.806093ms","start":"2026-06-28T19:57:27.421631Z","end":"2026-06-28T19:57:27.523437Z","steps":["trace[287341573] 'process raft request' (duration: 101.256744ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:27.523396Z","caller":"traceutil/trace.go:171","msg":"trace[372836551] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4766; }","duration":"100.897176ms","start":"2026-06-28T19:57:27.42248Z","end":"2026-06-28T19:57:27.523377Z","steps":["trace[372836551] 'agreement among raft nodes before linearized reading' (duration: 100.592161ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:28.470737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.027422ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:57:28.470845Z","caller":"traceutil/trace.go:171","msg":"trace[193335889] transaction","detail":"{read_only:false; response_revision:4774; number_of_response:1; }","duration":"173.62693ms","start":"2026-06-28T19:57:28.297194Z","end":"2026-06-28T19:57:28.470821Z","steps":["trace[193335889] 'process raft request' (duration: 54.466795ms)","trace[193335889] 'compare' (duration: 118.873279ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:57:30.71105Z","caller":"traceutil/trace.go:171","msg":"trace[1003948388] transaction","detail":"{read_only:false; response_revision:4799; number_of_response:1; }","duration":"371.291717ms","start":"2026-06-28T19:57:30.339734Z","end":"2026-06-28T19:57:30.711026Z","steps":["trace[1003948388] 'process raft request' (duration: 369.962983ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:30.712222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:30.339712Z","time spent":"372.422146ms","remote":"127.0.0.1:57904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2585,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-28T19:57:30.712966Z","caller":"traceutil/trace.go:171","msg":"trace[948194661] transaction","detail":"{read_only:false; response_revision:4800; number_of_response:1; }","duration":"237.362181ms","start":"2026-06-28T19:57:30.475586Z","end":"2026-06-28T19:57:30.712948Z","steps":["trace[948194661] 'process raft request' (duration: 237.242069ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:33.609481Z","caller":"traceutil/trace.go:171","msg":"trace[1034600779] linearizableReadLoop","detail":"{readStateIndex:5023; appliedIndex:5022; }","duration":"329.840427ms","start":"2026-06-28T19:57:33.279622Z","end":"2026-06-28T19:57:33.609462Z","steps":["trace[1034600779] 'read index received' (duration: 329.810736ms)","trace[1034600779] 'applied index is now lower than readState.Index' (duration: 28.931µs)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:57:33.609607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.96255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-28T19:57:33.60958Z","caller":"traceutil/trace.go:171","msg":"trace[1223728555] transaction","detail":"{read_only:false; response_revision:4839; number_of_response:1; }","duration":"548.519346ms","start":"2026-06-28T19:57:33.061034Z","end":"2026-06-28T19:57:33.609553Z","steps":["trace[1223728555] 'process raft request' (duration: 548.318302ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:33.609636Z","caller":"traceutil/trace.go:171","msg":"trace[2046555016] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:4839; }","duration":"330.045961ms","start":"2026-06-28T19:57:33.279582Z","end":"2026-06-28T19:57:33.609628Z","steps":["trace[2046555016] 'agreement among raft nodes before linearized reading' (duration: 329.973239ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:33.60973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:33.279565Z","time spent":"330.125182ms","remote":"127.0.0.1:52082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-28T19:57:33.60973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:33.061009Z","time spent":"548.653728ms","remote":"127.0.0.1:58066","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:57:33.614785Z","caller":"traceutil/trace.go:171","msg":"trace[1689016766] transaction","detail":"{read_only:false; response_revision:4841; number_of_response:1; }","duration":"216.337198ms","start":"2026-06-28T19:57:33.398434Z","end":"2026-06-28T19:57:33.614771Z","steps":["trace[1689016766] 'process raft request' (duration: 216.252926ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:33.614814Z","caller":"traceutil/trace.go:171","msg":"trace[860964400] transaction","detail":"{read_only:false; response_revision:4840; number_of_response:1; }","duration":"238.854172ms","start":"2026-06-28T19:57:33.375944Z","end":"2026-06-28T19:57:33.614798Z","steps":["trace[860964400] 'process raft request' (duration: 238.626289ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:33.614812Z","caller":"traceutil/trace.go:171","msg":"trace[106262801] transaction","detail":"{read_only:false; response_revision:4842; number_of_response:1; }","duration":"201.545442ms","start":"2026-06-28T19:57:33.413246Z","end":"2026-06-28T19:57:33.614792Z","steps":["trace[106262801] 'process raft request' (duration: 201.470381ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:40.021676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"986.951923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:57:40.021771Z","caller":"traceutil/trace.go:171","msg":"trace[1154658560] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4887; }","duration":"987.085955ms","start":"2026-06-28T19:57:39.034665Z","end":"2026-06-28T19:57:40.021751Z","steps":["trace[1154658560] 'range keys from in-memory index tree' (duration: 986.869171ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:40.021833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"695.422642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-28T19:57:40.021909Z","caller":"traceutil/trace.go:171","msg":"trace[1601803246] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:4887; }","duration":"695.555084ms","start":"2026-06-28T19:57:39.326337Z","end":"2026-06-28T19:57:40.021892Z","steps":["trace[1601803246] 'count revisions from in-memory index tree' (duration: 695.32294ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:40.021953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:39.326314Z","time spent":"695.628366ms","remote":"127.0.0.1:58292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":4,"response size":29,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"warn","ts":"2026-06-28T19:57:40.022064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:39.034646Z","time spent":"987.156686ms","remote":"127.0.0.1:53964","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-28T19:57:40.022243Z","caller":"traceutil/trace.go:171","msg":"trace[232928572] transaction","detail":"{read_only:false; response_revision:4888; number_of_response:1; }","duration":"390.006826ms","start":"2026-06-28T19:57:39.632223Z","end":"2026-06-28T19:57:40.02223Z","steps":["trace[232928572] 'process raft request' (duration: 331.955351ms)","trace[232928572] 'compare' (duration: 57.831441ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:57:40.022319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.789106ms","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-28T19:57:40.022335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:39.632198Z","time spent":"390.082488ms","remote":"127.0.0.1:58066","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:57:40.022123Z","caller":"traceutil/trace.go:171","msg":"trace[1707183414] linearizableReadLoop","detail":"{readStateIndex:5074; appliedIndex:5073; }","duration":"387.586762ms","start":"2026-06-28T19:57:39.634516Z","end":"2026-06-28T19:57:40.022103Z","steps":["trace[1707183414] 'read index received' (duration: 329.68562ms)","trace[1707183414] 'applied index is now lower than readState.Index' (duration: 57.900452ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:57:40.022374Z","caller":"traceutil/trace.go:171","msg":"trace[2127550767] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4888; }","duration":"387.879678ms","start":"2026-06-28T19:57:39.634485Z","end":"2026-06-28T19:57:40.022365Z","steps":["trace[2127550767] 'agreement among raft nodes before linearized reading' (duration: 387.686065ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:40.022409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:39.634476Z","time spent":"387.924899ms","remote":"127.0.0.1:58066","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-28T19:57:40.022577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"916.474966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-06-28T19:57:40.022799Z","caller":"traceutil/trace.go:171","msg":"trace[622983732] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4887; }","duration":"916.804581ms","start":"2026-06-28T19:57:39.105905Z","end":"2026-06-28T19:57:40.02271Z","steps":["trace[622983732] 'range keys from in-memory index tree' (duration: 915.708302ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:40.022898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:39.105891Z","time spent":"916.984525ms","remote":"127.0.0.1:40432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3338,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"info","ts":"2026-06-28T19:57:40.06411Z","caller":"traceutil/trace.go:171","msg":"trace[576938584] transaction","detail":"{read_only:false; response_revision:4889; number_of_response:1; }","duration":"425.278394ms","start":"2026-06-28T19:57:39.638802Z","end":"2026-06-28T19:57:40.064081Z","steps":["trace[576938584] 'process raft request' (duration: 425.00309ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:40.064204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.075874ms","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-28T19:57:40.064249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:39.638791Z","time spent":"425.393327ms","remote":"127.0.0.1:58066","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:57:40.064269Z","caller":"traceutil/trace.go:171","msg":"trace[1488362035] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4890; }","duration":"414.193327ms","start":"2026-06-28T19:57:39.650059Z","end":"2026-06-28T19:57:40.064252Z","steps":["trace[1488362035] 'agreement among raft nodes before linearized reading' (duration: 413.966442ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:40.064314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:39.650041Z","time spent":"414.260958ms","remote":"127.0.0.1:58066","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-28T19:57:40.064391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.314569ms","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-28T19:57:40.06448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.895552ms","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-28T19:57:40.064484Z","caller":"traceutil/trace.go:171","msg":"trace[426622033] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4890; }","duration":"414.454651ms","start":"2026-06-28T19:57:39.650012Z","end":"2026-06-28T19:57:40.064466Z","steps":["trace[426622033] 'agreement among raft nodes before linearized reading' (duration: 414.130625ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:40.064528Z","caller":"traceutil/trace.go:171","msg":"trace[1565790675] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4890; }","duration":"417.968464ms","start":"2026-06-28T19:57:39.646544Z","end":"2026-06-28T19:57:40.064512Z","steps":["trace[1565790675] 'agreement among raft nodes before linearized reading' (duration: 417.865072ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:40.064542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:39.649998Z","time spent":"414.530492ms","remote":"127.0.0.1:58066","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-28T19:57:40.064568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:39.646531Z","time spent":"418.028265ms","remote":"127.0.0.1:58066","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":"info","ts":"2026-06-28T19:57:40.064586Z","caller":"traceutil/trace.go:171","msg":"trace[367479750] transaction","detail":"{read_only:false; response_revision:4890; number_of_response:1; }","duration":"425.679951ms","start":"2026-06-28T19:57:39.638886Z","end":"2026-06-28T19:57:40.064566Z","steps":["trace[367479750] 'process raft request' (duration: 425.0694ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:40.064681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:39.638866Z","time spent":"425.769143ms","remote":"127.0.0.1:58066","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-28T19:57:40.064839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.520677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-28T19:57:40.064894Z","caller":"traceutil/trace.go:171","msg":"trace[1790278194] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4890; }","duration":"412.604839ms","start":"2026-06-28T19:57:39.652274Z","end":"2026-06-28T19:57:40.064879Z","steps":["trace[1790278194] 'agreement among raft nodes before linearized reading' (duration: 411.767163ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:40.064946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:39.652268Z","time spent":"412.66456ms","remote":"127.0.0.1:58066","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-28T19:57:40.181623Z","caller":"traceutil/trace.go:171","msg":"trace[342462045] transaction","detail":"{read_only:false; response_revision:4894; number_of_response:1; }","duration":"112.563256ms","start":"2026-06-28T19:57:40.06904Z","end":"2026-06-28T19:57:40.181603Z","steps":["trace[342462045] 'process raft request' (duration: 112.511695ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:40.181668Z","caller":"traceutil/trace.go:171","msg":"trace[1157884265] transaction","detail":"{read_only:false; response_revision:4893; number_of_response:1; }","duration":"112.973092ms","start":"2026-06-28T19:57:40.068651Z","end":"2026-06-28T19:57:40.181625Z","steps":["trace[1157884265] 'process raft request' (duration: 112.771749ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:40.181951Z","caller":"traceutil/trace.go:171","msg":"trace[1931561206] transaction","detail":"{read_only:false; response_revision:4895; number_of_response:1; }","duration":"112.348952ms","start":"2026-06-28T19:57:40.069592Z","end":"2026-06-28T19:57:40.181941Z","steps":["trace[1931561206] 'process raft request' (duration: 111.985135ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:40.182245Z","caller":"traceutil/trace.go:171","msg":"trace[1834145708] transaction","detail":"{read_only:false; response_revision:4896; number_of_response:1; }","duration":"111.854293ms","start":"2026-06-28T19:57:40.070383Z","end":"2026-06-28T19:57:40.182237Z","steps":["trace[1834145708] 'process raft request' (duration: 111.390164ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:44.185737Z","caller":"traceutil/trace.go:171","msg":"trace[692476107] transaction","detail":"{read_only:false; response_revision:4930; number_of_response:1; }","duration":"107.294133ms","start":"2026-06-28T19:57:44.078404Z","end":"2026-06-28T19:57:44.185698Z","steps":["trace[692476107] 'process raft request' (duration: 107.197262ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:44.346781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.139033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-28T19:57:44.346864Z","caller":"traceutil/trace.go:171","msg":"trace[256099883] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4932; }","duration":"150.250994ms","start":"2026-06-28T19:57:44.196597Z","end":"2026-06-28T19:57:44.346848Z","steps":["trace[256099883] 'agreement among raft nodes before linearized reading' (duration: 150.051301ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:44.346869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.3463ms","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-28T19:57:44.346955Z","caller":"traceutil/trace.go:171","msg":"trace[1829016757] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4932; }","duration":"148.456172ms","start":"2026-06-28T19:57:44.19848Z","end":"2026-06-28T19:57:44.346936Z","steps":["trace[1829016757] 'agreement among raft nodes before linearized reading' (duration: 148.153547ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:44.34711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.878145ms","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-28T19:57:44.347154Z","caller":"traceutil/trace.go:171","msg":"trace[537393818] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4932; }","duration":"150.939355ms","start":"2026-06-28T19:57:44.196205Z","end":"2026-06-28T19:57:44.347144Z","steps":["trace[537393818] 'agreement among raft nodes before linearized reading' (duration: 150.827853ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:44.347267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.025207ms","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-28T19:57:44.34735Z","caller":"traceutil/trace.go:171","msg":"trace[1369178802] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4932; }","duration":"151.123309ms","start":"2026-06-28T19:57:44.196216Z","end":"2026-06-28T19:57:44.347339Z","steps":["trace[1369178802] 'agreement among raft nodes before linearized reading' (duration: 150.950846ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:44.34751Z","caller":"traceutil/trace.go:171","msg":"trace[1865375670] transaction","detail":"{read_only:false; response_revision:4932; number_of_response:1; }","duration":"145.315666ms","start":"2026-06-28T19:57:44.201789Z","end":"2026-06-28T19:57:44.347105Z","steps":["trace[1865375670] 'process raft request' (duration: 143.983242ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:50.229666Z","caller":"traceutil/trace.go:171","msg":"trace[645622912] transaction","detail":"{read_only:false; response_revision:4965; number_of_response:1; }","duration":"173.24881ms","start":"2026-06-28T19:57:50.056393Z","end":"2026-06-28T19:57:50.229642Z","steps":["trace[645622912] 'process raft request' (duration: 173.082968ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:52.35471Z","caller":"traceutil/trace.go:171","msg":"trace[396061925] transaction","detail":"{read_only:false; response_revision:4978; number_of_response:1; }","duration":"103.112661ms","start":"2026-06-28T19:57:52.251568Z","end":"2026-06-28T19:57:52.35468Z","steps":["trace[396061925] 'process raft request' (duration: 71.982075ms)","trace[396061925] 'compare' (duration: 30.850952ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:57:52.354771Z","caller":"traceutil/trace.go:171","msg":"trace[771065578] transaction","detail":"{read_only:false; response_revision:4979; number_of_response:1; }","duration":"102.917218ms","start":"2026-06-28T19:57:52.251819Z","end":"2026-06-28T19:57:52.354736Z","steps":["trace[771065578] 'process raft request' (duration: 102.773256ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:08.460069Z","caller":"traceutil/trace.go:171","msg":"trace[547494907] transaction","detail":"{read_only:false; response_revision:5077; number_of_response:1; }","duration":"118.124241ms","start":"2026-06-28T19:58:08.341915Z","end":"2026-06-28T19:58:08.460039Z","steps":["trace[547494907] 'process raft request' (duration: 117.935938ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:08.643984Z","caller":"traceutil/trace.go:171","msg":"trace[501001927] transaction","detail":"{read_only:false; response_revision:5080; number_of_response:1; }","duration":"179.38182ms","start":"2026-06-28T19:58:08.464538Z","end":"2026-06-28T19:58:08.643919Z","steps":["trace[501001927] 'process raft request' (duration: 93.20904ms)","trace[501001927] 'compare' (duration: 85.473848ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:58:20.621926Z","caller":"traceutil/trace.go:171","msg":"trace[1104143431] transaction","detail":"{read_only:false; response_revision:5238; number_of_response:1; }","duration":"116.771765ms","start":"2026-06-28T19:58:20.50512Z","end":"2026-06-28T19:58:20.621892Z","steps":["trace[1104143431] 'process raft request' (duration: 70.689758ms)","trace[1104143431] 'compare' (duration: 45.71188ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:58:20.622133Z","caller":"traceutil/trace.go:171","msg":"trace[1579543061] transaction","detail":"{read_only:false; response_revision:5239; number_of_response:1; }","duration":"116.818795ms","start":"2026-06-28T19:58:20.505283Z","end":"2026-06-28T19:58:20.622102Z","steps":["trace[1579543061] 'process raft request' (duration: 116.50162ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:20.622583Z","caller":"traceutil/trace.go:171","msg":"trace[196322007] transaction","detail":"{read_only:false; response_revision:5240; number_of_response:1; }","duration":"115.551423ms","start":"2026-06-28T19:58:20.506803Z","end":"2026-06-28T19:58:20.622355Z","steps":["trace[196322007] 'process raft request' (duration: 115.117806ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:27.921181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.789643ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:58:27.921723Z","caller":"traceutil/trace.go:171","msg":"trace[517380203] transaction","detail":"{read_only:false; response_revision:5291; number_of_response:1; }","duration":"265.995655ms","start":"2026-06-28T19:58:27.655691Z","end":"2026-06-28T19:58:27.921686Z","steps":["trace[517380203] 'process raft request' (duration: 39.620202ms)","trace[517380203] 'compare' (duration: 225.330935ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:58:27.921809Z","caller":"traceutil/trace.go:171","msg":"trace[1660413992] transaction","detail":"{read_only:false; response_revision:5293; number_of_response:1; }","duration":"263.27866ms","start":"2026-06-28T19:58:27.658514Z","end":"2026-06-28T19:58:27.921793Z","steps":["trace[1660413992] 'process raft request' (duration: 263.128997ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:27.921905Z","caller":"traceutil/trace.go:171","msg":"trace[1917766664] linearizableReadLoop","detail":"{readStateIndex:5490; appliedIndex:5487; }","duration":"210.141047ms","start":"2026-06-28T19:58:27.711652Z","end":"2026-06-28T19:58:27.921793Z","steps":["trace[1917766664] 'read index received' (duration: 205.61141ms)","trace[1917766664] 'applied index is now lower than readState.Index' (duration: 4.522817ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:58:27.922101Z","caller":"traceutil/trace.go:171","msg":"trace[801264843] transaction","detail":"{read_only:false; response_revision:5292; number_of_response:1; }","duration":"264.114513ms","start":"2026-06-28T19:58:27.657977Z","end":"2026-06-28T19:58:27.922092Z","steps":["trace[801264843] 'process raft request' (duration: 263.605815ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:27.922172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.477942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:58:27.922225Z","caller":"traceutil/trace.go:171","msg":"trace[1033005261] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5294; }","duration":"210.596245ms","start":"2026-06-28T19:58:27.711613Z","end":"2026-06-28T19:58:27.92221Z","steps":["trace[1033005261] 'agreement among raft nodes before linearized reading' (duration: 210.449842ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:27.922249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.39006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-06-28T19:58:27.922278Z","caller":"traceutil/trace.go:171","msg":"trace[1468798631] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5294; }","duration":"108.456861ms","start":"2026-06-28T19:58:27.813812Z","end":"2026-06-28T19:58:27.922269Z","steps":["trace[1468798631] 'agreement among raft nodes before linearized reading' (duration: 108.351038ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:27.922277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.14706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-credential-setup\" ","response":"range_response_count:1 size:6254"} {"level":"info","ts":"2026-06-28T19:58:27.922313Z","caller":"traceutil/trace.go:171","msg":"trace[1425566486] range","detail":"{range_begin:/registry/jobs/openstack/keystone-credential-setup; range_end:; response_count:1; response_revision:5294; }","duration":"209.196622ms","start":"2026-06-28T19:58:27.713104Z","end":"2026-06-28T19:58:27.9223Z","steps":["trace[1425566486] 'agreement among raft nodes before linearized reading' (duration: 209.102049ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:27.922174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.456755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:58:27.92241Z","caller":"traceutil/trace.go:171","msg":"trace[174560002] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5294; }","duration":"209.71053ms","start":"2026-06-28T19:58:27.712692Z","end":"2026-06-28T19:58:27.922402Z","steps":["trace[174560002] 'agreement among raft nodes before linearized reading' (duration: 209.432025ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:27.921749Z","caller":"traceutil/trace.go:171","msg":"trace[946162386] transaction","detail":"{read_only:false; response_revision:5294; number_of_response:1; }","duration":"132.841406ms","start":"2026-06-28T19:58:27.788891Z","end":"2026-06-28T19:58:27.921733Z","steps":["trace[946162386] 'process raft request' (duration: 132.802595ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:34.795743Z","caller":"traceutil/trace.go:171","msg":"trace[2097070776] transaction","detail":"{read_only:false; response_revision:5338; number_of_response:1; }","duration":"121.702194ms","start":"2026-06-28T19:58:34.674019Z","end":"2026-06-28T19:58:34.795721Z","steps":["trace[2097070776] 'process raft request' (duration: 121.55727ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:34.795645Z","caller":"traceutil/trace.go:171","msg":"trace[1040158479] transaction","detail":"{read_only:false; response_revision:5337; number_of_response:1; }","duration":"124.673264ms","start":"2026-06-28T19:58:34.670935Z","end":"2026-06-28T19:58:34.795608Z","steps":["trace[1040158479] 'process raft request' (duration: 124.516431ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:35.169607Z","caller":"traceutil/trace.go:171","msg":"trace[1823246858] transaction","detail":"{read_only:false; response_revision:5339; number_of_response:1; }","duration":"234.748149ms","start":"2026-06-28T19:58:34.93483Z","end":"2026-06-28T19:58:35.169578Z","steps":["trace[1823246858] 'process raft request' (duration: 234.545835ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:35.171898Z","caller":"traceutil/trace.go:171","msg":"trace[155769445] linearizableReadLoop","detail":"{readStateIndex:5541; appliedIndex:5537; }","duration":"235.625864ms","start":"2026-06-28T19:58:34.936241Z","end":"2026-06-28T19:58:35.171867Z","steps":["trace[155769445] 'read index received' (duration: 233.192503ms)","trace[155769445] 'applied index is now lower than readState.Index' (duration: 2.431931ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:58:35.172149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.892068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-28T19:58:35.172185Z","caller":"traceutil/trace.go:171","msg":"trace[1109442747] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5342; }","duration":"235.99247ms","start":"2026-06-28T19:58:34.936181Z","end":"2026-06-28T19:58:35.172173Z","steps":["trace[1109442747] 'agreement among raft nodes before linearized reading' (duration: 235.799327ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:35.172549Z","caller":"traceutil/trace.go:171","msg":"trace[1353033445] transaction","detail":"{read_only:false; response_revision:5340; number_of_response:1; }","duration":"237.506145ms","start":"2026-06-28T19:58:34.935029Z","end":"2026-06-28T19:58:35.172535Z","steps":["trace[1353033445] 'process raft request' (duration: 236.490837ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:35.172682Z","caller":"traceutil/trace.go:171","msg":"trace[1528120718] transaction","detail":"{read_only:false; response_revision:5341; number_of_response:1; }","duration":"236.59438ms","start":"2026-06-28T19:58:34.936078Z","end":"2026-06-28T19:58:35.172672Z","steps":["trace[1528120718] 'process raft request' (duration: 235.614894ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:35.17283Z","caller":"traceutil/trace.go:171","msg":"trace[112428841] transaction","detail":"{read_only:false; response_revision:5342; number_of_response:1; }","duration":"236.664351ms","start":"2026-06-28T19:58:34.936152Z","end":"2026-06-28T19:58:35.172816Z","steps":["trace[112428841] 'process raft request' (duration: 235.633954ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:36.924245Z","caller":"traceutil/trace.go:171","msg":"trace[449642490] transaction","detail":"{read_only:false; response_revision:5350; number_of_response:1; }","duration":"123.209676ms","start":"2026-06-28T19:58:36.800995Z","end":"2026-06-28T19:58:36.924205Z","steps":["trace[449642490] 'process raft request' (duration: 47.732384ms)","trace[449642490] 'compare' (duration: 75.251438ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:58:36.945822Z","caller":"traceutil/trace.go:171","msg":"trace[2111416066] transaction","detail":"{read_only:false; response_revision:5351; number_of_response:1; }","duration":"144.496715ms","start":"2026-06-28T19:58:36.801304Z","end":"2026-06-28T19:58:36.945801Z","steps":["trace[2111416066] 'process raft request' (duration: 144.102068ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:42.469097Z","caller":"traceutil/trace.go:171","msg":"trace[1732884301] transaction","detail":"{read_only:false; response_revision:5402; number_of_response:1; }","duration":"112.105959ms","start":"2026-06-28T19:58:42.356965Z","end":"2026-06-28T19:58:42.469071Z","steps":["trace[1732884301] 'process raft request' (duration: 28.934585ms)","trace[1732884301] 'compare' (duration: 82.837519ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:58:43.116306Z","caller":"traceutil/trace.go:171","msg":"trace[338504176] transaction","detail":"{read_only:false; response_revision:5408; number_of_response:1; }","duration":"176.350346ms","start":"2026-06-28T19:58:42.939933Z","end":"2026-06-28T19:58:43.116283Z","steps":["trace[338504176] 'process raft request' (duration: 176.215483ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:43.120558Z","caller":"traceutil/trace.go:171","msg":"trace[1348104410] linearizableReadLoop","detail":"{readStateIndex:5609; appliedIndex:5607; }","duration":"156.555473ms","start":"2026-06-28T19:58:42.963982Z","end":"2026-06-28T19:58:43.120538Z","steps":["trace[1348104410] 'read index received' (duration: 152.183569ms)","trace[1348104410] 'applied index is now lower than readState.Index' (duration: 4.371104ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:58:43.120632Z","caller":"traceutil/trace.go:171","msg":"trace[1665646408] transaction","detail":"{read_only:false; response_revision:5409; number_of_response:1; }","duration":"156.95679ms","start":"2026-06-28T19:58:42.963667Z","end":"2026-06-28T19:58:43.120623Z","steps":["trace[1665646408] 'process raft request' (duration: 156.778097ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:43.120934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.93479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-28T19:58:43.121016Z","caller":"traceutil/trace.go:171","msg":"trace[55088870] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:5409; }","duration":"157.028401ms","start":"2026-06-28T19:58:42.963967Z","end":"2026-06-28T19:58:43.120995Z","steps":["trace[55088870] 'agreement among raft nodes before linearized reading' (duration: 156.91066ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:43.705785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.717042ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-28T19:58:43.706052Z","caller":"traceutil/trace.go:171","msg":"trace[1620989798] transaction","detail":"{read_only:false; response_revision:5416; number_of_response:1; }","duration":"186.994223ms","start":"2026-06-28T19:58:43.519039Z","end":"2026-06-28T19:58:43.706034Z","steps":["trace[1620989798] 'process raft request' (duration: 186.856231ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:43.706098Z","caller":"traceutil/trace.go:171","msg":"trace[715787658] linearizableReadLoop","detail":"{readStateIndex:5616; appliedIndex:5615; }","duration":"188.399896ms","start":"2026-06-28T19:58:43.517672Z","end":"2026-06-28T19:58:43.706071Z","steps":["trace[715787658] 'read index received' (duration: 51.39506ms)","trace[715787658] 'applied index is now lower than readState.Index' (duration: 137.002066ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:58:43.706429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.739882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keystone-fernet-setup-bgwvc\" ","response":"range_response_count:1 size:7715"} {"level":"info","ts":"2026-06-28T19:58:43.706469Z","caller":"traceutil/trace.go:171","msg":"trace[702045608] range","detail":"{range_begin:/registry/pods/openstack/keystone-fernet-setup-bgwvc; range_end:; response_count:1; response_revision:5416; }","duration":"188.820434ms","start":"2026-06-28T19:58:43.517637Z","end":"2026-06-28T19:58:43.706457Z","steps":["trace[702045608] 'agreement among raft nodes before linearized reading' (duration: 188.63672ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:43.8789Z","caller":"traceutil/trace.go:171","msg":"trace[1784258076] transaction","detail":"{read_only:false; response_revision:5417; number_of_response:1; }","duration":"162.722556ms","start":"2026-06-28T19:58:43.716138Z","end":"2026-06-28T19:58:43.878861Z","steps":["trace[1784258076] 'process raft request' (duration: 118.971693ms)","trace[1784258076] 'compare' (duration: 43.54ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:58:47.758745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.344063ms","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-28T19:58:47.758829Z","caller":"traceutil/trace.go:171","msg":"trace[37155329] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:5438; }","duration":"110.490565ms","start":"2026-06-28T19:58:47.648319Z","end":"2026-06-28T19:58:47.75881Z","steps":["trace[37155329] 'range keys from in-memory index tree' (duration: 109.303125ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:49.537709Z","caller":"traceutil/trace.go:171","msg":"trace[603174523] linearizableReadLoop","detail":"{readStateIndex:5651; appliedIndex:5650; }","duration":"140.347442ms","start":"2026-06-28T19:58:49.397328Z","end":"2026-06-28T19:58:49.537675Z","steps":["trace[603174523] 'read index received' (duration: 32.088966ms)","trace[603174523] 'applied index is now lower than readState.Index' (duration: 108.256846ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:58:49.537749Z","caller":"traceutil/trace.go:171","msg":"trace[1827327846] transaction","detail":"{read_only:false; response_revision:5449; number_of_response:1; }","duration":"186.365938ms","start":"2026-06-28T19:58:49.351351Z","end":"2026-06-28T19:58:49.537717Z","steps":["trace[1827327846] 'process raft request' (duration: 117.744884ms)","trace[1827327846] 'compare' (duration: 68.085975ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:58:49.538003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.647996ms","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-28T19:58:49.538052Z","caller":"traceutil/trace.go:171","msg":"trace[63878586] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5449; }","duration":"140.744297ms","start":"2026-06-28T19:58:49.397293Z","end":"2026-06-28T19:58:49.538037Z","steps":["trace[63878586] 'agreement among raft nodes before linearized reading' (duration: 140.542044ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:54.643132Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2841} {"level":"info","ts":"2026-06-28T19:58:54.750122Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2841,"took":"105.802028ms","hash":4202199577,"current-db-size-bytes":53530624,"current-db-size":"54 MB","current-db-size-in-use-bytes":28991488,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-28T19:58:54.750197Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4202199577,"revision":2841,"compact-revision":-1} {"level":"info","ts":"2026-06-28T20:00:40.332484Z","caller":"traceutil/trace.go:171","msg":"trace[558044189] transaction","detail":"{read_only:false; response_revision:6118; number_of_response:1; }","duration":"110.499191ms","start":"2026-06-28T20:00:40.22196Z","end":"2026-06-28T20:00:40.332459Z","steps":["trace[558044189] 'process raft request' (duration: 42.772914ms)","trace[558044189] 'compare' (duration: 67.580485ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T20:00:40.333519Z","caller":"traceutil/trace.go:171","msg":"trace[2057020002] transaction","detail":"{read_only:false; response_revision:6120; number_of_response:1; }","duration":"111.222722ms","start":"2026-06-28T20:00:40.222265Z","end":"2026-06-28T20:00:40.333488Z","steps":["trace[2057020002] 'process raft request' (duration: 111.160512ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T20:00:40.333703Z","caller":"traceutil/trace.go:171","msg":"trace[2137497885] transaction","detail":"{read_only:false; response_revision:6119; number_of_response:1; }","duration":"111.647599ms","start":"2026-06-28T20:00:40.221999Z","end":"2026-06-28T20:00:40.333647Z","steps":["trace[2137497885] 'process raft request' (duration: 111.305254ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T20:03:54.648625Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5500} {"level":"info","ts":"2026-06-28T20:03:54.743736Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5500,"took":"93.702614ms","hash":3741805925,"current-db-size-bytes":53530624,"current-db-size":"54 MB","current-db-size-in-use-bytes":18296832,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-28T20:03:54.743801Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3741805925,"revision":5500,"compact-revision":2841}