{"level":"warn","ts":"2026-08-04T15:11:33.619874Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-04T15:11:33.61997Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.54:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.54:2380","--initial-cluster=instance=https://199.19.213.54:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.54:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.54: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-08-04T15:11:33.62005Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-04T15:11:33.620062Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.54:2380"]} {"level":"info","ts":"2026-08-04T15:11:33.620088Z","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-08-04T15:11:33.620925Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.54:2379"]} {"level":"info","ts":"2026-08-04T15:11:33.621038Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.54:2380"],"listen-peer-urls":["https://199.19.213.54:2380"],"advertise-client-urls":["https://199.19.213.54:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.54:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.54: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-08-04T15:11:33.624893Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.594972ms"} {"level":"info","ts":"2026-08-04T15:11:33.630514Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"193b4dda7792855b","cluster-id":"dd6702a2f79ce697"} {"level":"info","ts":"2026-08-04T15:11:33.630619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b switched to configuration voters=()"} {"level":"info","ts":"2026-08-04T15:11:33.63066Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b became follower at term 0"} {"level":"info","ts":"2026-08-04T15:11:33.630694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 193b4dda7792855b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-04T15:11:33.630714Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b became follower at term 1"} {"level":"info","ts":"2026-08-04T15:11:33.630777Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b switched to configuration voters=(1818132475278427483)"} {"level":"warn","ts":"2026-08-04T15:11:33.637235Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-04T15:11:33.638673Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-04T15:11:33.640064Z","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-08-04T15:11:33.644976Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"193b4dda7792855b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-04T15:11:33.647585Z","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-08-04T15:11:33.647679Z","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-08-04T15:11:33.647704Z","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-08-04T15:11:33.647983Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"193b4dda7792855b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-04T15:11:33.648509Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b switched to configuration voters=(1818132475278427483)"} {"level":"info","ts":"2026-08-04T15:11:33.648631Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dd6702a2f79ce697","local-member-id":"193b4dda7792855b","added-peer-id":"193b4dda7792855b","added-peer-peer-urls":["https://199.19.213.54:2380"]} {"level":"info","ts":"2026-08-04T15:11:33.652366Z","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-08-04T15:11:33.652421Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.54:2380"} {"level":"info","ts":"2026-08-04T15:11:33.652437Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.54:2380"} {"level":"info","ts":"2026-08-04T15:11:33.652641Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"193b4dda7792855b","initial-advertise-peer-urls":["https://199.19.213.54:2380"],"listen-peer-urls":["https://199.19.213.54:2380"],"advertise-client-urls":["https://199.19.213.54:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.54:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-04T15:11:33.652677Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-04T15:11:34.131733Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b is starting a new election at term 1"} {"level":"info","ts":"2026-08-04T15:11:34.131808Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b became pre-candidate at term 1"} {"level":"info","ts":"2026-08-04T15:11:34.131834Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b received MsgPreVoteResp from 193b4dda7792855b at term 1"} {"level":"info","ts":"2026-08-04T15:11:34.131854Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b became candidate at term 2"} {"level":"info","ts":"2026-08-04T15:11:34.131862Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b received MsgVoteResp from 193b4dda7792855b at term 2"} {"level":"info","ts":"2026-08-04T15:11:34.131873Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b became leader at term 2"} {"level":"info","ts":"2026-08-04T15:11:34.131882Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 193b4dda7792855b elected leader 193b4dda7792855b at term 2"} {"level":"info","ts":"2026-08-04T15:11:34.133344Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T15:11:34.134423Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-04T15:11:34.134435Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"193b4dda7792855b","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.54:2379]}","request-path":"/0/members/193b4dda7792855b/attributes","cluster-id":"dd6702a2f79ce697","publish-timeout":"7s"} {"level":"info","ts":"2026-08-04T15:11:34.134748Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-04T15:11:34.134975Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-04T15:11:34.135064Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-04T15:11:34.137656Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.54:2379"} {"level":"info","ts":"2026-08-04T15:11:34.137908Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dd6702a2f79ce697","local-member-id":"193b4dda7792855b","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T15:11:34.138146Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T15:11:34.138311Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T15:11:34.13989Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-08-04T15:11:47.142009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.096498ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:11:47.142862Z","caller":"traceutil/trace.go:171","msg":"trace[1191305045] linearizableReadLoop","detail":"{readStateIndex:374; appliedIndex:373; }","duration":"160.678542ms","start":"2026-08-04T15:11:46.982165Z","end":"2026-08-04T15:11:47.142843Z","steps":["trace[1191305045] 'read index received' (duration: 38.009108ms)","trace[1191305045] 'applied index is now lower than readState.Index' (duration: 122.668104ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:11:47.142912Z","caller":"traceutil/trace.go:171","msg":"trace[256594037] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"286.656356ms","start":"2026-08-04T15:11:46.856218Z","end":"2026-08-04T15:11:47.142874Z","steps":["trace[256594037] 'process raft request' (duration: 164.040114ms)","trace[256594037] 'compare' (duration: 120.968033ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:11:47.143024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.844107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.54\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-08-04T15:11:47.143082Z","caller":"traceutil/trace.go:171","msg":"trace[1783551814] range","detail":"{range_begin:/registry/masterleases/199.19.213.54; range_end:; response_count:1; response_revision:362; }","duration":"160.95364ms","start":"2026-08-04T15:11:46.982112Z","end":"2026-08-04T15:11:47.143066Z","steps":["trace[1783551814] 'agreement among raft nodes before linearized reading' (duration: 160.845717ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:11:52.492373Z","caller":"traceutil/trace.go:171","msg":"trace[1087979262] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"110.120408ms","start":"2026-08-04T15:11:52.382233Z","end":"2026-08-04T15:11:52.492354Z","steps":["trace[1087979262] 'process raft request' (duration: 109.987015ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:11:53.086596Z","caller":"traceutil/trace.go:171","msg":"trace[1006028958] linearizableReadLoop","detail":"{readStateIndex:394; appliedIndex:393; }","duration":"187.317027ms","start":"2026-08-04T15:11:52.899255Z","end":"2026-08-04T15:11:53.086572Z","steps":["trace[1006028958] 'read index received' (duration: 187.243074ms)","trace[1006028958] 'applied index is now lower than readState.Index' (duration: 72.893µs)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:11:53.086816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.546433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:11:53.086856Z","caller":"traceutil/trace.go:171","msg":"trace[852881743] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:380; }","duration":"187.636055ms","start":"2026-08-04T15:11:52.899208Z","end":"2026-08-04T15:11:53.086844Z","steps":["trace[852881743] 'agreement among raft nodes before linearized reading' (duration: 187.484421ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:11:53.08672Z","caller":"traceutil/trace.go:171","msg":"trace[967256951] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"190.714914ms","start":"2026-08-04T15:11:52.895974Z","end":"2026-08-04T15:11:53.086689Z","steps":["trace[967256951] 'process raft request' (duration: 190.439556ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:11:53.761451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.119588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-08-04T15:11:53.761517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.810792ms","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-08-04T15:11:53.761571Z","caller":"traceutil/trace.go:171","msg":"trace[639650132] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:380; }","duration":"259.330944ms","start":"2026-08-04T15:11:53.502214Z","end":"2026-08-04T15:11:53.761545Z","steps":["trace[639650132] 'range keys from in-memory index tree' (duration: 259.007485ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:11:53.76163Z","caller":"traceutil/trace.go:171","msg":"trace[58459229] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:380; }","duration":"586.955295ms","start":"2026-08-04T15:11:53.174644Z","end":"2026-08-04T15:11:53.7616Z","steps":["trace[58459229] 'range keys from in-memory index tree' (duration: 586.542074ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:11:53.761706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:11:53.174627Z","time spent":"587.060469ms","remote":"127.0.0.1:59474","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-08-04T15:12:09.467967Z","caller":"traceutil/trace.go:171","msg":"trace[497824673] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"117.31876ms","start":"2026-08-04T15:12:09.35062Z","end":"2026-08-04T15:12:09.467939Z","steps":["trace[497824673] 'process raft request' (duration: 117.119125ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:09.474767Z","caller":"traceutil/trace.go:171","msg":"trace[57899488] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"123.315271ms","start":"2026-08-04T15:12:09.351371Z","end":"2026-08-04T15:12:09.474686Z","steps":["trace[57899488] 'process raft request' (duration: 122.670194ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:09.474886Z","caller":"traceutil/trace.go:171","msg":"trace[363807432] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"123.219049ms","start":"2026-08-04T15:12:09.35166Z","end":"2026-08-04T15:12:09.474879Z","steps":["trace[363807432] 'process raft request' (duration: 122.48154ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:09.474978Z","caller":"traceutil/trace.go:171","msg":"trace[62676842] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"116.631603ms","start":"2026-08-04T15:12:09.358341Z","end":"2026-08-04T15:12:09.474973Z","steps":["trace[62676842] 'process raft request' (duration: 115.836743ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:09.475194Z","caller":"traceutil/trace.go:171","msg":"trace[214973658] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"106.889048ms","start":"2026-08-04T15:12:09.368277Z","end":"2026-08-04T15:12:09.475166Z","steps":["trace[214973658] 'process raft request' (duration: 105.930864ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:09.475292Z","caller":"traceutil/trace.go:171","msg":"trace[514798175] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"106.631041ms","start":"2026-08-04T15:12:09.368652Z","end":"2026-08-04T15:12:09.475283Z","steps":["trace[514798175] 'process raft request' (duration: 105.587064ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:09.475349Z","caller":"traceutil/trace.go:171","msg":"trace[1899876586] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"106.58994ms","start":"2026-08-04T15:12:09.368752Z","end":"2026-08-04T15:12:09.475342Z","steps":["trace[1899876586] 'process raft request' (duration: 105.547754ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:09.47541Z","caller":"traceutil/trace.go:171","msg":"trace[1748212714] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"100.758334ms","start":"2026-08-04T15:12:09.374647Z","end":"2026-08-04T15:12:09.475405Z","steps":["trace[1748212714] 'process raft request' (duration: 99.698997ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:15.897802Z","caller":"traceutil/trace.go:171","msg":"trace[295382962] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"634.476494ms","start":"2026-08-04T15:12:15.263276Z","end":"2026-08-04T15:12:15.897752Z","steps":["trace[295382962] 'process raft request' (duration: 634.034193ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:15.898025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:15.263243Z","time spent":"634.672008ms","remote":"127.0.0.1:59318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:12:16.034555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.537817ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:12:16.034937Z","caller":"traceutil/trace.go:171","msg":"trace[1588422657] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"133.067557ms","start":"2026-08-04T15:12:15.90179Z","end":"2026-08-04T15:12:16.034857Z","steps":["trace[1588422657] 'process raft request' (duration: 14.11014ms)","trace[1588422657] 'compare' (duration: 118.314962ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:12:16.035459Z","caller":"traceutil/trace.go:171","msg":"trace[1432496987] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"132.312879ms","start":"2026-08-04T15:12:15.902738Z","end":"2026-08-04T15:12:16.035051Z","steps":["trace[1432496987] 'process raft request' (duration: 132.222516ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:16.087488Z","caller":"traceutil/trace.go:171","msg":"trace[15116445] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"136.02444ms","start":"2026-08-04T15:12:15.951432Z","end":"2026-08-04T15:12:16.087456Z","steps":["trace[15116445] 'process raft request' (duration: 135.828225ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:17.114721Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9609449934159545158,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-04T15:12:17.615445Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9609449934159545158,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-04T15:12:17.716115Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.347067265s","expected-duration":"1s"} {"level":"info","ts":"2026-08-04T15:12:17.785643Z","caller":"traceutil/trace.go:171","msg":"trace[1001761861] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"1.416679792s","start":"2026-08-04T15:12:16.368935Z","end":"2026-08-04T15:12:17.785614Z","steps":["trace[1001761861] 'process raft request' (duration: 1.347481374s)","trace[1001761861] 'compare' (duration: 68.608114ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:12:17.785828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:16.368903Z","time spent":"1.416804855s","remote":"127.0.0.1:59474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:12:17.789124Z","caller":"traceutil/trace.go:171","msg":"trace[879241974] linearizableReadLoop","detail":"{readStateIndex:619; appliedIndex:617; }","duration":"1.175030578s","start":"2026-08-04T15:12:16.614046Z","end":"2026-08-04T15:12:17.789077Z","steps":["trace[879241974] 'read index received' (duration: 1.102385848s)","trace[879241974] 'applied index is now lower than readState.Index' (duration: 72.64326ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:12:17.789274Z","caller":"traceutil/trace.go:171","msg":"trace[1915737080] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"1.272643239s","start":"2026-08-04T15:12:16.516561Z","end":"2026-08-04T15:12:17.789204Z","steps":["trace[1915737080] 'process raft request' (duration: 1.271691476s)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:17.789349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.175288984s","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-08-04T15:12:17.789414Z","caller":"traceutil/trace.go:171","msg":"trace[1285160697] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:594; }","duration":"1.175404937s","start":"2026-08-04T15:12:16.613992Z","end":"2026-08-04T15:12:17.789397Z","steps":["trace[1285160697] 'agreement among raft nodes before linearized reading' (duration: 1.175221353s)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:17.789445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:16.613971Z","time spent":"1.175466228s","remote":"127.0.0.1:59474","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-08-04T15:12:17.789432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"889.941374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-04T15:12:17.789497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"805.692264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.54\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-08-04T15:12:17.789511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.571685ms","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-08-04T15:12:17.78954Z","caller":"traceutil/trace.go:171","msg":"trace[300396789] range","detail":"{range_begin:/registry/masterleases/199.19.213.54; range_end:; response_count:1; response_revision:594; }","duration":"805.755205ms","start":"2026-08-04T15:12:16.983768Z","end":"2026-08-04T15:12:17.789523Z","steps":["trace[300396789] 'agreement among raft nodes before linearized reading' (duration: 805.695244ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:17.789559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:16.516541Z","time spent":"1.272871774s","remote":"127.0.0.1:59318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:12:17.789582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:16.983749Z","time spent":"805.825707ms","remote":"127.0.0.1:59258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.19.213.54\" "} {"level":"info","ts":"2026-08-04T15:12:17.789587Z","caller":"traceutil/trace.go:171","msg":"trace[1617530097] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:594; }","duration":"553.701438ms","start":"2026-08-04T15:12:17.235864Z","end":"2026-08-04T15:12:17.789565Z","steps":["trace[1617530097] 'agreement among raft nodes before linearized reading' (duration: 553.544255ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:17.789639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:17.235832Z","time spent":"553.797681ms","remote":"127.0.0.1:59474","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":"info","ts":"2026-08-04T15:12:17.78954Z","caller":"traceutil/trace.go:171","msg":"trace[2146982929] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:594; }","duration":"890.089647ms","start":"2026-08-04T15:12:16.89943Z","end":"2026-08-04T15:12:17.78952Z","steps":["trace[2146982929] 'agreement among raft nodes before linearized reading' (duration: 889.946014ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:17.789753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:16.899406Z","time spent":"890.287842ms","remote":"127.0.0.1:59212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-04T15:12:19.731061Z","caller":"traceutil/trace.go:171","msg":"trace[1238453706] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"362.570115ms","start":"2026-08-04T15:12:19.368468Z","end":"2026-08-04T15:12:19.731038Z","steps":["trace[1238453706] 'process raft request' (duration: 321.223973ms)","trace[1238453706] 'compare' (duration: 41.030474ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:12:19.731126Z","caller":"traceutil/trace.go:171","msg":"trace[2096195510] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"360.952106ms","start":"2026-08-04T15:12:19.370149Z","end":"2026-08-04T15:12:19.731101Z","steps":["trace[2096195510] 'process raft request' (duration: 360.831493ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:19.73117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:19.368457Z","time spent":"362.661347ms","remote":"127.0.0.1:59750","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":950,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-04T15:12:19.731283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:19.370129Z","time spent":"361.069ms","remote":"127.0.0.1:59270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4156,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:12:19.738756Z","caller":"traceutil/trace.go:171","msg":"trace[1064135196] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"180.877623ms","start":"2026-08-04T15:12:19.557867Z","end":"2026-08-04T15:12:19.738745Z","steps":["trace[1064135196] 'process raft request' (duration: 180.818522ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:22.507466Z","caller":"traceutil/trace.go:171","msg":"trace[2046188618] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"116.040987ms","start":"2026-08-04T15:12:22.391403Z","end":"2026-08-04T15:12:22.507444Z","steps":["trace[2046188618] 'process raft request' (duration: 115.905543ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:32.333333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.774004ms","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-08-04T15:12:32.333438Z","caller":"traceutil/trace.go:171","msg":"trace[1690414461] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:754; }","duration":"205.924187ms","start":"2026-08-04T15:12:32.127496Z","end":"2026-08-04T15:12:32.33342Z","steps":["trace[1690414461] 'range keys from in-memory index tree' (duration: 205.615309ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:32.333798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.325723ms","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-08-04T15:12:32.333854Z","caller":"traceutil/trace.go:171","msg":"trace[143802293] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:754; }","duration":"170.426844ms","start":"2026-08-04T15:12:32.163415Z","end":"2026-08-04T15:12:32.333842Z","steps":["trace[143802293] 'range keys from in-memory index tree' (duration: 170.170029ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:32.793574Z","caller":"traceutil/trace.go:171","msg":"trace[2114130968] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"457.472935ms","start":"2026-08-04T15:12:32.336085Z","end":"2026-08-04T15:12:32.793558Z","steps":["trace[2114130968] 'process raft request' (duration: 457.374403ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:32.793689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:32.336066Z","time spent":"457.565497ms","remote":"127.0.0.1:59444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:12:32.797804Z","caller":"traceutil/trace.go:171","msg":"trace[508518640] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"459.883697ms","start":"2026-08-04T15:12:32.337896Z","end":"2026-08-04T15:12:32.79778Z","steps":["trace[508518640] 'process raft request' (duration: 459.833206ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:32.797971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:32.337888Z","time spent":"459.98835ms","remote":"127.0.0.1:59474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:12:32.798111Z","caller":"traceutil/trace.go:171","msg":"trace[754783500] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"460.233795ms","start":"2026-08-04T15:12:32.337835Z","end":"2026-08-04T15:12:32.798069Z","steps":["trace[754783500] 'process raft request' (duration: 459.742845ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:32.79825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:32.337816Z","time spent":"460.355108ms","remote":"127.0.0.1:59474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:12:37.376597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.025409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:5 size:1050264"} {"level":"info","ts":"2026-08-04T15:12:37.376693Z","caller":"traceutil/trace.go:171","msg":"trace[215281777] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:802; }","duration":"182.144522ms","start":"2026-08-04T15:12:37.194526Z","end":"2026-08-04T15:12:37.37667Z","steps":["trace[215281777] 'range keys from in-memory index tree' (duration: 180.975407ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:38.102209Z","caller":"traceutil/trace.go:171","msg":"trace[804216500] linearizableReadLoop","detail":"{readStateIndex:837; appliedIndex:836; }","duration":"199.59138ms","start":"2026-08-04T15:12:37.902585Z","end":"2026-08-04T15:12:38.102177Z","steps":["trace[804216500] 'read index received' (duration: 199.383745ms)","trace[804216500] 'applied index is now lower than readState.Index' (duration: 206.315µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:12:38.102292Z","caller":"traceutil/trace.go:171","msg":"trace[1996547322] transaction","detail":"{read_only:false; response_revision:806; number_of_response:1; }","duration":"200.624952ms","start":"2026-08-04T15:12:37.901651Z","end":"2026-08-04T15:12:38.102275Z","steps":["trace[1996547322] 'process raft request' (duration: 200.350736ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:38.102607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.009328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-04T15:12:38.102692Z","caller":"traceutil/trace.go:171","msg":"trace[1737754128] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:806; }","duration":"200.135711ms","start":"2026-08-04T15:12:37.902543Z","end":"2026-08-04T15:12:38.102679Z","steps":["trace[1737754128] 'agreement among raft nodes before linearized reading' (duration: 199.783944ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:38.102755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.698645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-04T15:12:38.102884Z","caller":"traceutil/trace.go:171","msg":"trace[578444658] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:806; }","duration":"176.982511ms","start":"2026-08-04T15:12:37.925877Z","end":"2026-08-04T15:12:38.10286Z","steps":["trace[578444658] 'agreement among raft nodes before linearized reading' (duration: 176.701555ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:38.515731Z","caller":"traceutil/trace.go:171","msg":"trace[2073222456] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"407.969471ms","start":"2026-08-04T15:12:38.107738Z","end":"2026-08-04T15:12:38.515707Z","steps":["trace[2073222456] 'process raft request' (duration: 406.684394ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:38.515902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:38.107722Z","time spent":"408.087594ms","remote":"127.0.0.1:59474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:12:38.516268Z","caller":"traceutil/trace.go:171","msg":"trace[23478517] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"370.109536ms","start":"2026-08-04T15:12:38.146124Z","end":"2026-08-04T15:12:38.516234Z","steps":["trace[23478517] 'process raft request' (duration: 369.495433ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:38.516452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:38.146094Z","time spent":"370.261759ms","remote":"127.0.0.1:59474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:12:51.778536Z","caller":"traceutil/trace.go:171","msg":"trace[624893443] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"208.168756ms","start":"2026-08-04T15:12:51.570349Z","end":"2026-08-04T15:12:51.778518Z","steps":["trace[624893443] 'process raft request' (duration: 207.942341ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:57.833959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.678693ms","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-08-04T15:12:57.834083Z","caller":"traceutil/trace.go:171","msg":"trace[1976353081] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1119; }","duration":"188.855336ms","start":"2026-08-04T15:12:57.645214Z","end":"2026-08-04T15:12:57.834069Z","steps":["trace[1976353081] 'range keys from in-memory index tree' (duration: 188.52991ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:57.836194Z","caller":"traceutil/trace.go:171","msg":"trace[1283418362] transaction","detail":"{read_only:false; response_revision:1120; number_of_response:1; }","duration":"168.580486ms","start":"2026-08-04T15:12:57.667604Z","end":"2026-08-04T15:12:57.836184Z","steps":["trace[1283418362] 'process raft request' (duration: 168.511035ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:59.616307Z","caller":"traceutil/trace.go:171","msg":"trace[1282893324] transaction","detail":"{read_only:false; response_revision:1138; number_of_response:1; }","duration":"156.980468ms","start":"2026-08-04T15:12:59.4593Z","end":"2026-08-04T15:12:59.61628Z","steps":["trace[1282893324] 'process raft request' (duration: 156.809175ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:13:04.838905Z","caller":"traceutil/trace.go:171","msg":"trace[1347208431] transaction","detail":"{read_only:false; response_revision:1160; number_of_response:1; }","duration":"176.997701ms","start":"2026-08-04T15:13:04.661878Z","end":"2026-08-04T15:13:04.838875Z","steps":["trace[1347208431] 'process raft request' (duration: 176.624664ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:13:32.877791Z","caller":"traceutil/trace.go:171","msg":"trace[1768466646] transaction","detail":"{read_only:false; response_revision:1513; number_of_response:1; }","duration":"177.906339ms","start":"2026-08-04T15:13:32.699855Z","end":"2026-08-04T15:13:32.877762Z","steps":["trace[1768466646] 'process raft request' (duration: 133.672219ms)","trace[1768466646] 'compare' (duration: 44.105068ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:13:32.881435Z","caller":"traceutil/trace.go:171","msg":"trace[264528368] transaction","detail":"{read_only:false; response_revision:1514; number_of_response:1; }","duration":"109.912715ms","start":"2026-08-04T15:13:32.771503Z","end":"2026-08-04T15:13:32.881416Z","steps":["trace[264528368] 'process raft request' (duration: 109.312795ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:13:34.555098Z","caller":"traceutil/trace.go:171","msg":"trace[1963113233] transaction","detail":"{read_only:false; response_revision:1524; number_of_response:1; }","duration":"127.837207ms","start":"2026-08-04T15:13:34.427213Z","end":"2026-08-04T15:13:34.55505Z","steps":["trace[1963113233] 'process raft request' (duration: 127.645564ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:13:37.327512Z","caller":"traceutil/trace.go:171","msg":"trace[667496952] transaction","detail":"{read_only:false; response_revision:1536; number_of_response:1; }","duration":"107.911507ms","start":"2026-08-04T15:13:37.219577Z","end":"2026-08-04T15:13:37.327489Z","steps":["trace[667496952] 'process raft request' (duration: 107.773934ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:13:37.348102Z","caller":"traceutil/trace.go:171","msg":"trace[45160040] transaction","detail":"{read_only:false; response_revision:1537; number_of_response:1; }","duration":"102.715379ms","start":"2026-08-04T15:13:37.245353Z","end":"2026-08-04T15:13:37.348068Z","steps":["trace[45160040] 'process raft request' (duration: 102.395474ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:13:39.807669Z","caller":"traceutil/trace.go:171","msg":"trace[1745259694] transaction","detail":"{read_only:false; response_revision:1651; number_of_response:1; }","duration":"139.855119ms","start":"2026-08-04T15:13:39.667794Z","end":"2026-08-04T15:13:39.807649Z","steps":["trace[1745259694] 'process raft request' (duration: 139.736147ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:13:41.931017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.718797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/\" range_end:\"/registry/secrets/openstack0\" ","response":"range_response_count:2 size:146766"} {"level":"info","ts":"2026-08-04T15:13:41.931107Z","caller":"traceutil/trace.go:171","msg":"trace[1419341723] range","detail":"{range_begin:/registry/secrets/openstack/; range_end:/registry/secrets/openstack0; response_count:2; response_revision:1679; }","duration":"121.855278ms","start":"2026-08-04T15:13:41.809232Z","end":"2026-08-04T15:13:41.931087Z","steps":["trace[1419341723] 'range keys from in-memory index tree' (duration: 121.492712ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:13:52.950903Z","caller":"traceutil/trace.go:171","msg":"trace[319917166] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"161.139371ms","start":"2026-08-04T15:13:52.789718Z","end":"2026-08-04T15:13:52.950858Z","steps":["trace[319917166] 'process raft request' (duration: 160.726725ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:13:53.681718Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9609449934159547576,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-04T15:13:54.182416Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9609449934159547576,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-04T15:13:54.502857Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.536437021s","expected-duration":"1s"} {"level":"info","ts":"2026-08-04T15:13:54.503508Z","caller":"traceutil/trace.go:171","msg":"trace[84125072] transaction","detail":"{read_only:false; response_revision:1839; number_of_response:1; }","duration":"1.537211684s","start":"2026-08-04T15:13:52.966264Z","end":"2026-08-04T15:13:54.503476Z","steps":["trace[84125072] 'process raft request' (duration: 1.53698601s)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:13:54.503709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:13:52.966253Z","time spent":"1.537354346s","remote":"127.0.0.1:59412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10966,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:13:54.800721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.073832ms","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-08-04T15:13:54.800865Z","caller":"traceutil/trace.go:171","msg":"trace[328089369] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1839; }","duration":"260.251175ms","start":"2026-08-04T15:13:54.540593Z","end":"2026-08-04T15:13:54.800845Z","steps":["trace[328089369] 'range keys from in-memory index tree' (duration: 260.052701ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:13:54.801209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.421397ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:13:54.80147Z","caller":"traceutil/trace.go:171","msg":"trace[1256636854] linearizableReadLoop","detail":"{readStateIndex:1916; appliedIndex:1912; }","duration":"1.620576785s","start":"2026-08-04T15:13:53.180876Z","end":"2026-08-04T15:13:54.801453Z","steps":["trace[1256636854] 'read index received' (duration: 1.322409021s)","trace[1256636854] 'applied index is now lower than readState.Index' (duration: 298.166604ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:13:54.801546Z","caller":"traceutil/trace.go:171","msg":"trace[1207341221] transaction","detail":"{read_only:false; response_revision:1840; number_of_response:1; }","duration":"1.452257344s","start":"2026-08-04T15:13:53.349277Z","end":"2026-08-04T15:13:54.801535Z","steps":["trace[1207341221] 'process raft request' (duration: 1.2064065s)","trace[1207341221] 'compare' (duration: 245.01393ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:13:54.801607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:13:53.349258Z","time spent":"1.452311165s","remote":"127.0.0.1:59474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:13:54.801894Z","caller":"traceutil/trace.go:171","msg":"trace[626018394] transaction","detail":"{read_only:false; response_revision:1841; number_of_response:1; }","duration":"1.438071165s","start":"2026-08-04T15:13:53.363803Z","end":"2026-08-04T15:13:54.801874Z","steps":["trace[626018394] 'process raft request' (duration: 1.437487546s)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:13:54.80194Z","caller":"traceutil/trace.go:171","msg":"trace[312077717] transaction","detail":"{read_only:false; response_revision:1842; number_of_response:1; }","duration":"1.41851404s","start":"2026-08-04T15:13:53.383414Z","end":"2026-08-04T15:13:54.801928Z","steps":["trace[312077717] 'process raft request' (duration: 1.417931141s)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:13:54.801987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.621100364s","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-08-04T15:13:54.802052Z","caller":"traceutil/trace.go:171","msg":"trace[1659355299] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1844; }","duration":"1.621205646s","start":"2026-08-04T15:13:53.180831Z","end":"2026-08-04T15:13:54.802037Z","steps":["trace[1659355299] 'agreement among raft nodes before linearized reading' (duration: 1.621021693s)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:13:54.802061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:13:53.363777Z","time spent":"1.438161187s","remote":"127.0.0.1:59474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:13:54.802059Z","caller":"traceutil/trace.go:171","msg":"trace[597746042] transaction","detail":"{read_only:false; response_revision:1844; number_of_response:1; }","duration":"513.495847ms","start":"2026-08-04T15:13:54.288544Z","end":"2026-08-04T15:13:54.80204Z","steps":["trace[597746042] 'process raft request' (duration: 512.871297ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:13:54.80209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:13:53.18081Z","time spent":"1.621271546s","remote":"127.0.0.1:59474","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-08-04T15:13:54.801997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:13:53.3834Z","time spent":"1.418567472s","remote":"127.0.0.1:59474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:13:54.801913Z","caller":"traceutil/trace.go:171","msg":"trace[1507645078] transaction","detail":"{read_only:false; response_revision:1843; number_of_response:1; }","duration":"535.127906ms","start":"2026-08-04T15:13:54.266707Z","end":"2026-08-04T15:13:54.801835Z","steps":["trace[1507645078] 'process raft request' (duration: 534.673038ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:13:54.802672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:13:54.288524Z","time spent":"513.611319ms","remote":"127.0.0.1:59474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:13:54.803009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:13:54.266681Z","time spent":"535.665424ms","remote":"127.0.0.1:59474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:13:55.916258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"899.843739ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:13:55.916678Z","caller":"traceutil/trace.go:171","msg":"trace[1191081463] transaction","detail":"{read_only:false; response_revision:1845; number_of_response:1; }","duration":"1.406084949s","start":"2026-08-04T15:13:54.510557Z","end":"2026-08-04T15:13:55.916642Z","steps":["trace[1191081463] 'process raft request' (duration: 505.65383ms)","trace[1191081463] 'compare' (duration: 899.338111ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:13:55.916898Z","caller":"traceutil/trace.go:171","msg":"trace[1555926137] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"1.405904186s","start":"2026-08-04T15:13:54.510965Z","end":"2026-08-04T15:13:55.916869Z","steps":["trace[1555926137] 'process raft request' (duration: 1.405405638s)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:13:55.916872Z","caller":"traceutil/trace.go:171","msg":"trace[1683035784] transaction","detail":"{read_only:false; response_revision:1848; number_of_response:1; }","duration":"1.4055475s","start":"2026-08-04T15:13:54.511301Z","end":"2026-08-04T15:13:55.916849Z","steps":["trace[1683035784] 'process raft request' (duration: 1.405287196s)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:13:55.916923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:13:54.510528Z","time spent":"1.406283753s","remote":"127.0.0.1:59484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1529,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:13:55.917029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:13:54.510941Z","time spent":"1.406014468s","remote":"127.0.0.1:59384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":977,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:13:55.917046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:13:54.511277Z","time spent":"1.405682303s","remote":"127.0.0.1:59384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:13:55.917026Z","caller":"traceutil/trace.go:171","msg":"trace[454412086] transaction","detail":"{read_only:false; response_revision:1849; number_of_response:1; }","duration":"1.109633852s","start":"2026-08-04T15:13:54.807379Z","end":"2026-08-04T15:13:55.917013Z","steps":["trace[454412086] 'process raft request' (duration: 1.109259526s)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:13:55.917123Z","caller":"traceutil/trace.go:171","msg":"trace[97577846] linearizableReadLoop","detail":"{readStateIndex:1922; appliedIndex:1918; }","duration":"1.115607298s","start":"2026-08-04T15:13:54.801498Z","end":"2026-08-04T15:13:55.917105Z","steps":["trace[97577846] 'read index received' (duration: 214.730992ms)","trace[97577846] 'applied index is now lower than readState.Index' (duration: 900.875036ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:13:55.91674Z","caller":"traceutil/trace.go:171","msg":"trace[528397404] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"1.081802345s","start":"2026-08-04T15:13:54.834919Z","end":"2026-08-04T15:13:55.916722Z","steps":["trace[528397404] 'process raft request' (duration: 1.081758304s)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:13:55.916907Z","caller":"traceutil/trace.go:171","msg":"trace[321834337] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"1.405875376s","start":"2026-08-04T15:13:54.511012Z","end":"2026-08-04T15:13:55.916888Z","steps":["trace[321834337] 'process raft request' (duration: 1.4054912s)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:13:55.917196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:13:54.807358Z","time spent":"1.109765525s","remote":"127.0.0.1:59474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:13:55.917266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.958857999s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-61f769d3-3c76-4cd2-a282-d859a2ae98c4\" ","response":"range_response_count:1 size:3740"} {"level":"warn","ts":"2026-08-04T15:13:55.917266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:13:54.834887Z","time spent":"1.082297012s","remote":"127.0.0.1:59474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:13:55.917294Z","caller":"traceutil/trace.go:171","msg":"trace[953798375] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-61f769d3-3c76-4cd2-a282-d859a2ae98c4; range_end:; response_count:1; response_revision:1850; }","duration":"1.95895767s","start":"2026-08-04T15:13:53.958328Z","end":"2026-08-04T15:13:55.917285Z","steps":["trace[953798375] 'agreement among raft nodes before linearized reading' (duration: 1.958833598s)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:13:55.917303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.478288199s","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-08-04T15:13:55.917289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:13:54.510998Z","time spent":"1.406219601s","remote":"127.0.0.1:59484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1471,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:13:55.917351Z","caller":"traceutil/trace.go:171","msg":"trace[386927696] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1850; }","duration":"2.47837246s","start":"2026-08-04T15:13:53.438965Z","end":"2026-08-04T15:13:55.917337Z","steps":["trace[386927696] 'agreement among raft nodes before linearized reading' (duration: 2.478242988s)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:13:55.917372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.210580375s","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-08-04T15:13:55.91739Z","caller":"traceutil/trace.go:171","msg":"trace[1517884465] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1850; }","duration":"1.210643327s","start":"2026-08-04T15:13:54.706741Z","end":"2026-08-04T15:13:55.917384Z","steps":["trace[1517884465] 'agreement among raft nodes before linearized reading' (duration: 1.210586746s)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:13:55.917384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.467953484s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-04T15:13:55.917391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:13:53.43894Z","time spent":"2.478440702s","remote":"127.0.0.1:59474","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-08-04T15:13:55.917405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:13:54.706724Z","time spent":"1.210677897s","remote":"127.0.0.1:59474","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-08-04T15:13:55.917316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:13:53.958297Z","time spent":"1.959014272s","remote":"127.0.0.1:59412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3763,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-61f769d3-3c76-4cd2-a282-d859a2ae98c4\" "} {"level":"info","ts":"2026-08-04T15:13:55.917415Z","caller":"traceutil/trace.go:171","msg":"trace[635722400] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1850; }","duration":"1.468016525s","start":"2026-08-04T15:13:54.449389Z","end":"2026-08-04T15:13:55.917406Z","steps":["trace[635722400] 'agreement among raft nodes before linearized reading' (duration: 1.467955324s)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:13:55.91744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:13:54.449368Z","time spent":"1.468066876s","remote":"127.0.0.1:51990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"warn","ts":"2026-08-04T15:13:55.917528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.480116098s","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-08-04T15:13:55.917555Z","caller":"traceutil/trace.go:171","msg":"trace[1134765066] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1850; }","duration":"2.480172959s","start":"2026-08-04T15:13:53.437373Z","end":"2026-08-04T15:13:55.917546Z","steps":["trace[1134765066] 'agreement among raft nodes before linearized reading' (duration: 2.480093798s)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:13:55.917582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:13:53.437352Z","time spent":"2.48022351s","remote":"127.0.0.1:59474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-04T15:13:55.91758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.622873975s","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":"warn","ts":"2026-08-04T15:13:55.917596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.721713811s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-04T15:13:55.91766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.019427382s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:13:55.917681Z","caller":"traceutil/trace.go:171","msg":"trace[984924799] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1850; }","duration":"1.019498102s","start":"2026-08-04T15:13:54.898176Z","end":"2026-08-04T15:13:55.917674Z","steps":["trace[984924799] 'agreement among raft nodes before linearized reading' (duration: 1.019465362s)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:13:55.917706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:13:54.898159Z","time spent":"1.019536964s","remote":"127.0.0.1:59212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-04T15:13:55.917719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.654384675s","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-08-04T15:13:55.917696Z","caller":"traceutil/trace.go:171","msg":"trace[181479028] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:1850; }","duration":"2.721825052s","start":"2026-08-04T15:13:53.195833Z","end":"2026-08-04T15:13:55.917658Z","steps":["trace[181479028] 'agreement among raft nodes before linearized reading' (duration: 2.72168005s)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:13:55.917755Z","caller":"traceutil/trace.go:171","msg":"trace[1567786547] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1850; }","duration":"2.654433907s","start":"2026-08-04T15:13:53.263311Z","end":"2026-08-04T15:13:55.917744Z","steps":["trace[1567786547] 'agreement among raft nodes before linearized reading' (duration: 2.654342205s)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:13:55.917769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:13:53.195815Z","time spent":"2.721941084s","remote":"127.0.0.1:40556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-08-04T15:13:55.917787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:13:53.263301Z","time spent":"2.654478657s","remote":"127.0.0.1:54302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-08-04T15:13:55.917613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.481225386s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:13:55.917939Z","caller":"traceutil/trace.go:171","msg":"trace[1931604419] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:1850; }","duration":"2.481582291s","start":"2026-08-04T15:13:53.436341Z","end":"2026-08-04T15:13:55.917923Z","steps":["trace[1931604419] 'agreement among raft nodes before linearized reading' (duration: 2.481244236s)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:13:55.917992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:13:53.436328Z","time spent":"2.481647503s","remote":"127.0.0.1:40570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"info","ts":"2026-08-04T15:13:55.917619Z","caller":"traceutil/trace.go:171","msg":"trace[673193635] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1850; }","duration":"1.622959276s","start":"2026-08-04T15:13:54.294648Z","end":"2026-08-04T15:13:55.917607Z","steps":["trace[673193635] 'agreement among raft nodes before linearized reading' (duration: 1.622808584s)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:13:55.918159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:13:54.294633Z","time spent":"1.623516515s","remote":"127.0.0.1:59474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-04T15:14:03.108476Z","caller":"traceutil/trace.go:171","msg":"trace[1713694953] transaction","detail":"{read_only:false; response_revision:1912; number_of_response:1; }","duration":"269.023164ms","start":"2026-08-04T15:14:02.839426Z","end":"2026-08-04T15:14:03.108449Z","steps":["trace[1713694953] 'process raft request' (duration: 268.858452ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:14:03.242029Z","caller":"traceutil/trace.go:171","msg":"trace[1687642933] transaction","detail":"{read_only:false; response_revision:1913; number_of_response:1; }","duration":"401.800682ms","start":"2026-08-04T15:14:02.840188Z","end":"2026-08-04T15:14:03.241989Z","steps":["trace[1687642933] 'process raft request' (duration: 319.117156ms)","trace[1687642933] 'compare' (duration: 82.464872ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:14:03.242251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:14:02.84017Z","time spent":"401.996985ms","remote":"127.0.0.1:59474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:14:03.242326Z","caller":"traceutil/trace.go:171","msg":"trace[1179918523] transaction","detail":"{read_only:false; response_revision:1914; number_of_response:1; }","duration":"401.822553ms","start":"2026-08-04T15:14:02.84047Z","end":"2026-08-04T15:14:03.242293Z","steps":["trace[1179918523] 'process raft request' (duration: 401.482337ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:14:03.242422Z","caller":"traceutil/trace.go:171","msg":"trace[922574098] linearizableReadLoop","detail":"{readStateIndex:1992; appliedIndex:1988; }","duration":"265.339592ms","start":"2026-08-04T15:14:02.977063Z","end":"2026-08-04T15:14:03.242403Z","steps":["trace[922574098] 'read index received' (duration: 131.253394ms)","trace[922574098] 'applied index is now lower than readState.Index' (duration: 134.085238ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:14:03.24251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:14:02.840464Z","time spent":"401.963065ms","remote":"127.0.0.1:59474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:14:03.24261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.517885ms","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-08-04T15:14:03.242649Z","caller":"traceutil/trace.go:171","msg":"trace[1817898303] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1915; }","duration":"265.581666ms","start":"2026-08-04T15:14:02.977057Z","end":"2026-08-04T15:14:03.242638Z","steps":["trace[1817898303] 'agreement among raft nodes before linearized reading' (duration: 265.416373ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:14:03.24325Z","caller":"traceutil/trace.go:171","msg":"trace[1081714378] transaction","detail":"{read_only:false; response_revision:1915; number_of_response:1; }","duration":"402.044245ms","start":"2026-08-04T15:14:02.841171Z","end":"2026-08-04T15:14:03.243215Z","steps":["trace[1081714378] 'process raft request' (duration: 401.023029ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:14:03.243337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:14:02.841166Z","time spent":"402.128117ms","remote":"127.0.0.1:59474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:14:09.458085Z","caller":"traceutil/trace.go:171","msg":"trace[1903340610] transaction","detail":"{read_only:false; response_revision:1968; number_of_response:1; }","duration":"174.096641ms","start":"2026-08-04T15:14:09.283961Z","end":"2026-08-04T15:14:09.458058Z","steps":["trace[1903340610] 'process raft request' (duration: 162.145374ms)","trace[1903340610] 'compare' (duration: 11.710933ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:14:09.463704Z","caller":"traceutil/trace.go:171","msg":"trace[62782661] linearizableReadLoop","detail":"{readStateIndex:2047; appliedIndex:2045; }","duration":"163.073019ms","start":"2026-08-04T15:14:09.300614Z","end":"2026-08-04T15:14:09.463687Z","steps":["trace[62782661] 'read index received' (duration: 145.654437ms)","trace[62782661] 'applied index is now lower than readState.Index' (duration: 17.415852ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:14:09.463751Z","caller":"traceutil/trace.go:171","msg":"trace[981068845] transaction","detail":"{read_only:false; response_revision:1969; number_of_response:1; }","duration":"177.643677ms","start":"2026-08-04T15:14:09.28608Z","end":"2026-08-04T15:14:09.463724Z","steps":["trace[981068845] 'process raft request' (duration: 177.522095ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:14:09.464136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.503586ms","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-08-04T15:14:09.464457Z","caller":"traceutil/trace.go:171","msg":"trace[1205313353] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1969; }","duration":"163.864571ms","start":"2026-08-04T15:14:09.300565Z","end":"2026-08-04T15:14:09.46443Z","steps":["trace[1205313353] 'agreement among raft nodes before linearized reading' (duration: 163.274051ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:14:13.267008Z","caller":"traceutil/trace.go:171","msg":"trace[1426958164] transaction","detail":"{read_only:false; response_revision:1992; number_of_response:1; }","duration":"103.996994ms","start":"2026-08-04T15:14:13.162981Z","end":"2026-08-04T15:14:13.266978Z","steps":["trace[1426958164] 'process raft request' (duration: 103.593098ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:14:14.628791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.548069ms","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-08-04T15:14:14.628886Z","caller":"traceutil/trace.go:171","msg":"trace[550854162] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2000; }","duration":"131.661611ms","start":"2026-08-04T15:14:14.497182Z","end":"2026-08-04T15:14:14.628843Z","steps":["trace[550854162] 'range keys from in-memory index tree' (duration: 131.382366ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:14:30.272255Z","caller":"traceutil/trace.go:171","msg":"trace[1676970138] linearizableReadLoop","detail":"{readStateIndex:2169; appliedIndex:2168; }","duration":"145.732448ms","start":"2026-08-04T15:14:30.126497Z","end":"2026-08-04T15:14:30.27223Z","steps":["trace[1676970138] 'read index received' (duration: 145.598896ms)","trace[1676970138] 'applied index is now lower than readState.Index' (duration: 132.752µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:14:30.272353Z","caller":"traceutil/trace.go:171","msg":"trace[27379955] transaction","detail":"{read_only:false; response_revision:2087; number_of_response:1; }","duration":"148.141574ms","start":"2026-08-04T15:14:30.124195Z","end":"2026-08-04T15:14:30.272337Z","steps":["trace[27379955] 'process raft request' (duration: 147.88233ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:14:30.272465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.965311ms","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-08-04T15:14:30.272517Z","caller":"traceutil/trace.go:171","msg":"trace[1602555177] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2087; }","duration":"146.059113ms","start":"2026-08-04T15:14:30.126446Z","end":"2026-08-04T15:14:30.272505Z","steps":["trace[1602555177] 'agreement among raft nodes before linearized reading' (duration: 145.900761ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:14:30.272551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.099608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-04T15:14:30.272582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.400516ms","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-08-04T15:14:30.272594Z","caller":"traceutil/trace.go:171","msg":"trace[1897033813] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:2087; }","duration":"112.176249ms","start":"2026-08-04T15:14:30.160405Z","end":"2026-08-04T15:14:30.272582Z","steps":["trace[1897033813] 'agreement among raft nodes before linearized reading' (duration: 112.109828ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:14:30.272627Z","caller":"traceutil/trace.go:171","msg":"trace[1043007394] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2087; }","duration":"132.534559ms","start":"2026-08-04T15:14:30.140081Z","end":"2026-08-04T15:14:30.272616Z","steps":["trace[1043007394] 'agreement among raft nodes before linearized reading' (duration: 132.375766ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:14:30.272675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.93393ms","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-08-04T15:14:30.272754Z","caller":"traceutil/trace.go:171","msg":"trace[2110067410] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2087; }","duration":"140.045561ms","start":"2026-08-04T15:14:30.132688Z","end":"2026-08-04T15:14:30.272734Z","steps":["trace[2110067410] 'agreement among raft nodes before linearized reading' (duration: 139.794148ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:14:30.273181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.719537ms","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-08-04T15:14:30.273234Z","caller":"traceutil/trace.go:171","msg":"trace[1874661994] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2087; }","duration":"141.804599ms","start":"2026-08-04T15:14:30.131414Z","end":"2026-08-04T15:14:30.273219Z","steps":["trace[1874661994] 'agreement among raft nodes before linearized reading' (duration: 140.974186ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:14:35.505899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.898242ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:14:35.506005Z","caller":"traceutil/trace.go:171","msg":"trace[1409325221] linearizableReadLoop","detail":"{readStateIndex:2198; appliedIndex:2197; }","duration":"107.55845ms","start":"2026-08-04T15:14:35.39843Z","end":"2026-08-04T15:14:35.505989Z","steps":["trace[1409325221] 'read index received' (duration: 63.831µs)","trace[1409325221] 'applied index is now lower than readState.Index' (duration: 107.493679ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:14:35.506092Z","caller":"traceutil/trace.go:171","msg":"trace[1935511848] transaction","detail":"{read_only:false; response_revision:2115; number_of_response:1; }","duration":"145.207717ms","start":"2026-08-04T15:14:35.360873Z","end":"2026-08-04T15:14:35.506081Z","steps":["trace[1935511848] 'process raft request' (duration: 12.035392ms)","trace[1935511848] 'compare' (duration: 132.768989ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:14:35.506224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.667491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:122086"} {"level":"warn","ts":"2026-08-04T15:14:35.506214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.764663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-08-04T15:14:35.506315Z","caller":"traceutil/trace.go:171","msg":"trace[1874174233] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:2115; }","duration":"107.921405ms","start":"2026-08-04T15:14:35.398383Z","end":"2026-08-04T15:14:35.506304Z","steps":["trace[1874174233] 'agreement among raft nodes before linearized reading' (duration: 107.776043ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:14:35.506273Z","caller":"traceutil/trace.go:171","msg":"trace[115103718] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:2115; }","duration":"107.751883ms","start":"2026-08-04T15:14:35.398509Z","end":"2026-08-04T15:14:35.506261Z","steps":["trace[115103718] 'agreement among raft nodes before linearized reading' (duration: 107.57874ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:14:35.675922Z","caller":"traceutil/trace.go:171","msg":"trace[178163118] transaction","detail":"{read_only:false; response_revision:2117; number_of_response:1; }","duration":"111.637171ms","start":"2026-08-04T15:14:35.56425Z","end":"2026-08-04T15:14:35.675887Z","steps":["trace[178163118] 'process raft request' (duration: 98.905179ms)","trace[178163118] 'compare' (duration: 12.538749ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:14:36.352661Z","caller":"traceutil/trace.go:171","msg":"trace[606246981] transaction","detail":"{read_only:false; response_revision:2118; number_of_response:1; }","duration":"216.036008ms","start":"2026-08-04T15:14:36.1366Z","end":"2026-08-04T15:14:36.352636Z","steps":["trace[606246981] 'process raft request' (duration: 215.635952ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:14:36.490942Z","caller":"traceutil/trace.go:171","msg":"trace[597991361] transaction","detail":"{read_only:false; response_revision:2120; number_of_response:1; }","duration":"132.370902ms","start":"2026-08-04T15:14:36.358551Z","end":"2026-08-04T15:14:36.490922Z","steps":["trace[597991361] 'process raft request' (duration: 132.325121ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:14:36.491015Z","caller":"traceutil/trace.go:171","msg":"trace[24255265] transaction","detail":"{read_only:false; response_revision:2119; number_of_response:1; }","duration":"132.423172ms","start":"2026-08-04T15:14:36.358549Z","end":"2026-08-04T15:14:36.490972Z","steps":["trace[24255265] 'process raft request' (duration: 53.025338ms)","trace[24255265] 'compare' (duration: 79.163761ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:14:36.499923Z","caller":"traceutil/trace.go:171","msg":"trace[1079207399] transaction","detail":"{read_only:false; response_revision:2121; number_of_response:1; }","duration":"141.263734ms","start":"2026-08-04T15:14:36.358632Z","end":"2026-08-04T15:14:36.499896Z","steps":["trace[1079207399] 'process raft request' (duration: 141.067461ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:14:36.500071Z","caller":"traceutil/trace.go:171","msg":"trace[265755957] transaction","detail":"{read_only:false; response_revision:2122; number_of_response:1; }","duration":"140.835438ms","start":"2026-08-04T15:14:36.359225Z","end":"2026-08-04T15:14:36.50006Z","steps":["trace[265755957] 'process raft request' (duration: 140.618215ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:14:36.500467Z","caller":"traceutil/trace.go:171","msg":"trace[1175271341] transaction","detail":"{read_only:false; response_revision:2123; number_of_response:1; }","duration":"140.553734ms","start":"2026-08-04T15:14:36.359894Z","end":"2026-08-04T15:14:36.500447Z","steps":["trace[1175271341] 'process raft request' (duration: 140.129227ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:14:37.5907Z","caller":"traceutil/trace.go:171","msg":"trace[1768617673] transaction","detail":"{read_only:false; response_revision:2124; number_of_response:1; }","duration":"347.558752ms","start":"2026-08-04T15:14:37.24312Z","end":"2026-08-04T15:14:37.590679Z","steps":["trace[1768617673] 'process raft request' (duration: 337.339049ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:14:37.590904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:14:37.243095Z","time spent":"347.667624ms","remote":"127.0.0.1:59258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:14:37.675587Z","caller":"traceutil/trace.go:171","msg":"trace[116697454] transaction","detail":"{read_only:false; response_revision:2125; number_of_response:1; }","duration":"319.222237ms","start":"2026-08-04T15:14:37.356333Z","end":"2026-08-04T15:14:37.675556Z","steps":["trace[116697454] 'process raft request' (duration: 318.997563ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:14:37.675772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:14:37.356305Z","time spent":"319.371488ms","remote":"127.0.0.1:59474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:14:37.676598Z","caller":"traceutil/trace.go:171","msg":"trace[1586760998] transaction","detail":"{read_only:false; response_revision:2126; number_of_response:1; }","duration":"163.114691ms","start":"2026-08-04T15:14:37.51345Z","end":"2026-08-04T15:14:37.676565Z","steps":["trace[1586760998] 'process raft request' (duration: 162.048895ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:14:38.001625Z","caller":"traceutil/trace.go:171","msg":"trace[2115545223] linearizableReadLoop","detail":"{readStateIndex:2212; appliedIndex:2211; }","duration":"320.555996ms","start":"2026-08-04T15:14:37.681047Z","end":"2026-08-04T15:14:38.001603Z","steps":["trace[2115545223] 'read index received' (duration: 294.811679ms)","trace[2115545223] 'applied index is now lower than readState.Index' (duration: 25.743307ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:14:38.001684Z","caller":"traceutil/trace.go:171","msg":"trace[1552988216] transaction","detail":"{read_only:false; response_revision:2128; number_of_response:1; }","duration":"321.059333ms","start":"2026-08-04T15:14:37.680608Z","end":"2026-08-04T15:14:38.001667Z","steps":["trace[1552988216] 'process raft request' (duration: 295.256875ms)","trace[1552988216] 'compare' (duration: 25.417432ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:14:38.001753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.694898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-08-04T15:14:38.001798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.073278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-04T15:14:38.001801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:14:37.680573Z","time spent":"321.143945ms","remote":"127.0.0.1:59474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:14:38.001808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.575196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:14:38.00183Z","caller":"traceutil/trace.go:171","msg":"trace[1638638700] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:2128; }","duration":"294.159859ms","start":"2026-08-04T15:14:37.707661Z","end":"2026-08-04T15:14:38.001821Z","steps":["trace[1638638700] 'agreement among raft nodes before linearized reading' (duration: 294.083348ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:14:38.001816Z","caller":"traceutil/trace.go:171","msg":"trace[350096055] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:2128; }","duration":"320.80095ms","start":"2026-08-04T15:14:37.680997Z","end":"2026-08-04T15:14:38.001797Z","steps":["trace[350096055] 'agreement among raft nodes before linearized reading' (duration: 320.674278ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:14:38.001892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:14:37.680979Z","time spent":"320.898531ms","remote":"127.0.0.1:59484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"warn","ts":"2026-08-04T15:14:38.00196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.34005ms","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-08-04T15:14:38.002117Z","caller":"traceutil/trace.go:171","msg":"trace[1598149567] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2128; }","duration":"224.543993ms","start":"2026-08-04T15:14:37.777558Z","end":"2026-08-04T15:14:38.002102Z","steps":["trace[1598149567] 'agreement among raft nodes before linearized reading' (duration: 224.31866ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:14:38.001851Z","caller":"traceutil/trace.go:171","msg":"trace[155736677] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2128; }","duration":"103.677247ms","start":"2026-08-04T15:14:37.898163Z","end":"2026-08-04T15:14:38.001841Z","steps":["trace[155736677] 'agreement among raft nodes before linearized reading' (duration: 103.594526ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:15:01.736653Z","caller":"traceutil/trace.go:171","msg":"trace[158231368] transaction","detail":"{read_only:false; response_revision:2258; number_of_response:1; }","duration":"158.43627ms","start":"2026-08-04T15:15:01.578193Z","end":"2026-08-04T15:15:01.736629Z","steps":["trace[158231368] 'process raft request' (duration: 158.266353ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:15:02.219767Z","caller":"traceutil/trace.go:171","msg":"trace[961815731] transaction","detail":"{read_only:false; response_revision:2262; number_of_response:1; }","duration":"137.828564ms","start":"2026-08-04T15:15:02.081913Z","end":"2026-08-04T15:15:02.219742Z","steps":["trace[961815731] 'process raft request' (duration: 137.617815ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:15:02.254025Z","caller":"traceutil/trace.go:171","msg":"trace[1706983496] transaction","detail":"{read_only:false; response_revision:2263; number_of_response:1; }","duration":"163.390814ms","start":"2026-08-04T15:15:02.090608Z","end":"2026-08-04T15:15:02.253999Z","steps":["trace[1706983496] 'process raft request' (duration: 163.232477ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:15:02.529852Z","caller":"traceutil/trace.go:171","msg":"trace[1219728710] transaction","detail":"{read_only:false; response_revision:2264; number_of_response:1; }","duration":"163.660315ms","start":"2026-08-04T15:15:02.366143Z","end":"2026-08-04T15:15:02.529803Z","steps":["trace[1219728710] 'process raft request' (duration: 156.808877ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:15:24.547023Z","caller":"traceutil/trace.go:171","msg":"trace[1847803778] transaction","detail":"{read_only:false; response_revision:2420; number_of_response:1; }","duration":"235.743966ms","start":"2026-08-04T15:15:24.311248Z","end":"2026-08-04T15:15:24.546992Z","steps":["trace[1847803778] 'process raft request' (duration: 171.573211ms)","trace[1847803778] 'compare' (duration: 63.700866ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:15:24.547069Z","caller":"traceutil/trace.go:171","msg":"trace[347893289] transaction","detail":"{read_only:false; response_revision:2421; number_of_response:1; }","duration":"235.626901ms","start":"2026-08-04T15:15:24.311422Z","end":"2026-08-04T15:15:24.547049Z","steps":["trace[347893289] 'process raft request' (duration: 235.506616ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:15:24.5471Z","caller":"traceutil/trace.go:171","msg":"trace[1187532978] transaction","detail":"{read_only:false; response_revision:2422; number_of_response:1; }","duration":"131.805726ms","start":"2026-08-04T15:15:24.415272Z","end":"2026-08-04T15:15:24.547077Z","steps":["trace[1187532978] 'process raft request' (duration: 131.725553ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:15:26.296431Z","caller":"traceutil/trace.go:171","msg":"trace[880060454] transaction","detail":"{read_only:false; response_revision:2437; number_of_response:1; }","duration":"135.650942ms","start":"2026-08-04T15:15:26.160731Z","end":"2026-08-04T15:15:26.296382Z","steps":["trace[880060454] 'process raft request' (duration: 129.286324ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:15:34.032954Z","caller":"traceutil/trace.go:171","msg":"trace[1059871485] transaction","detail":"{read_only:false; response_revision:2534; number_of_response:1; }","duration":"118.821385ms","start":"2026-08-04T15:15:33.914094Z","end":"2026-08-04T15:15:34.032915Z","steps":["trace[1059871485] 'process raft request' (duration: 118.648179ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:15:34.054027Z","caller":"traceutil/trace.go:171","msg":"trace[558716064] transaction","detail":"{read_only:false; response_revision:2535; number_of_response:1; }","duration":"108.133097ms","start":"2026-08-04T15:15:33.945859Z","end":"2026-08-04T15:15:34.053992Z","steps":["trace[558716064] 'process raft request' (duration: 107.886798ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:15:35.135171Z","caller":"traceutil/trace.go:171","msg":"trace[220569678] linearizableReadLoop","detail":"{readStateIndex:2635; appliedIndex:2634; }","duration":"323.99696ms","start":"2026-08-04T15:15:34.811134Z","end":"2026-08-04T15:15:35.135131Z","steps":["trace[220569678] 'read index received' (duration: 323.71859ms)","trace[220569678] 'applied index is now lower than readState.Index' (duration: 277.21µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:15:35.135808Z","caller":"traceutil/trace.go:171","msg":"trace[63846746] transaction","detail":"{read_only:false; response_revision:2538; number_of_response:1; }","duration":"538.199839ms","start":"2026-08-04T15:15:34.597593Z","end":"2026-08-04T15:15:35.135793Z","steps":["trace[63846746] 'process raft request' (duration: 537.356047ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:15:35.135957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:15:34.597571Z","time spent":"538.281272ms","remote":"127.0.0.1:59474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:15:35.142528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.274219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-08-04T15:15:35.14255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.177915ms","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-08-04T15:15:35.142589Z","caller":"traceutil/trace.go:171","msg":"trace[1212396850] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2538; }","duration":"210.416255ms","start":"2026-08-04T15:15:34.932158Z","end":"2026-08-04T15:15:35.142574Z","steps":["trace[1212396850] 'agreement among raft nodes before linearized reading' (duration: 203.715173ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:15:35.142603Z","caller":"traceutil/trace.go:171","msg":"trace[386893460] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2538; }","duration":"149.266148ms","start":"2026-08-04T15:15:34.993322Z","end":"2026-08-04T15:15:35.142588Z","steps":["trace[386893460] 'agreement among raft nodes before linearized reading' (duration: 142.509924ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:15:35.142779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.848543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:15:35.142801Z","caller":"traceutil/trace.go:171","msg":"trace[1769865403] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:2538; }","duration":"161.893965ms","start":"2026-08-04T15:15:34.980899Z","end":"2026-08-04T15:15:35.142793Z","steps":["trace[1769865403] 'agreement among raft nodes before linearized reading' (duration: 154.938334ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:15:35.142842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.895838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-08-04T15:15:35.142889Z","caller":"traceutil/trace.go:171","msg":"trace[1178460398] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2538; }","duration":"291.993092ms","start":"2026-08-04T15:15:34.850882Z","end":"2026-08-04T15:15:35.142875Z","steps":["trace[1178460398] 'agreement among raft nodes before linearized reading' (duration: 284.908766ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:15:35.142926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.081157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:15:35.14294Z","caller":"traceutil/trace.go:171","msg":"trace[497896929] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2538; }","duration":"243.144769ms","start":"2026-08-04T15:15:34.89979Z","end":"2026-08-04T15:15:35.142935Z","steps":["trace[497896929] 'agreement among raft nodes before linearized reading' (duration: 236.065113ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:15:35.143048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.967158ms","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-08-04T15:15:35.143062Z","caller":"traceutil/trace.go:171","msg":"trace[1624812513] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2538; }","duration":"201.023231ms","start":"2026-08-04T15:15:34.942034Z","end":"2026-08-04T15:15:35.143057Z","steps":["trace[1624812513] 'agreement among raft nodes before linearized reading' (duration: 193.787579ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:15:35.14318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.285796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-04T15:15:35.14322Z","caller":"traceutil/trace.go:171","msg":"trace[142721626] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2538; }","duration":"168.359098ms","start":"2026-08-04T15:15:34.97485Z","end":"2026-08-04T15:15:35.143209Z","steps":["trace[142721626] 'agreement among raft nodes before linearized reading' (duration: 160.94371ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:15:35.142911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.700423ms","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-08-04T15:15:35.14335Z","caller":"traceutil/trace.go:171","msg":"trace[2087706223] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2538; }","duration":"234.17472ms","start":"2026-08-04T15:15:34.909168Z","end":"2026-08-04T15:15:35.143343Z","steps":["trace[2087706223] 'agreement among raft nodes before linearized reading' (duration: 226.678489ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:15:35.1434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.27062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:15:35.143417Z","caller":"traceutil/trace.go:171","msg":"trace[1806060587] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:2538; }","duration":"332.465838ms","start":"2026-08-04T15:15:34.810945Z","end":"2026-08-04T15:15:35.143411Z","steps":["trace[1806060587] 'agreement among raft nodes before linearized reading' (duration: 324.879013ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:15:35.143434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:15:34.810912Z","time spent":"332.51443ms","remote":"127.0.0.1:54112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true "} {"level":"info","ts":"2026-08-04T15:16:08.339168Z","caller":"traceutil/trace.go:171","msg":"trace[330505890] transaction","detail":"{read_only:false; response_revision:2723; number_of_response:1; }","duration":"115.156116ms","start":"2026-08-04T15:16:08.223985Z","end":"2026-08-04T15:16:08.339142Z","steps":["trace[330505890] 'process raft request' (duration: 114.945239ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:16:08.339846Z","caller":"traceutil/trace.go:171","msg":"trace[430407958] transaction","detail":"{read_only:false; response_revision:2724; number_of_response:1; }","duration":"112.109904ms","start":"2026-08-04T15:16:08.227665Z","end":"2026-08-04T15:16:08.339774Z","steps":["trace[430407958] 'process raft request' (duration: 111.432672ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:16:13.63471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.627431ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:16:13.635007Z","caller":"traceutil/trace.go:171","msg":"trace[1571641030] transaction","detail":"{read_only:false; response_revision:2751; number_of_response:1; }","duration":"233.330912ms","start":"2026-08-04T15:16:13.40164Z","end":"2026-08-04T15:16:13.634971Z","steps":["trace[1571641030] 'process raft request' (duration: 233.288621ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:16:13.635123Z","caller":"traceutil/trace.go:171","msg":"trace[2135644246] transaction","detail":"{read_only:false; response_revision:2750; number_of_response:1; }","duration":"234.207101ms","start":"2026-08-04T15:16:13.400909Z","end":"2026-08-04T15:16:13.635117Z","steps":["trace[2135644246] 'process raft request' (duration: 233.974963ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:16:13.635133Z","caller":"traceutil/trace.go:171","msg":"trace[818577060] transaction","detail":"{read_only:false; response_revision:2749; number_of_response:1; }","duration":"234.492841ms","start":"2026-08-04T15:16:13.400616Z","end":"2026-08-04T15:16:13.635108Z","steps":["trace[818577060] 'process raft request' (duration: 70.405136ms)","trace[818577060] 'compare' (duration: 163.527046ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:16:13.635157Z","caller":"traceutil/trace.go:171","msg":"trace[1188831098] transaction","detail":"{read_only:false; response_revision:2752; number_of_response:1; }","duration":"233.201499ms","start":"2026-08-04T15:16:13.401945Z","end":"2026-08-04T15:16:13.635146Z","steps":["trace[1188831098] 'process raft request' (duration: 233.004392ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:16:13.635329Z","caller":"traceutil/trace.go:171","msg":"trace[1252251888] transaction","detail":"{read_only:false; response_revision:2753; number_of_response:1; }","duration":"204.104554ms","start":"2026-08-04T15:16:13.431218Z","end":"2026-08-04T15:16:13.635322Z","steps":["trace[1252251888] 'process raft request' (duration: 203.889407ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:18:05.824499Z","caller":"traceutil/trace.go:171","msg":"trace[1789274053] transaction","detail":"{read_only:false; response_revision:3418; number_of_response:1; }","duration":"104.963144ms","start":"2026-08-04T15:18:05.719508Z","end":"2026-08-04T15:18:05.824471Z","steps":["trace[1789274053] 'process raft request' (duration: 104.78925ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:18:10.32116Z","caller":"traceutil/trace.go:171","msg":"trace[37956981] transaction","detail":"{read_only:false; response_revision:3440; number_of_response:1; }","duration":"278.98385ms","start":"2026-08-04T15:18:10.04215Z","end":"2026-08-04T15:18:10.321134Z","steps":["trace[37956981] 'process raft request' (duration: 278.836227ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:18:10.32116Z","caller":"traceutil/trace.go:171","msg":"trace[208529084] linearizableReadLoop","detail":"{readStateIndex:3574; appliedIndex:3573; }","duration":"187.017557ms","start":"2026-08-04T15:18:10.134112Z","end":"2026-08-04T15:18:10.32113Z","steps":["trace[208529084] 'read index received' (duration: 187.003917ms)","trace[208529084] 'applied index is now lower than readState.Index' (duration: 11.76µs)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:18:10.32158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.191062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/monitoring\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:18:10.321656Z","caller":"traceutil/trace.go:171","msg":"trace[345561952] range","detail":"{range_begin:/registry/namespaces/monitoring; range_end:; response_count:0; response_revision:3440; }","duration":"187.607871ms","start":"2026-08-04T15:18:10.134031Z","end":"2026-08-04T15:18:10.321638Z","steps":["trace[345561952] 'agreement among raft nodes before linearized reading' (duration: 187.206292ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:18:10.337388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.531268ms","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-08-04T15:18:10.337597Z","caller":"traceutil/trace.go:171","msg":"trace[1402493695] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3441; }","duration":"120.771563ms","start":"2026-08-04T15:18:10.216804Z","end":"2026-08-04T15:18:10.337575Z","steps":["trace[1402493695] 'agreement among raft nodes before linearized reading' (duration: 120.484256ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:18:10.462471Z","caller":"traceutil/trace.go:171","msg":"trace[99825763] transaction","detail":"{read_only:false; response_revision:3442; number_of_response:1; }","duration":"122.846112ms","start":"2026-08-04T15:18:10.339598Z","end":"2026-08-04T15:18:10.462444Z","steps":["trace[99825763] 'process raft request' (duration: 33.494712ms)","trace[99825763] 'compare' (duration: 89.215237ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:18:10.463001Z","caller":"traceutil/trace.go:171","msg":"trace[1705363171] transaction","detail":"{read_only:false; response_revision:3446; number_of_response:1; }","duration":"119.751009ms","start":"2026-08-04T15:18:10.343217Z","end":"2026-08-04T15:18:10.462968Z","steps":["trace[1705363171] 'process raft request' (duration: 119.714448ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:18:10.463115Z","caller":"traceutil/trace.go:171","msg":"trace[1481359923] transaction","detail":"{read_only:false; response_revision:3445; number_of_response:1; }","duration":"120.65131ms","start":"2026-08-04T15:18:10.342451Z","end":"2026-08-04T15:18:10.463102Z","steps":["trace[1481359923] 'process raft request' (duration: 120.453925ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:18:10.463766Z","caller":"traceutil/trace.go:171","msg":"trace[12123141] transaction","detail":"{read_only:false; response_revision:3444; number_of_response:1; }","duration":"121.396677ms","start":"2026-08-04T15:18:10.342319Z","end":"2026-08-04T15:18:10.463716Z","steps":["trace[12123141] 'process raft request' (duration: 120.546757ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:18:10.463008Z","caller":"traceutil/trace.go:171","msg":"trace[1624569672] transaction","detail":"{read_only:false; response_revision:3443; number_of_response:1; }","duration":"120.749443ms","start":"2026-08-04T15:18:10.342215Z","end":"2026-08-04T15:18:10.462964Z","steps":["trace[1624569672] 'process raft request' (duration: 120.543248ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:19:11.576686Z","caller":"traceutil/trace.go:171","msg":"trace[1088248816] transaction","detail":"{read_only:false; response_revision:3847; number_of_response:1; }","duration":"226.33661ms","start":"2026-08-04T15:19:11.350319Z","end":"2026-08-04T15:19:11.576656Z","steps":["trace[1088248816] 'process raft request' (duration: 225.932562ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:19:11.576661Z","caller":"traceutil/trace.go:171","msg":"trace[1738486508] transaction","detail":"{read_only:false; response_revision:3846; number_of_response:1; }","duration":"226.334481ms","start":"2026-08-04T15:19:11.35028Z","end":"2026-08-04T15:19:11.576615Z","steps":["trace[1738486508] 'process raft request' (duration: 127.510517ms)","trace[1738486508] 'compare' (duration: 98.059737ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:19:11.576665Z","caller":"traceutil/trace.go:171","msg":"trace[1785829804] transaction","detail":"{read_only:false; response_revision:3848; number_of_response:1; }","duration":"127.916566ms","start":"2026-08-04T15:19:11.448721Z","end":"2026-08-04T15:19:11.576638Z","steps":["trace[1785829804] 'process raft request' (duration: 127.850385ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:19:24.428838Z","caller":"traceutil/trace.go:171","msg":"trace[164445023] transaction","detail":"{read_only:false; response_revision:3919; number_of_response:1; }","duration":"186.494013ms","start":"2026-08-04T15:19:24.242318Z","end":"2026-08-04T15:19:24.428812Z","steps":["trace[164445023] 'process raft request' (duration: 186.35162ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:19:27.224419Z","caller":"traceutil/trace.go:171","msg":"trace[466536606] transaction","detail":"{read_only:false; response_revision:3935; number_of_response:1; }","duration":"192.319611ms","start":"2026-08-04T15:19:27.032069Z","end":"2026-08-04T15:19:27.224389Z","steps":["trace[466536606] 'process raft request' (duration: 192.215328ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:19:27.224625Z","caller":"traceutil/trace.go:171","msg":"trace[474957023] transaction","detail":"{read_only:false; response_revision:3936; number_of_response:1; }","duration":"192.486494ms","start":"2026-08-04T15:19:27.032122Z","end":"2026-08-04T15:19:27.224609Z","steps":["trace[474957023] 'process raft request' (duration: 192.213599ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:19:27.224677Z","caller":"traceutil/trace.go:171","msg":"trace[209497937] transaction","detail":"{read_only:false; response_revision:3934; number_of_response:1; }","duration":"193.079307ms","start":"2026-08-04T15:19:27.031556Z","end":"2026-08-04T15:19:27.224635Z","steps":["trace[209497937] 'process raft request' (duration: 192.501995ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:19:27.889001Z","caller":"traceutil/trace.go:171","msg":"trace[824216102] transaction","detail":"{read_only:false; response_revision:3941; number_of_response:1; }","duration":"172.888254ms","start":"2026-08-04T15:19:27.71608Z","end":"2026-08-04T15:19:27.888968Z","steps":["trace[824216102] 'process raft request' (duration: 172.74361ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:20:02.494567Z","caller":"traceutil/trace.go:171","msg":"trace[194365068] linearizableReadLoop","detail":"{readStateIndex:4751; appliedIndex:4750; }","duration":"108.130003ms","start":"2026-08-04T15:20:02.386413Z","end":"2026-08-04T15:20:02.494543Z","steps":["trace[194365068] 'read index received' (duration: 99.885907ms)","trace[194365068] 'applied index is now lower than readState.Index' (duration: 8.242986ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:20:02.494739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.306867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-04T15:20:02.494766Z","caller":"traceutil/trace.go:171","msg":"trace[1948919142] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:4572; }","duration":"108.410119ms","start":"2026-08-04T15:20:02.386347Z","end":"2026-08-04T15:20:02.494757Z","steps":["trace[1948919142] 'agreement among raft nodes before linearized reading' (duration: 108.282676ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:20:02.792106Z","caller":"traceutil/trace.go:171","msg":"trace[674545548] transaction","detail":"{read_only:false; response_revision:4574; number_of_response:1; }","duration":"144.556498ms","start":"2026-08-04T15:20:02.647493Z","end":"2026-08-04T15:20:02.792049Z","steps":["trace[674545548] 'process raft request' (duration: 143.916985ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:20:03.347766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.421636ms","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-08-04T15:20:03.348095Z","caller":"traceutil/trace.go:171","msg":"trace[1802902235] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4577; }","duration":"109.636031ms","start":"2026-08-04T15:20:03.238221Z","end":"2026-08-04T15:20:03.347857Z","steps":["trace[1802902235] 'range keys from in-memory index tree' (duration: 109.123541ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:20:03.74224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.711561ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:20:03.742495Z","caller":"traceutil/trace.go:171","msg":"trace[293474143] transaction","detail":"{read_only:false; response_revision:4582; number_of_response:1; }","duration":"232.099702ms","start":"2026-08-04T15:20:03.510339Z","end":"2026-08-04T15:20:03.742438Z","steps":["trace[293474143] 'process raft request' (duration: 77.025064ms)","trace[293474143] 'compare' (duration: 154.523706ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:20:04.081683Z","caller":"traceutil/trace.go:171","msg":"trace[1595330506] transaction","detail":"{read_only:false; response_revision:4583; number_of_response:1; }","duration":"250.739625ms","start":"2026-08-04T15:20:03.830911Z","end":"2026-08-04T15:20:04.08165Z","steps":["trace[1595330506] 'process raft request' (duration: 208.032215ms)","trace[1595330506] 'compare' (duration: 42.313083ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:20:04.081827Z","caller":"traceutil/trace.go:171","msg":"trace[76426002] linearizableReadLoop","detail":"{readStateIndex:4762; appliedIndex:4761; }","duration":"221.859144ms","start":"2026-08-04T15:20:03.859956Z","end":"2026-08-04T15:20:04.081815Z","steps":["trace[76426002] 'read index received' (duration: 179.00528ms)","trace[76426002] 'applied index is now lower than readState.Index' (duration: 42.852484ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:20:04.081955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.979136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:20:04.081999Z","caller":"traceutil/trace.go:171","msg":"trace[47177127] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:4584; }","duration":"222.085358ms","start":"2026-08-04T15:20:03.8599Z","end":"2026-08-04T15:20:04.081985Z","steps":["trace[47177127] 'agreement among raft nodes before linearized reading' (duration: 221.991396ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:20:04.082552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.794089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:20:04.082612Z","caller":"traceutil/trace.go:171","msg":"trace[1717588461] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:4584; }","duration":"143.884071ms","start":"2026-08-04T15:20:03.938712Z","end":"2026-08-04T15:20:04.082596Z","steps":["trace[1717588461] 'agreement among raft nodes before linearized reading' (duration: 143.784469ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:20:04.082618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.450381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c398b75c-037d-4510-9982-b7de53c55071\" ","response":"range_response_count:1 size:4073"} {"level":"info","ts":"2026-08-04T15:20:04.082723Z","caller":"traceutil/trace.go:171","msg":"trace[1617825039] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c398b75c-037d-4510-9982-b7de53c55071; range_end:; response_count:1; response_revision:4584; }","duration":"194.621214ms","start":"2026-08-04T15:20:03.888069Z","end":"2026-08-04T15:20:04.08269Z","steps":["trace[1617825039] 'agreement among raft nodes before linearized reading' (duration: 194.193616ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:20:06.379874Z","caller":"traceutil/trace.go:171","msg":"trace[131539838] transaction","detail":"{read_only:false; response_revision:4620; number_of_response:1; }","duration":"292.35145ms","start":"2026-08-04T15:20:06.087492Z","end":"2026-08-04T15:20:06.379844Z","steps":["trace[131539838] 'process raft request' (duration: 292.137406ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:20:06.380068Z","caller":"traceutil/trace.go:171","msg":"trace[1636330897] transaction","detail":"{read_only:false; response_revision:4622; number_of_response:1; }","duration":"230.193349ms","start":"2026-08-04T15:20:06.149865Z","end":"2026-08-04T15:20:06.380058Z","steps":["trace[1636330897] 'process raft request' (duration: 229.990015ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:20:06.38005Z","caller":"traceutil/trace.go:171","msg":"trace[570404856] transaction","detail":"{read_only:false; response_revision:4621; number_of_response:1; }","duration":"247.515978ms","start":"2026-08-04T15:20:06.132406Z","end":"2026-08-04T15:20:06.379922Z","steps":["trace[570404856] 'process raft request' (duration: 247.387665ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:20:09.365718Z","caller":"traceutil/trace.go:171","msg":"trace[1793938191] transaction","detail":"{read_only:false; response_revision:4727; number_of_response:1; }","duration":"339.471178ms","start":"2026-08-04T15:20:09.026228Z","end":"2026-08-04T15:20:09.365699Z","steps":["trace[1793938191] 'process raft request' (duration: 339.265373ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:20:09.365857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:20:09.02621Z","time spent":"339.56886ms","remote":"127.0.0.1:51322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7566,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:20:09.37359Z","caller":"traceutil/trace.go:171","msg":"trace[936105893] linearizableReadLoop","detail":"{readStateIndex:4912; appliedIndex:4910; }","duration":"187.345148ms","start":"2026-08-04T15:20:09.186228Z","end":"2026-08-04T15:20:09.373573Z","steps":["trace[936105893] 'read index received' (duration: 179.259295ms)","trace[936105893] 'applied index is now lower than readState.Index' (duration: 8.084573ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:20:09.373684Z","caller":"traceutil/trace.go:171","msg":"trace[1372517898] transaction","detail":"{read_only:false; response_revision:4728; number_of_response:1; }","duration":"230.776719ms","start":"2026-08-04T15:20:09.142896Z","end":"2026-08-04T15:20:09.373673Z","steps":["trace[1372517898] 'process raft request' (duration: 230.577275ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:20:09.373922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.663834ms","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-08-04T15:20:09.374007Z","caller":"traceutil/trace.go:171","msg":"trace[1490407898] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4728; }","duration":"187.762276ms","start":"2026-08-04T15:20:09.186223Z","end":"2026-08-04T15:20:09.373985Z","steps":["trace[1490407898] 'agreement among raft nodes before linearized reading' (duration: 187.499151ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:20:09.374617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.495287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207411"} {"level":"info","ts":"2026-08-04T15:20:09.374679Z","caller":"traceutil/trace.go:171","msg":"trace[844094700] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4728; }","duration":"125.5993ms","start":"2026-08-04T15:20:09.249067Z","end":"2026-08-04T15:20:09.374667Z","steps":["trace[844094700] 'agreement among raft nodes before linearized reading' (duration: 124.63475ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:20:09.84765Z","caller":"traceutil/trace.go:171","msg":"trace[1575237030] transaction","detail":"{read_only:false; response_revision:4735; number_of_response:1; }","duration":"123.083719ms","start":"2026-08-04T15:20:09.724537Z","end":"2026-08-04T15:20:09.847621Z","steps":["trace[1575237030] 'process raft request' (duration: 122.895945ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:20:09.925875Z","caller":"traceutil/trace.go:171","msg":"trace[582516376] linearizableReadLoop","detail":"{readStateIndex:4920; appliedIndex:4918; }","duration":"107.138749ms","start":"2026-08-04T15:20:09.818709Z","end":"2026-08-04T15:20:09.925847Z","steps":["trace[582516376] 'read index received' (duration: 28.697245ms)","trace[582516376] 'applied index is now lower than readState.Index' (duration: 78.440314ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:20:09.925979Z","caller":"traceutil/trace.go:171","msg":"trace[1478942103] transaction","detail":"{read_only:false; response_revision:4736; number_of_response:1; }","duration":"162.772104ms","start":"2026-08-04T15:20:09.763173Z","end":"2026-08-04T15:20:09.925945Z","steps":["trace[1478942103] 'process raft request' (duration: 135.008348ms)","trace[1478942103] 'compare' (duration: 27.501601ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:20:09.926521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.780912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-17b6b306-8044-461f-b2a5-4af83826c96b\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-08-04T15:20:09.926628Z","caller":"traceutil/trace.go:171","msg":"trace[857785785] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-17b6b306-8044-461f-b2a5-4af83826c96b; range_end:; response_count:1; response_revision:4736; }","duration":"107.940755ms","start":"2026-08-04T15:20:09.818658Z","end":"2026-08-04T15:20:09.926599Z","steps":["trace[857785785] 'agreement among raft nodes before linearized reading' (duration: 107.347523ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:20:10.490822Z","caller":"traceutil/trace.go:171","msg":"trace[1676220282] transaction","detail":"{read_only:false; response_revision:4737; number_of_response:1; }","duration":"323.705867ms","start":"2026-08-04T15:20:10.167091Z","end":"2026-08-04T15:20:10.490797Z","steps":["trace[1676220282] 'process raft request' (duration: 323.525934ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:20:10.490971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:20:10.167063Z","time spent":"323.831709ms","remote":"127.0.0.1:59474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:20:10.718979Z","caller":"traceutil/trace.go:171","msg":"trace[1633028500] transaction","detail":"{read_only:false; response_revision:4738; number_of_response:1; }","duration":"325.649486ms","start":"2026-08-04T15:20:10.393298Z","end":"2026-08-04T15:20:10.718947Z","steps":["trace[1633028500] 'process raft request' (duration: 258.502581ms)","trace[1633028500] 'compare' (duration: 66.693826ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:20:10.719136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:20:10.393272Z","time spent":"325.785238ms","remote":"127.0.0.1:59474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:20:10.719172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.170524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-08-04T15:20:10.719238Z","caller":"traceutil/trace.go:171","msg":"trace[1524819850] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4738; }","duration":"266.278006ms","start":"2026-08-04T15:20:10.452945Z","end":"2026-08-04T15:20:10.719223Z","steps":["trace[1524819850] 'agreement among raft nodes before linearized reading' (duration: 266.088042ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:20:10.718997Z","caller":"traceutil/trace.go:171","msg":"trace[1261067808] linearizableReadLoop","detail":"{readStateIndex:4922; appliedIndex:4920; }","duration":"265.808907ms","start":"2026-08-04T15:20:10.45298Z","end":"2026-08-04T15:20:10.718789Z","steps":["trace[1261067808] 'read index received' (duration: 37.626694ms)","trace[1261067808] 'applied index is now lower than readState.Index' (duration: 228.181113ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:20:10.722927Z","caller":"traceutil/trace.go:171","msg":"trace[1037469414] transaction","detail":"{read_only:false; response_revision:4739; number_of_response:1; }","duration":"123.039116ms","start":"2026-08-04T15:20:10.599828Z","end":"2026-08-04T15:20:10.722868Z","steps":["trace[1037469414] 'process raft request' (duration: 122.875452ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:20:10.723012Z","caller":"traceutil/trace.go:171","msg":"trace[346856404] transaction","detail":"{read_only:false; response_revision:4740; number_of_response:1; }","duration":"107.317551ms","start":"2026-08-04T15:20:10.615663Z","end":"2026-08-04T15:20:10.722981Z","steps":["trace[346856404] 'process raft request' (duration: 107.099997ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:20:11.393705Z","caller":"traceutil/trace.go:171","msg":"trace[1434805872] transaction","detail":"{read_only:false; response_revision:4746; number_of_response:1; }","duration":"162.32839ms","start":"2026-08-04T15:20:11.231358Z","end":"2026-08-04T15:20:11.393687Z","steps":["trace[1434805872] 'process raft request' (duration: 162.215498ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:20:13.388681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.508245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-n67rd-tls\" ","response":"range_response_count:1 size:1966"} {"level":"info","ts":"2026-08-04T15:20:13.388768Z","caller":"traceutil/trace.go:171","msg":"trace[1990626866] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-n67rd-tls; range_end:; response_count:1; response_revision:4760; }","duration":"388.632008ms","start":"2026-08-04T15:20:13.000116Z","end":"2026-08-04T15:20:13.388748Z","steps":["trace[1990626866] 'range keys from in-memory index tree' (duration: 388.342592ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:20:13.388808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:20:13.000097Z","time spent":"388.701449ms","remote":"127.0.0.1:40534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":1989,"request content":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-n67rd-tls\" "} {"level":"warn","ts":"2026-08-04T15:20:13.38881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.674941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-n67rd.18c8a34ef321d117\" ","response":"range_response_count:1 size:962"} {"level":"info","ts":"2026-08-04T15:20:13.388851Z","caller":"traceutil/trace.go:171","msg":"trace[1256687089] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-n67rd.18c8a34ef321d117; range_end:; response_count:1; response_revision:4760; }","duration":"243.759102ms","start":"2026-08-04T15:20:13.145077Z","end":"2026-08-04T15:20:13.388836Z","steps":["trace[1256687089] 'range keys from in-memory index tree' (duration: 243.542388ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:20:13.38883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.755972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-n67rd\" ","response":"range_response_count:1 size:9867"} {"level":"warn","ts":"2026-08-04T15:20:13.388874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.636347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-17b6b306-8044-461f-b2a5-4af83826c96b\" ","response":"range_response_count:1 size:3935"} {"level":"info","ts":"2026-08-04T15:20:13.388912Z","caller":"traceutil/trace.go:171","msg":"trace[639012855] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-n67rd; range_end:; response_count:1; response_revision:4760; }","duration":"244.886025ms","start":"2026-08-04T15:20:13.144003Z","end":"2026-08-04T15:20:13.388889Z","steps":["trace[639012855] 'range keys from in-memory index tree' (duration: 244.564078ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:20:13.3887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.781042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:20:13.388962Z","caller":"traceutil/trace.go:171","msg":"trace[547028488] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-17b6b306-8044-461f-b2a5-4af83826c96b; range_end:; response_count:1; response_revision:4760; }","duration":"449.772491ms","start":"2026-08-04T15:20:12.939166Z","end":"2026-08-04T15:20:13.388939Z","steps":["trace[547028488] 'range keys from in-memory index tree' (duration: 449.447094ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:20:13.389001Z","caller":"traceutil/trace.go:171","msg":"trace[762185970] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:4760; }","duration":"287.114458ms","start":"2026-08-04T15:20:13.101858Z","end":"2026-08-04T15:20:13.388973Z","steps":["trace[762185970] 'count revisions from in-memory index tree' (duration: 286.67165ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:20:13.38902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:20:12.939146Z","time spent":"449.860692ms","remote":"127.0.0.1:59412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3958,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-17b6b306-8044-461f-b2a5-4af83826c96b\" "} {"level":"info","ts":"2026-08-04T15:20:17.086817Z","caller":"traceutil/trace.go:171","msg":"trace[1243764117] transaction","detail":"{read_only:false; response_revision:4815; number_of_response:1; }","duration":"243.944672ms","start":"2026-08-04T15:20:16.842803Z","end":"2026-08-04T15:20:17.086748Z","steps":["trace[1243764117] 'process raft request' (duration: 243.801589ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:20:17.086835Z","caller":"traceutil/trace.go:171","msg":"trace[87152090] transaction","detail":"{read_only:false; response_revision:4814; number_of_response:1; }","duration":"244.058614ms","start":"2026-08-04T15:20:16.842691Z","end":"2026-08-04T15:20:17.086749Z","steps":["trace[87152090] 'process raft request' (duration: 237.907021ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:20:17.086979Z","caller":"traceutil/trace.go:171","msg":"trace[1612422170] transaction","detail":"{read_only:false; response_revision:4816; number_of_response:1; }","duration":"243.769158ms","start":"2026-08-04T15:20:16.8432Z","end":"2026-08-04T15:20:17.086969Z","steps":["trace[1612422170] 'process raft request' (duration: 243.477712ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:20:23.416208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.719126ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:20:23.416317Z","caller":"traceutil/trace.go:171","msg":"trace[806889147] transaction","detail":"{read_only:false; response_revision:4872; number_of_response:1; }","duration":"155.044122ms","start":"2026-08-04T15:20:23.261253Z","end":"2026-08-04T15:20:23.416298Z","steps":["trace[806889147] 'process raft request' (duration: 53.155483ms)","trace[806889147] 'compare' (duration: 101.595714ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:20:23.579717Z","caller":"traceutil/trace.go:171","msg":"trace[565736104] transaction","detail":"{read_only:false; response_revision:4873; number_of_response:1; }","duration":"106.171744ms","start":"2026-08-04T15:20:23.473522Z","end":"2026-08-04T15:20:23.579694Z","steps":["trace[565736104] 'process raft request' (duration: 106.048522ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:20:23.632974Z","caller":"traceutil/trace.go:171","msg":"trace[288118904] linearizableReadLoop","detail":"{readStateIndex:5062; appliedIndex:5061; }","duration":"139.691878ms","start":"2026-08-04T15:20:23.493264Z","end":"2026-08-04T15:20:23.632956Z","steps":["trace[288118904] 'read index received' (duration: 86.504194ms)","trace[288118904] 'applied index is now lower than readState.Index' (duration: 53.186864ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:20:23.633292Z","caller":"traceutil/trace.go:171","msg":"trace[1797078807] transaction","detail":"{read_only:false; response_revision:4874; number_of_response:1; }","duration":"157.264377ms","start":"2026-08-04T15:20:23.475987Z","end":"2026-08-04T15:20:23.633251Z","steps":["trace[1797078807] 'process raft request' (duration: 156.868609ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:20:23.633361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.089457ms","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-08-04T15:20:23.633901Z","caller":"traceutil/trace.go:171","msg":"trace[386858290] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4874; }","duration":"140.679098ms","start":"2026-08-04T15:20:23.493215Z","end":"2026-08-04T15:20:23.633894Z","steps":["trace[386858290] 'agreement among raft nodes before linearized reading' (duration: 140.052235ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:20:23.752256Z","caller":"traceutil/trace.go:171","msg":"trace[1930683112] transaction","detail":"{read_only:false; response_revision:4875; number_of_response:1; }","duration":"113.978559ms","start":"2026-08-04T15:20:23.63825Z","end":"2026-08-04T15:20:23.752229Z","steps":["trace[1930683112] 'process raft request' (duration: 43.92176ms)","trace[1930683112] 'compare' (duration: 69.849195ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:20:23.752545Z","caller":"traceutil/trace.go:171","msg":"trace[141833299] transaction","detail":"{read_only:false; response_revision:4876; number_of_response:1; }","duration":"114.05548ms","start":"2026-08-04T15:20:23.638438Z","end":"2026-08-04T15:20:23.752493Z","steps":["trace[141833299] 'process raft request' (duration: 113.740324ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:20:47.966273Z","caller":"traceutil/trace.go:171","msg":"trace[642514052] linearizableReadLoop","detail":"{readStateIndex:5296; appliedIndex:5295; }","duration":"217.814059ms","start":"2026-08-04T15:20:47.748417Z","end":"2026-08-04T15:20:47.966231Z","steps":["trace[642514052] 'read index received' (duration: 217.381551ms)","trace[642514052] 'applied index is now lower than readState.Index' (duration: 429.408µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:20:47.966948Z","caller":"traceutil/trace.go:171","msg":"trace[211373347] transaction","detail":"{read_only:false; response_revision:5101; number_of_response:1; }","duration":"265.318224ms","start":"2026-08-04T15:20:47.701612Z","end":"2026-08-04T15:20:47.96693Z","steps":["trace[211373347] 'process raft request' (duration: 264.349935ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:20:47.967421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.977732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-08-04T15:20:47.967476Z","caller":"traceutil/trace.go:171","msg":"trace[1633892877] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5101; }","duration":"219.095894ms","start":"2026-08-04T15:20:47.748365Z","end":"2026-08-04T15:20:47.967461Z","steps":["trace[1633892877] 'agreement among raft nodes before linearized reading' (duration: 218.834619ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:20:52.29836Z","caller":"traceutil/trace.go:171","msg":"trace[2142195757] transaction","detail":"{read_only:false; response_revision:5213; number_of_response:1; }","duration":"148.799076ms","start":"2026-08-04T15:20:52.149523Z","end":"2026-08-04T15:20:52.298322Z","steps":["trace[2142195757] 'process raft request' (duration: 148.577651ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:20:52.298583Z","caller":"traceutil/trace.go:171","msg":"trace[1858225750] linearizableReadLoop","detail":"{readStateIndex:5408; appliedIndex:5407; }","duration":"291.923661ms","start":"2026-08-04T15:20:52.006612Z","end":"2026-08-04T15:20:52.298536Z","steps":["trace[1858225750] 'read index received' (duration: 289.917322ms)","trace[1858225750] 'applied index is now lower than readState.Index' (duration: 1.955858ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:20:52.298977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.34243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-08-04T15:20:52.299033Z","caller":"traceutil/trace.go:171","msg":"trace[1514089836] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5213; }","duration":"292.491672ms","start":"2026-08-04T15:20:52.006529Z","end":"2026-08-04T15:20:52.299021Z","steps":["trace[1514089836] 'agreement among raft nodes before linearized reading' (duration: 292.249708ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:20:52.298424Z","caller":"traceutil/trace.go:171","msg":"trace[1756521232] transaction","detail":"{read_only:false; response_revision:5212; number_of_response:1; }","duration":"310.009762ms","start":"2026-08-04T15:20:51.988346Z","end":"2026-08-04T15:20:52.298356Z","steps":["trace[1756521232] 'process raft request' (duration: 309.520673ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:20:52.299485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:20:51.988317Z","time spent":"311.097663ms","remote":"127.0.0.1:59474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:20:52.299637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.780277ms","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-08-04T15:20:52.29968Z","caller":"traceutil/trace.go:171","msg":"trace[334288929] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5213; }","duration":"260.861669ms","start":"2026-08-04T15:20:52.038809Z","end":"2026-08-04T15:20:52.29967Z","steps":["trace[334288929] 'agreement among raft nodes before linearized reading' (duration: 260.766607ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:20:52.305081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.266803ms","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-08-04T15:20:52.30514Z","caller":"traceutil/trace.go:171","msg":"trace[2064510503] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5213; }","duration":"265.348356ms","start":"2026-08-04T15:20:52.039779Z","end":"2026-08-04T15:20:52.305128Z","steps":["trace[2064510503] 'agreement among raft nodes before linearized reading' (duration: 259.955211ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:20:52.305338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.397616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-04T15:20:52.305372Z","caller":"traceutil/trace.go:171","msg":"trace[1340682914] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5213; }","duration":"266.469777ms","start":"2026-08-04T15:20:52.038894Z","end":"2026-08-04T15:20:52.305363Z","steps":["trace[1340682914] 'agreement among raft nodes before linearized reading' (duration: 260.863189ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:04.045176Z","caller":"traceutil/trace.go:171","msg":"trace[1875985744] linearizableReadLoop","detail":"{readStateIndex:5489; appliedIndex:5488; }","duration":"146.819437ms","start":"2026-08-04T15:21:03.898329Z","end":"2026-08-04T15:21:04.045149Z","steps":["trace[1875985744] 'read index received' (duration: 146.45937ms)","trace[1875985744] 'applied index is now lower than readState.Index' (duration: 359.097µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:21:04.045286Z","caller":"traceutil/trace.go:171","msg":"trace[1534169705] transaction","detail":"{read_only:false; response_revision:5290; number_of_response:1; }","duration":"186.667095ms","start":"2026-08-04T15:21:03.858567Z","end":"2026-08-04T15:21:04.045234Z","steps":["trace[1534169705] 'process raft request' (duration: 186.345308ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:21:04.045312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.96373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:21:04.045585Z","caller":"traceutil/trace.go:171","msg":"trace[1790413267] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5290; }","duration":"147.276436ms","start":"2026-08-04T15:21:03.898287Z","end":"2026-08-04T15:21:04.045563Z","steps":["trace[1790413267] 'agreement among raft nodes before linearized reading' (duration: 146.96774ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:05.229631Z","caller":"traceutil/trace.go:171","msg":"trace[108297844] transaction","detail":"{read_only:false; response_revision:5300; number_of_response:1; }","duration":"104.117562ms","start":"2026-08-04T15:21:05.125479Z","end":"2026-08-04T15:21:05.229597Z","steps":["trace[108297844] 'process raft request' (duration: 103.806026ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:07.256372Z","caller":"traceutil/trace.go:171","msg":"trace[1210717264] transaction","detail":"{read_only:false; response_revision:5313; number_of_response:1; }","duration":"120.26484ms","start":"2026-08-04T15:21:07.136073Z","end":"2026-08-04T15:21:07.256338Z","steps":["trace[1210717264] 'process raft request' (duration: 119.974485ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:08.401021Z","caller":"traceutil/trace.go:171","msg":"trace[380720065] transaction","detail":"{read_only:false; response_revision:5314; number_of_response:1; }","duration":"132.126266ms","start":"2026-08-04T15:21:08.268847Z","end":"2026-08-04T15:21:08.400974Z","steps":["trace[380720065] 'process raft request' (duration: 131.80375ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:21:08.632069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.060607ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:21:08.632233Z","caller":"traceutil/trace.go:171","msg":"trace[1669033346] transaction","detail":"{read_only:false; response_revision:5315; number_of_response:1; }","duration":"270.700758ms","start":"2026-08-04T15:21:08.361505Z","end":"2026-08-04T15:21:08.632205Z","steps":["trace[1669033346] 'process raft request' (duration: 165.346965ms)","trace[1669033346] 'compare' (duration: 104.846963ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:21:08.639546Z","caller":"traceutil/trace.go:171","msg":"trace[1432523836] linearizableReadLoop","detail":"{readStateIndex:5516; appliedIndex:5514; }","duration":"207.102176ms","start":"2026-08-04T15:21:08.432425Z","end":"2026-08-04T15:21:08.639527Z","steps":["trace[1432523836] 'read index received' (duration: 94.514534ms)","trace[1432523836] 'applied index is now lower than readState.Index' (duration: 112.586212ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:21:08.639673Z","caller":"traceutil/trace.go:171","msg":"trace[1021596580] transaction","detail":"{read_only:false; response_revision:5316; number_of_response:1; }","duration":"226.781925ms","start":"2026-08-04T15:21:08.412812Z","end":"2026-08-04T15:21:08.639594Z","steps":["trace[1021596580] 'process raft request' (duration: 226.583141ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:21:08.639759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.28224ms","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-08-04T15:21:08.639809Z","caller":"traceutil/trace.go:171","msg":"trace[595782633] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5316; }","duration":"207.449353ms","start":"2026-08-04T15:21:08.432343Z","end":"2026-08-04T15:21:08.639792Z","steps":["trace[595782633] 'agreement among raft nodes before linearized reading' (duration: 207.319881ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:21:08.639976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.366513ms","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-08-04T15:21:08.640053Z","caller":"traceutil/trace.go:171","msg":"trace[1932290758] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5316; }","duration":"142.521677ms","start":"2026-08-04T15:21:08.497511Z","end":"2026-08-04T15:21:08.640033Z","steps":["trace[1932290758] 'agreement among raft nodes before linearized reading' (duration: 142.337793ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:21:08.640132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.097473ms","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-08-04T15:21:08.640232Z","caller":"traceutil/trace.go:171","msg":"trace[1405789025] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5316; }","duration":"137.217395ms","start":"2026-08-04T15:21:08.50298Z","end":"2026-08-04T15:21:08.640198Z","steps":["trace[1405789025] 'agreement among raft nodes before linearized reading' (duration: 136.979811ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:21:08.640125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.20553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-08-04T15:21:08.640315Z","caller":"traceutil/trace.go:171","msg":"trace[405607558] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5316; }","duration":"143.466635ms","start":"2026-08-04T15:21:08.49684Z","end":"2026-08-04T15:21:08.640307Z","steps":["trace[405607558] 'agreement among raft nodes before linearized reading' (duration: 143.072368ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:21:08.640396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.094798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-credential-setup\" ","response":"range_response_count:1 size:6260"} {"level":"info","ts":"2026-08-04T15:21:08.6405Z","caller":"traceutil/trace.go:171","msg":"trace[1616793723] range","detail":"{range_begin:/registry/jobs/openstack/keystone-credential-setup; range_end:; response_count:1; response_revision:5316; }","duration":"181.22362ms","start":"2026-08-04T15:21:08.459257Z","end":"2026-08-04T15:21:08.64048Z","steps":["trace[1616793723] 'agreement among raft nodes before linearized reading' (duration: 180.939384ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:21:08.640544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.500506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-08-04T15:21:08.640747Z","caller":"traceutil/trace.go:171","msg":"trace[1966027017] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5316; }","duration":"143.773091ms","start":"2026-08-04T15:21:08.49694Z","end":"2026-08-04T15:21:08.640713Z","steps":["trace[1966027017] 'agreement among raft nodes before linearized reading' (duration: 142.979826ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:21:08.640777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.237149ms","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-08-04T15:21:08.640883Z","caller":"traceutil/trace.go:171","msg":"trace[23350018] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5316; }","duration":"207.379462ms","start":"2026-08-04T15:21:08.433489Z","end":"2026-08-04T15:21:08.640868Z","steps":["trace[23350018] 'agreement among raft nodes before linearized reading' (duration: 206.301781ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:21:08.640864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.917824ms","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-08-04T15:21:08.640979Z","caller":"traceutil/trace.go:171","msg":"trace[1961360595] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5316; }","duration":"143.079608ms","start":"2026-08-04T15:21:08.497882Z","end":"2026-08-04T15:21:08.640961Z","steps":["trace[1961360595] 'agreement among raft nodes before linearized reading' (duration: 142.211331ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:08.777891Z","caller":"traceutil/trace.go:171","msg":"trace[629023528] transaction","detail":"{read_only:false; response_revision:5319; number_of_response:1; }","duration":"130.571867ms","start":"2026-08-04T15:21:08.647305Z","end":"2026-08-04T15:21:08.777876Z","steps":["trace[629023528] 'process raft request' (duration: 130.487165ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:08.777896Z","caller":"traceutil/trace.go:171","msg":"trace[1125564035] transaction","detail":"{read_only:false; response_revision:5318; number_of_response:1; }","duration":"130.646769ms","start":"2026-08-04T15:21:08.647225Z","end":"2026-08-04T15:21:08.777872Z","steps":["trace[1125564035] 'process raft request' (duration: 113.896367ms)","trace[1125564035] 'compare' (duration: 16.554748ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:21:08.778124Z","caller":"traceutil/trace.go:171","msg":"trace[1227796509] transaction","detail":"{read_only:false; response_revision:5320; number_of_response:1; }","duration":"130.622638ms","start":"2026-08-04T15:21:08.647486Z","end":"2026-08-04T15:21:08.778109Z","steps":["trace[1227796509] 'process raft request' (duration: 130.355503ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:08.778408Z","caller":"traceutil/trace.go:171","msg":"trace[689470419] transaction","detail":"{read_only:false; response_revision:5322; number_of_response:1; }","duration":"127.479498ms","start":"2026-08-04T15:21:08.650902Z","end":"2026-08-04T15:21:08.778382Z","steps":["trace[689470419] 'process raft request' (duration: 127.364845ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:08.778458Z","caller":"traceutil/trace.go:171","msg":"trace[62185561] transaction","detail":"{read_only:false; response_revision:5321; number_of_response:1; }","duration":"130.497736ms","start":"2026-08-04T15:21:08.647947Z","end":"2026-08-04T15:21:08.778444Z","steps":["trace[62185561] 'process raft request' (duration: 130.036487ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:11.261962Z","caller":"traceutil/trace.go:171","msg":"trace[43649358] transaction","detail":"{read_only:false; response_revision:5353; number_of_response:1; }","duration":"143.574882ms","start":"2026-08-04T15:21:11.118363Z","end":"2026-08-04T15:21:11.261937Z","steps":["trace[43649358] 'process raft request' (duration: 104.82595ms)","trace[43649358] 'compare' (duration: 38.65252ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:21:19.365564Z","caller":"traceutil/trace.go:171","msg":"trace[1787018862] transaction","detail":"{read_only:false; response_revision:5397; number_of_response:1; }","duration":"150.843839ms","start":"2026-08-04T15:21:19.214693Z","end":"2026-08-04T15:21:19.365537Z","steps":["trace[1787018862] 'process raft request' (duration: 150.37527ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:19.375641Z","caller":"traceutil/trace.go:171","msg":"trace[1021096810] transaction","detail":"{read_only:false; response_revision:5398; number_of_response:1; }","duration":"152.090432ms","start":"2026-08-04T15:21:19.223529Z","end":"2026-08-04T15:21:19.375619Z","steps":["trace[1021096810] 'process raft request' (duration: 151.347788ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:19.375966Z","caller":"traceutil/trace.go:171","msg":"trace[661438397] transaction","detail":"{read_only:false; response_revision:5399; number_of_response:1; }","duration":"135.964975ms","start":"2026-08-04T15:21:19.239911Z","end":"2026-08-04T15:21:19.375876Z","steps":["trace[661438397] 'process raft request' (duration: 135.124979ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:21:21.640092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.052403ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:21:21.640231Z","caller":"traceutil/trace.go:171","msg":"trace[60649307] linearizableReadLoop","detail":"{readStateIndex:5616; appliedIndex:5614; }","duration":"218.002335ms","start":"2026-08-04T15:21:21.42221Z","end":"2026-08-04T15:21:21.640212Z","steps":["trace[60649307] 'read index received' (duration: 42.578551ms)","trace[60649307] 'applied index is now lower than readState.Index' (duration: 175.421594ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:21:21.640315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.092337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-04T15:21:21.640363Z","caller":"traceutil/trace.go:171","msg":"trace[1093660796] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5413; }","duration":"218.181899ms","start":"2026-08-04T15:21:21.422166Z","end":"2026-08-04T15:21:21.640348Z","steps":["trace[1093660796] 'agreement among raft nodes before linearized reading' (duration: 218.098967ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:21.640378Z","caller":"traceutil/trace.go:171","msg":"trace[1333075065] transaction","detail":"{read_only:false; response_revision:5413; number_of_response:1; }","duration":"252.538043ms","start":"2026-08-04T15:21:21.387802Z","end":"2026-08-04T15:21:21.64034Z","steps":["trace[1333075065] 'process raft request' (duration: 137.147844ms)","trace[1333075065] 'compare' (duration: 114.92247ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:21:34.284567Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2859} {"level":"warn","ts":"2026-08-04T15:21:34.285528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.289517ms","expected-duration":"100ms","prefix":"","request":"header: compaction: ","response":"size:5"} {"level":"info","ts":"2026-08-04T15:21:34.285682Z","caller":"traceutil/trace.go:171","msg":"trace[1825582076] compact","detail":"{revision:2859; response_revision:5520; }","duration":"116.211911ms","start":"2026-08-04T15:21:34.169451Z","end":"2026-08-04T15:21:34.285663Z","steps":["trace[1825582076] 'check and update compact revision' (duration: 101.099484ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:21:34.815984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.360339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:1 size:6092"} {"level":"warn","ts":"2026-08-04T15:21:34.815987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.876609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:1 size:8314"} {"level":"info","ts":"2026-08-04T15:21:34.816065Z","caller":"traceutil/trace.go:171","msg":"trace[710558438] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:1; response_revision:5520; }","duration":"110.615225ms","start":"2026-08-04T15:21:34.70543Z","end":"2026-08-04T15:21:34.816045Z","steps":["trace[710558438] 'range keys from in-memory index tree' (duration: 110.264368ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:34.816127Z","caller":"traceutil/trace.go:171","msg":"trace[533141567] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:1; response_revision:5520; }","duration":"111.079023ms","start":"2026-08-04T15:21:34.705019Z","end":"2026-08-04T15:21:34.816098Z","steps":["trace[533141567] 'range keys from in-memory index tree' (duration: 110.633365ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:21:34.901971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.693059ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:21:34.902127Z","caller":"traceutil/trace.go:171","msg":"trace[500521853] transaction","detail":"{read_only:false; response_revision:5521; number_of_response:1; }","duration":"164.157198ms","start":"2026-08-04T15:21:34.737942Z","end":"2026-08-04T15:21:34.9021Z","steps":["trace[500521853] 'compare' (duration: 68.554738ms)","trace[500521853] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/openstack/08db1feb.percona.com; req_size:506; } (duration: 85.949518ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:21:34.928713Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2859,"took":"641.038226ms","hash":4168309460,"current-db-size-bytes":54779904,"current-db-size":"55 MB","current-db-size-in-use-bytes":29204480,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-04T15:21:34.928787Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4168309460,"revision":2859,"compact-revision":-1} {"level":"info","ts":"2026-08-04T15:21:35.064625Z","caller":"traceutil/trace.go:171","msg":"trace[951880693] transaction","detail":"{read_only:false; response_revision:5523; number_of_response:1; }","duration":"103.887376ms","start":"2026-08-04T15:21:34.960694Z","end":"2026-08-04T15:21:35.064581Z","steps":["trace[951880693] 'process raft request' (duration: 44.681736ms)","trace[951880693] 'compare' (duration: 58.924064ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:21:35.064681Z","caller":"traceutil/trace.go:171","msg":"trace[1357335997] transaction","detail":"{read_only:false; response_revision:5524; number_of_response:1; }","duration":"103.028119ms","start":"2026-08-04T15:21:34.961599Z","end":"2026-08-04T15:21:35.064627Z","steps":["trace[1357335997] 'process raft request' (duration: 102.898137ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:41.002057Z","caller":"traceutil/trace.go:171","msg":"trace[1432323799] transaction","detail":"{read_only:false; response_revision:5561; number_of_response:1; }","duration":"129.698499ms","start":"2026-08-04T15:21:40.872324Z","end":"2026-08-04T15:21:41.002023Z","steps":["trace[1432323799] 'process raft request' (duration: 129.353242ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:45.175905Z","caller":"traceutil/trace.go:171","msg":"trace[2050833923] transaction","detail":"{read_only:false; response_revision:5583; number_of_response:1; }","duration":"158.505206ms","start":"2026-08-04T15:21:45.017367Z","end":"2026-08-04T15:21:45.175872Z","steps":["trace[2050833923] 'process raft request' (duration: 158.239771ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:22:01.334309Z","caller":"traceutil/trace.go:171","msg":"trace[824568478] transaction","detail":"{read_only:false; response_revision:5715; number_of_response:1; }","duration":"104.519685ms","start":"2026-08-04T15:22:01.22974Z","end":"2026-08-04T15:22:01.33426Z","steps":["trace[824568478] 'process raft request' (duration: 104.26494ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:23:48.2528Z","caller":"traceutil/trace.go:171","msg":"trace[422426149] transaction","detail":"{read_only:false; response_revision:6435; number_of_response:1; }","duration":"122.798614ms","start":"2026-08-04T15:23:48.129973Z","end":"2026-08-04T15:23:48.252772Z","steps":["trace[422426149] 'process raft request' (duration: 68.198349ms)","trace[422426149] 'compare' (duration: 54.371784ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:23:48.253035Z","caller":"traceutil/trace.go:171","msg":"trace[658675481] transaction","detail":"{read_only:false; response_revision:6436; number_of_response:1; }","duration":"122.583944ms","start":"2026-08-04T15:23:48.130424Z","end":"2026-08-04T15:23:48.253008Z","steps":["trace[658675481] 'process raft request' (duration: 122.300621ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:23:48.488936Z","caller":"traceutil/trace.go:171","msg":"trace[833335887] transaction","detail":"{read_only:false; response_revision:6439; number_of_response:1; }","duration":"190.230656ms","start":"2026-08-04T15:23:48.298678Z","end":"2026-08-04T15:23:48.488909Z","steps":["trace[833335887] 'process raft request' (duration: 144.780578ms)","trace[833335887] 'compare' (duration: 44.84675ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:23:48.489257Z","caller":"traceutil/trace.go:171","msg":"trace[31062597] transaction","detail":"{read_only:false; response_revision:6440; number_of_response:1; }","duration":"184.328082ms","start":"2026-08-04T15:23:48.304885Z","end":"2026-08-04T15:23:48.489213Z","steps":["trace[31062597] 'process raft request' (duration: 183.955074ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:23:57.065372Z","caller":"traceutil/trace.go:171","msg":"trace[447533917] linearizableReadLoop","detail":"{readStateIndex:6744; appliedIndex:6743; }","duration":"169.00842ms","start":"2026-08-04T15:23:56.896342Z","end":"2026-08-04T15:23:57.065351Z","steps":["trace[447533917] 'read index received' (duration: 168.873914ms)","trace[447533917] 'applied index is now lower than readState.Index' (duration: 133.516µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:23:57.065455Z","caller":"traceutil/trace.go:171","msg":"trace[1723150108] transaction","detail":"{read_only:false; response_revision:6505; number_of_response:1; }","duration":"318.389627ms","start":"2026-08-04T15:23:56.747018Z","end":"2026-08-04T15:23:57.065407Z","steps":["trace[1723150108] 'process raft request' (duration: 318.153006ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:23:57.065559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.197978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:23:57.065599Z","caller":"traceutil/trace.go:171","msg":"trace[1083085342] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6505; }","duration":"169.280283ms","start":"2026-08-04T15:23:56.896304Z","end":"2026-08-04T15:23:57.065584Z","steps":["trace[1083085342] 'agreement among raft nodes before linearized reading' (duration: 169.188919ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:23:57.065637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:23:56.746994Z","time spent":"318.548054ms","remote":"127.0.0.1:59474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:23:57.26816Z","caller":"traceutil/trace.go:171","msg":"trace[1436152301] transaction","detail":"{read_only:false; response_revision:6506; number_of_response:1; }","duration":"135.686716ms","start":"2026-08-04T15:23:57.1324Z","end":"2026-08-04T15:23:57.268086Z","steps":["trace[1436152301] 'process raft request' (duration: 37.275244ms)","trace[1436152301] 'compare' (duration: 98.292276ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:24:08.027561Z","caller":"traceutil/trace.go:171","msg":"trace[372834343] transaction","detail":"{read_only:false; response_revision:6561; number_of_response:1; }","duration":"101.474794ms","start":"2026-08-04T15:24:07.926062Z","end":"2026-08-04T15:24:08.027536Z","steps":["trace[372834343] 'process raft request' (duration: 101.331208ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:24:08.2364Z","caller":"traceutil/trace.go:171","msg":"trace[871110249] linearizableReadLoop","detail":"{readStateIndex:6805; appliedIndex:6804; }","duration":"116.047168ms","start":"2026-08-04T15:24:08.120318Z","end":"2026-08-04T15:24:08.236366Z","steps":["trace[871110249] 'read index received' (duration: 115.723653ms)","trace[871110249] 'applied index is now lower than readState.Index' (duration: 322.215µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:24:08.23714Z","caller":"traceutil/trace.go:171","msg":"trace[743231070] transaction","detail":"{read_only:false; response_revision:6562; number_of_response:1; }","duration":"134.604179ms","start":"2026-08-04T15:24:08.102491Z","end":"2026-08-04T15:24:08.237095Z","steps":["trace[743231070] 'process raft request' (duration: 133.655616ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:24:08.237158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.805492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:24:08.237348Z","caller":"traceutil/trace.go:171","msg":"trace[2012166732] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:6562; }","duration":"117.060574ms","start":"2026-08-04T15:24:08.120263Z","end":"2026-08-04T15:24:08.237324Z","steps":["trace[2012166732] 'agreement among raft nodes before linearized reading' (duration: 116.693437ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:24:08.551546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.596766ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:24:08.552445Z","caller":"traceutil/trace.go:171","msg":"trace[812375804] transaction","detail":"{read_only:false; response_revision:6565; number_of_response:1; }","duration":"197.664318ms","start":"2026-08-04T15:24:08.354754Z","end":"2026-08-04T15:24:08.552418Z","steps":["trace[812375804] 'process raft request' (duration: 197.552793ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:24:08.553019Z","caller":"traceutil/trace.go:171","msg":"trace[988959914] transaction","detail":"{read_only:false; response_revision:6564; number_of_response:1; }","duration":"307.373203ms","start":"2026-08-04T15:24:08.245626Z","end":"2026-08-04T15:24:08.552999Z","steps":["trace[988959914] 'process raft request' (duration: 95.231128ms)","trace[988959914] 'compare' (duration: 210.297462ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:24:08.553161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:24:08.245604Z","time spent":"307.461997ms","remote":"127.0.0.1:59474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:24:08.571879Z","caller":"traceutil/trace.go:171","msg":"trace[1430970538] linearizableReadLoop","detail":"{readStateIndex:6809; appliedIndex:6806; }","duration":"161.919329ms","start":"2026-08-04T15:24:08.409944Z","end":"2026-08-04T15:24:08.571863Z","steps":["trace[1430970538] 'read index received' (duration: 74.739741ms)","trace[1430970538] 'applied index is now lower than readState.Index' (duration: 87.177368ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:24:08.571933Z","caller":"traceutil/trace.go:171","msg":"trace[1622042947] transaction","detail":"{read_only:false; response_revision:6566; number_of_response:1; }","duration":"207.939167ms","start":"2026-08-04T15:24:08.363969Z","end":"2026-08-04T15:24:08.571908Z","steps":["trace[1622042947] 'process raft request' (duration: 207.79032ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:24:08.572064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.115258ms","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-08-04T15:24:08.572092Z","caller":"traceutil/trace.go:171","msg":"trace[632640509] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6566; }","duration":"162.195192ms","start":"2026-08-04T15:24:08.40989Z","end":"2026-08-04T15:24:08.572085Z","steps":["trace[632640509] 'agreement among raft nodes before linearized reading' (duration: 162.073227ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:24:08.572257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.552028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-08-04T15:24:08.57232Z","caller":"traceutil/trace.go:171","msg":"trace[1035715295] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6566; }","duration":"111.670873ms","start":"2026-08-04T15:24:08.460636Z","end":"2026-08-04T15:24:08.572307Z","steps":["trace[1035715295] 'agreement among raft nodes before linearized reading' (duration: 111.441883ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:24:08.572621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.194872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-04T15:24:08.572665Z","caller":"traceutil/trace.go:171","msg":"trace[951233404] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:6566; }","duration":"145.289786ms","start":"2026-08-04T15:24:08.427364Z","end":"2026-08-04T15:24:08.572654Z","steps":["trace[951233404] 'agreement among raft nodes before linearized reading' (duration: 144.68974ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:24:08.779778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.277448ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:24:08.779979Z","caller":"traceutil/trace.go:171","msg":"trace[1693514048] linearizableReadLoop","detail":"{readStateIndex:6811; appliedIndex:6809; }","duration":"152.298049ms","start":"2026-08-04T15:24:08.627639Z","end":"2026-08-04T15:24:08.779937Z","steps":["trace[1693514048] 'read index received' (duration: 31.722368ms)","trace[1693514048] 'applied index is now lower than readState.Index' (duration: 120.574691ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:24:08.7802Z","caller":"traceutil/trace.go:171","msg":"trace[1104832863] transaction","detail":"{read_only:false; response_revision:6567; number_of_response:1; }","duration":"204.575346ms","start":"2026-08-04T15:24:08.575612Z","end":"2026-08-04T15:24:08.780188Z","steps":["trace[1104832863] 'process raft request' (duration: 83.804737ms)","trace[1104832863] 'compare' (duration: 120.169452ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:24:08.780381Z","caller":"traceutil/trace.go:171","msg":"trace[498396351] transaction","detail":"{read_only:false; response_revision:6568; number_of_response:1; }","duration":"202.748825ms","start":"2026-08-04T15:24:08.577623Z","end":"2026-08-04T15:24:08.780372Z","steps":["trace[498396351] 'process raft request' (duration: 202.261793ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:24:08.780586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.954739ms","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-08-04T15:24:08.780626Z","caller":"traceutil/trace.go:171","msg":"trace[65071361] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6568; }","duration":"153.046612ms","start":"2026-08-04T15:24:08.627569Z","end":"2026-08-04T15:24:08.780615Z","steps":["trace[65071361] 'agreement among raft nodes before linearized reading' (duration: 152.920917ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:24:10.274124Z","caller":"traceutil/trace.go:171","msg":"trace[1183142950] linearizableReadLoop","detail":"{readStateIndex:6813; appliedIndex:6812; }","duration":"147.069819ms","start":"2026-08-04T15:24:10.127035Z","end":"2026-08-04T15:24:10.274105Z","steps":["trace[1183142950] 'read index received' (duration: 146.938144ms)","trace[1183142950] 'applied index is now lower than readState.Index' (duration: 130.875µs)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:24:10.274301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.246357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-08-04T15:24:10.274332Z","caller":"traceutil/trace.go:171","msg":"trace[1098790815] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6570; }","duration":"147.330221ms","start":"2026-08-04T15:24:10.126991Z","end":"2026-08-04T15:24:10.274322Z","steps":["trace[1098790815] 'agreement among raft nodes before linearized reading' (duration: 147.192195ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:24:10.274296Z","caller":"traceutil/trace.go:171","msg":"trace[837845767] transaction","detail":"{read_only:false; response_revision:6570; number_of_response:1; }","duration":"241.588907ms","start":"2026-08-04T15:24:10.03256Z","end":"2026-08-04T15:24:10.274149Z","steps":["trace[837845767] 'process raft request' (duration: 241.41897ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:24:30.911824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.910245ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:24:30.911911Z","caller":"traceutil/trace.go:171","msg":"trace[703004427] linearizableReadLoop","detail":"{readStateIndex:6982; appliedIndex:6981; }","duration":"186.365434ms","start":"2026-08-04T15:24:30.725533Z","end":"2026-08-04T15:24:30.911899Z","steps":["trace[703004427] 'read index received' (duration: 79.292643ms)","trace[703004427] 'applied index is now lower than readState.Index' (duration: 107.071861ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:24:30.911976Z","caller":"traceutil/trace.go:171","msg":"trace[441543368] transaction","detail":"{read_only:false; response_revision:6732; number_of_response:1; }","duration":"195.873521ms","start":"2026-08-04T15:24:30.716095Z","end":"2026-08-04T15:24:30.911969Z","steps":["trace[441543368] 'process raft request' (duration: 88.753517ms)","trace[441543368] 'compare' (duration: 106.79991ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:24:30.912127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.57266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:24:30.912204Z","caller":"traceutil/trace.go:171","msg":"trace[233041485] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:6732; }","duration":"156.688024ms","start":"2026-08-04T15:24:30.755501Z","end":"2026-08-04T15:24:30.912189Z","steps":["trace[233041485] 'agreement among raft nodes before linearized reading' (duration: 156.570559ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:24:30.912471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.936398ms","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-08-04T15:24:30.912504Z","caller":"traceutil/trace.go:171","msg":"trace[558662142] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6732; }","duration":"187.016981ms","start":"2026-08-04T15:24:30.725479Z","end":"2026-08-04T15:24:30.912496Z","steps":["trace[558662142] 'agreement among raft nodes before linearized reading' (duration: 186.914577ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:24:31.444637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.788692ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:24:31.444771Z","caller":"traceutil/trace.go:171","msg":"trace[1819084311] transaction","detail":"{read_only:false; response_revision:6733; number_of_response:1; }","duration":"527.348667ms","start":"2026-08-04T15:24:30.917385Z","end":"2026-08-04T15:24:31.444734Z","steps":["trace[1819084311] 'process raft request' (duration: 112.244271ms)","trace[1819084311] 'compare' (duration: 414.543672ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:24:31.444821Z","caller":"traceutil/trace.go:171","msg":"trace[396720957] linearizableReadLoop","detail":"{readStateIndex:6983; appliedIndex:6982; }","duration":"526.24826ms","start":"2026-08-04T15:24:30.918553Z","end":"2026-08-04T15:24:31.444802Z","steps":["trace[396720957] 'read index received' (duration: 111.070701ms)","trace[396720957] 'applied index is now lower than readState.Index' (duration: 415.176689ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:24:31.444908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:24:30.917362Z","time spent":"527.468542ms","remote":"127.0.0.1:59474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:24:31.444975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.417787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-08-04T15:24:31.444997Z","caller":"traceutil/trace.go:171","msg":"trace[438875469] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6733; }","duration":"526.456019ms","start":"2026-08-04T15:24:30.918534Z","end":"2026-08-04T15:24:31.44499Z","steps":["trace[438875469] 'agreement among raft nodes before linearized reading' (duration: 526.348674ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:24:31.445019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:24:30.918525Z","time spent":"526.48922ms","remote":"127.0.0.1:59412","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":"info","ts":"2026-08-04T15:24:31.445505Z","caller":"traceutil/trace.go:171","msg":"trace[1417792581] transaction","detail":"{read_only:false; response_revision:6734; number_of_response:1; }","duration":"525.339781ms","start":"2026-08-04T15:24:30.92014Z","end":"2026-08-04T15:24:31.445361Z","steps":["trace[1417792581] 'process raft request' (duration: 524.6067ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:24:31.445689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:24:30.920129Z","time spent":"525.485957ms","remote":"127.0.0.1:59474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:24:31.446757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.875399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-08-04T15:24:31.446791Z","caller":"traceutil/trace.go:171","msg":"trace[52571949] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6734; }","duration":"527.928181ms","start":"2026-08-04T15:24:30.918852Z","end":"2026-08-04T15:24:31.446781Z","steps":["trace[52571949] 'agreement among raft nodes before linearized reading' (duration: 526.423737ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:24:31.446814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:24:30.918847Z","time spent":"527.962113ms","remote":"127.0.0.1:59474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-04T15:24:31.446954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.105854ms","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-08-04T15:24:31.447845Z","caller":"traceutil/trace.go:171","msg":"trace[914855555] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6734; }","duration":"526.192807ms","start":"2026-08-04T15:24:30.92081Z","end":"2026-08-04T15:24:31.447003Z","steps":["trace[914855555] 'agreement among raft nodes before linearized reading' (duration: 524.494504ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:24:31.448221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:24:30.920805Z","time spent":"527.403278ms","remote":"127.0.0.1:59474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-04T15:24:31.448489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.195179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-04T15:24:31.448538Z","caller":"traceutil/trace.go:171","msg":"trace[99582124] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:6734; }","duration":"322.277892ms","start":"2026-08-04T15:24:31.126248Z","end":"2026-08-04T15:24:31.448526Z","steps":["trace[99582124] 'agreement among raft nodes before linearized reading' (duration: 319.059754ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:24:31.448565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:24:31.126233Z","time spent":"322.324354ms","remote":"127.0.0.1:51336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":6,"response size":30,"request content":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true "} {"level":"info","ts":"2026-08-04T15:24:31.638507Z","caller":"traceutil/trace.go:171","msg":"trace[2136123486] transaction","detail":"{read_only:false; response_revision:6735; number_of_response:1; }","duration":"185.211609ms","start":"2026-08-04T15:24:31.453275Z","end":"2026-08-04T15:24:31.638487Z","steps":["trace[2136123486] 'process raft request' (duration: 131.566128ms)","trace[2136123486] 'compare' (duration: 53.406721ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:24:31.638703Z","caller":"traceutil/trace.go:171","msg":"trace[1159457881] linearizableReadLoop","detail":"{readStateIndex:6986; appliedIndex:6984; }","duration":"180.920716ms","start":"2026-08-04T15:24:31.457763Z","end":"2026-08-04T15:24:31.638684Z","steps":["trace[1159457881] 'read index received' (duration: 127.068696ms)","trace[1159457881] 'applied index is now lower than readState.Index' (duration: 53.85133ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:24:31.638846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.066642ms","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-08-04T15:24:31.638868Z","caller":"traceutil/trace.go:171","msg":"trace[1282041034] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:6736; }","duration":"181.113014ms","start":"2026-08-04T15:24:31.457744Z","end":"2026-08-04T15:24:31.638857Z","steps":["trace[1282041034] 'agreement among raft nodes before linearized reading' (duration: 180.999089ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:24:31.638907Z","caller":"traceutil/trace.go:171","msg":"trace[1240534544] transaction","detail":"{read_only:false; response_revision:6736; number_of_response:1; }","duration":"185.446549ms","start":"2026-08-04T15:24:31.453454Z","end":"2026-08-04T15:24:31.638901Z","steps":["trace[1240534544] 'process raft request' (duration: 185.00178ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:24:34.570218Z","caller":"traceutil/trace.go:171","msg":"trace[664681372] transaction","detail":"{read_only:false; response_revision:6750; number_of_response:1; }","duration":"153.82262ms","start":"2026-08-04T15:24:34.416362Z","end":"2026-08-04T15:24:34.570185Z","steps":["trace[664681372] 'process raft request' (duration: 153.650653ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:24:34.592369Z","caller":"traceutil/trace.go:171","msg":"trace[1933454882] transaction","detail":"{read_only:false; response_revision:6751; number_of_response:1; }","duration":"169.691764ms","start":"2026-08-04T15:24:34.422653Z","end":"2026-08-04T15:24:34.592345Z","steps":["trace[1933454882] 'process raft request' (duration: 169.411902ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:24:34.967643Z","caller":"traceutil/trace.go:171","msg":"trace[628674889] linearizableReadLoop","detail":"{readStateIndex:7004; appliedIndex:7003; }","duration":"176.378908ms","start":"2026-08-04T15:24:34.791239Z","end":"2026-08-04T15:24:34.967618Z","steps":["trace[628674889] 'read index received' (duration: 176.336736ms)","trace[628674889] 'applied index is now lower than readState.Index' (duration: 40.622µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:24:34.967739Z","caller":"traceutil/trace.go:171","msg":"trace[1042996775] transaction","detail":"{read_only:false; response_revision:6753; number_of_response:1; }","duration":"247.836611ms","start":"2026-08-04T15:24:34.719859Z","end":"2026-08-04T15:24:34.967696Z","steps":["trace[1042996775] 'process raft request' (duration: 247.608822ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:24:34.967919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.654829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/rabbitmqclusters.rabbitmq.com\" ","response":"range_response_count:1 size:120324"} {"level":"info","ts":"2026-08-04T15:24:34.967966Z","caller":"traceutil/trace.go:171","msg":"trace[1169413122] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/rabbitmqclusters.rabbitmq.com; range_end:; response_count:1; response_revision:6753; }","duration":"176.760084ms","start":"2026-08-04T15:24:34.791193Z","end":"2026-08-04T15:24:34.967953Z","steps":["trace[1169413122] 'agreement among raft nodes before linearized reading' (duration: 176.548925ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:24:35.038295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.187136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:24:35.03832Z","caller":"traceutil/trace.go:171","msg":"trace[197955867] transaction","detail":"{read_only:false; response_revision:6754; number_of_response:1; }","duration":"112.686361ms","start":"2026-08-04T15:24:34.925598Z","end":"2026-08-04T15:24:35.038284Z","steps":["trace[197955867] 'process raft request' (duration: 101.08663ms)","trace[197955867] 'compare' (duration: 11.3329ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:24:35.038467Z","caller":"traceutil/trace.go:171","msg":"trace[1415660067] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6754; }","duration":"139.367144ms","start":"2026-08-04T15:24:34.899026Z","end":"2026-08-04T15:24:35.038393Z","steps":["trace[1415660067] 'agreement among raft nodes before linearized reading' (duration: 139.159915ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:24:35.195515Z","caller":"traceutil/trace.go:171","msg":"trace[786007929] transaction","detail":"{read_only:false; response_revision:6755; number_of_response:1; }","duration":"119.317195ms","start":"2026-08-04T15:24:35.076157Z","end":"2026-08-04T15:24:35.195474Z","steps":["trace[786007929] 'process raft request' (duration: 75.457227ms)","trace[786007929] 'compare' (duration: 43.719482ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:24:35.572697Z","caller":"traceutil/trace.go:171","msg":"trace[1369808622] transaction","detail":"{read_only:false; response_revision:6756; number_of_response:1; }","duration":"106.90398ms","start":"2026-08-04T15:24:35.465768Z","end":"2026-08-04T15:24:35.572672Z","steps":["trace[1369808622] 'process raft request' (duration: 106.714192ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:24:35.671491Z","caller":"traceutil/trace.go:171","msg":"trace[1432765038] transaction","detail":"{read_only:false; response_revision:6757; number_of_response:1; }","duration":"204.262364ms","start":"2026-08-04T15:24:35.467178Z","end":"2026-08-04T15:24:35.67144Z","steps":["trace[1432765038] 'process raft request' (duration: 185.306051ms)","trace[1432765038] 'compare' (duration: 18.142759ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:24:45.908287Z","caller":"traceutil/trace.go:171","msg":"trace[1740239830] transaction","detail":"{read_only:false; response_revision:6808; number_of_response:1; }","duration":"100.57449ms","start":"2026-08-04T15:24:45.807692Z","end":"2026-08-04T15:24:45.908267Z","steps":["trace[1740239830] 'process raft request' (duration: 100.467985ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:24:45.946314Z","caller":"traceutil/trace.go:171","msg":"trace[1145971557] transaction","detail":"{read_only:false; response_revision:6809; number_of_response:1; }","duration":"136.729133ms","start":"2026-08-04T15:24:45.809572Z","end":"2026-08-04T15:24:45.946301Z","steps":["trace[1145971557] 'process raft request' (duration: 136.493513ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:24:45.94659Z","caller":"traceutil/trace.go:171","msg":"trace[1298782368] transaction","detail":"{read_only:false; response_revision:6810; number_of_response:1; }","duration":"136.532885ms","start":"2026-08-04T15:24:45.809982Z","end":"2026-08-04T15:24:45.946515Z","steps":["trace[1298782368] 'process raft request' (duration: 136.162869ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:24:58.175515Z","caller":"traceutil/trace.go:171","msg":"trace[2006078182] transaction","detail":"{read_only:false; response_revision:6874; number_of_response:1; }","duration":"157.77433ms","start":"2026-08-04T15:24:58.017713Z","end":"2026-08-04T15:24:58.175487Z","steps":["trace[2006078182] 'process raft request' (duration: 140.138855ms)","trace[2006078182] 'compare' (duration: 17.49885ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:24:58.175779Z","caller":"traceutil/trace.go:171","msg":"trace[631421599] linearizableReadLoop","detail":"{readStateIndex:7131; appliedIndex:7129; }","duration":"110.611306ms","start":"2026-08-04T15:24:58.065149Z","end":"2026-08-04T15:24:58.175761Z","steps":["trace[631421599] 'read index received' (duration: 92.7146ms)","trace[631421599] 'applied index is now lower than readState.Index' (duration: 17.896026ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:24:58.175922Z","caller":"traceutil/trace.go:171","msg":"trace[989541962] transaction","detail":"{read_only:false; response_revision:6875; number_of_response:1; }","duration":"157.424756ms","start":"2026-08-04T15:24:58.018477Z","end":"2026-08-04T15:24:58.175902Z","steps":["trace[989541962] 'process raft request' (duration: 157.173656ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:24:58.175944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.771454ms","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-08-04T15:24:58.176123Z","caller":"traceutil/trace.go:171","msg":"trace[1491821423] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6875; }","duration":"111.005122ms","start":"2026-08-04T15:24:58.065104Z","end":"2026-08-04T15:24:58.176109Z","steps":["trace[1491821423] 'agreement among raft nodes before linearized reading' (duration: 110.733431ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:25:00.99755Z","caller":"traceutil/trace.go:171","msg":"trace[304035892] linearizableReadLoop","detail":"{readStateIndex:7145; appliedIndex:7143; }","duration":"216.080372ms","start":"2026-08-04T15:25:00.781443Z","end":"2026-08-04T15:25:00.997523Z","steps":["trace[304035892] 'read index received' (duration: 18.231036ms)","trace[304035892] 'applied index is now lower than readState.Index' (duration: 197.848146ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:25:00.997749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.293271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-08-04T15:25:00.997796Z","caller":"traceutil/trace.go:171","msg":"trace[1765605432] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6889; }","duration":"216.403715ms","start":"2026-08-04T15:25:00.781373Z","end":"2026-08-04T15:25:00.997777Z","steps":["trace[1765605432] 'agreement among raft nodes before linearized reading' (duration: 216.245579ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:25:00.997601Z","caller":"traceutil/trace.go:171","msg":"trace[2046842414] transaction","detail":"{read_only:false; response_revision:6889; number_of_response:1; }","duration":"241.113984ms","start":"2026-08-04T15:25:00.756463Z","end":"2026-08-04T15:25:00.997577Z","steps":["trace[2046842414] 'process raft request' (duration: 240.75206ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:25:37.537686Z","caller":"traceutil/trace.go:171","msg":"trace[2092794839] linearizableReadLoop","detail":"{readStateIndex:7357; appliedIndex:7355; }","duration":"179.606257ms","start":"2026-08-04T15:25:37.358057Z","end":"2026-08-04T15:25:37.537663Z","steps":["trace[2092794839] 'read index received' (duration: 22.795802ms)","trace[2092794839] 'applied index is now lower than readState.Index' (duration: 156.809685ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:25:37.537809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.729442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:25:37.537833Z","caller":"traceutil/trace.go:171","msg":"trace[1575062287] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:7093; }","duration":"179.815695ms","start":"2026-08-04T15:25:37.35801Z","end":"2026-08-04T15:25:37.537825Z","steps":["trace[1575062287] 'agreement among raft nodes before linearized reading' (duration: 179.746903ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:25:37.537899Z","caller":"traceutil/trace.go:171","msg":"trace[731958995] transaction","detail":"{read_only:false; response_revision:7093; number_of_response:1; }","duration":"197.835848ms","start":"2026-08-04T15:25:37.340033Z","end":"2026-08-04T15:25:37.537869Z","steps":["trace[731958995] 'process raft request' (duration: 151.232524ms)","trace[731958995] 'compare' (duration: 45.855946ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:25:39.344286Z","caller":"traceutil/trace.go:171","msg":"trace[1853855460] transaction","detail":"{read_only:false; response_revision:7100; number_of_response:1; }","duration":"111.898051ms","start":"2026-08-04T15:25:39.232351Z","end":"2026-08-04T15:25:39.344249Z","steps":["trace[1853855460] 'process raft request' (duration: 34.760021ms)","trace[1853855460] 'compare' (duration: 77.023286ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:25:40.588189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.485783ms","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-08-04T15:25:40.588428Z","caller":"traceutil/trace.go:171","msg":"trace[230569661] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7104; }","duration":"164.804836ms","start":"2026-08-04T15:25:40.423601Z","end":"2026-08-04T15:25:40.588406Z","steps":["trace[230569661] 'range keys from in-memory index tree' (duration: 164.259745ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:26:00.824248Z","caller":"traceutil/trace.go:171","msg":"trace[40561788] transaction","detail":"{read_only:false; response_revision:7208; number_of_response:1; }","duration":"103.361995ms","start":"2026-08-04T15:26:00.720839Z","end":"2026-08-04T15:26:00.824201Z","steps":["trace[40561788] 'process raft request' (duration: 103.152307ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:26:34.295565Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5520} {"level":"info","ts":"2026-08-04T15:26:34.522811Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5520,"took":"225.188201ms","hash":1811303773,"current-db-size-bytes":54779904,"current-db-size":"55 MB","current-db-size-in-use-bytes":18440192,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-08-04T15:26:34.522901Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1811303773,"revision":5520,"compact-revision":2859} {"level":"info","ts":"2026-08-04T15:26:38.579517Z","caller":"traceutil/trace.go:171","msg":"trace[550290176] transaction","detail":"{read_only:false; response_revision:7399; number_of_response:1; }","duration":"171.147969ms","start":"2026-08-04T15:26:38.40834Z","end":"2026-08-04T15:26:38.579488Z","steps":["trace[550290176] 'process raft request' (duration: 170.974333ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:26:38.897213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.288461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-08-04T15:26:38.897305Z","caller":"traceutil/trace.go:171","msg":"trace[2121285061] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7399; }","duration":"214.446076ms","start":"2026-08-04T15:26:38.682838Z","end":"2026-08-04T15:26:38.897284Z","steps":["trace[2121285061] 'range keys from in-memory index tree' (duration: 213.954839ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:26:44.014591Z","caller":"traceutil/trace.go:171","msg":"trace[578135947] transaction","detail":"{read_only:false; response_revision:7427; number_of_response:1; }","duration":"137.451886ms","start":"2026-08-04T15:26:43.877096Z","end":"2026-08-04T15:26:44.014547Z","steps":["trace[578135947] 'process raft request' (duration: 136.996061ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:26:44.014787Z","caller":"traceutil/trace.go:171","msg":"trace[1926227044] linearizableReadLoop","detail":"{readStateIndex:7705; appliedIndex:7705; }","duration":"116.144959ms","start":"2026-08-04T15:26:43.898607Z","end":"2026-08-04T15:26:44.014752Z","steps":["trace[1926227044] 'read index received' (duration: 116.132719ms)","trace[1926227044] 'applied index is now lower than readState.Index' (duration: 10.18µs)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:26:44.015345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.657797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:26:44.015413Z","caller":"traceutil/trace.go:171","msg":"trace[204475944] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7428; }","duration":"116.835613ms","start":"2026-08-04T15:26:43.898556Z","end":"2026-08-04T15:26:44.015392Z","steps":["trace[204475944] 'agreement among raft nodes before linearized reading' (duration: 116.618776ms)"],"step_count":1}