{"level":"warn","ts":"2026-06-23T01:13:13.936921Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-23T01:13:13.937015Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.3:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.3:2380","--initial-cluster=instance=https://199.204.45.3:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.3:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.3:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-23T01:13:13.937082Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-23T01:13:13.937098Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.3:2380"]} {"level":"info","ts":"2026-06-23T01:13:13.937115Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-23T01:13:13.937714Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"]} {"level":"info","ts":"2026-06-23T01:13:13.937794Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.3:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-23T01:13:13.940886Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.873499ms"} {"level":"info","ts":"2026-06-23T01:13:13.94817Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"597401b06ce1cf3d","cluster-id":"dfc54657ad8a2432"} {"level":"info","ts":"2026-06-23T01:13:13.948255Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=()"} {"level":"info","ts":"2026-06-23T01:13:13.948286Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 0"} {"level":"info","ts":"2026-06-23T01:13:13.948306Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 597401b06ce1cf3d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-23T01:13:13.948325Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 1"} {"level":"info","ts":"2026-06-23T01:13:13.948384Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"} {"level":"warn","ts":"2026-06-23T01:13:13.953806Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-23T01:13:13.955581Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-23T01:13:13.957063Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-23T01:13:13.960433Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"597401b06ce1cf3d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-23T01:13:13.960652Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"597401b06ce1cf3d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-23T01:13:13.960751Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-23T01:13:13.960912Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-23T01:13:13.960949Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-23T01:13:13.96659Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"} {"level":"info","ts":"2026-06-23T01:13:13.966983Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","added-peer-id":"597401b06ce1cf3d","added-peer-peer-urls":["https://199.204.45.3:2380"]} {"level":"info","ts":"2026-06-23T01:13:13.968183Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-23T01:13:13.968423Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"597401b06ce1cf3d","initial-advertise-peer-urls":["https://199.204.45.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-23T01:13:13.96846Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-23T01:13:13.968582Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.3:2380"} {"level":"info","ts":"2026-06-23T01:13:13.968598Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.3:2380"} {"level":"info","ts":"2026-06-23T01:13:14.148964Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d is starting a new election at term 1"} {"level":"info","ts":"2026-06-23T01:13:14.149024Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became pre-candidate at term 1"} {"level":"info","ts":"2026-06-23T01:13:14.149059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgPreVoteResp from 597401b06ce1cf3d at term 1"} {"level":"info","ts":"2026-06-23T01:13:14.149075Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became candidate at term 2"} {"level":"info","ts":"2026-06-23T01:13:14.149083Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgVoteResp from 597401b06ce1cf3d at term 2"} {"level":"info","ts":"2026-06-23T01:13:14.149095Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became leader at term 2"} {"level":"info","ts":"2026-06-23T01:13:14.149108Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 597401b06ce1cf3d elected leader 597401b06ce1cf3d at term 2"} {"level":"info","ts":"2026-06-23T01:13:14.150027Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-23T01:13:14.150733Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"597401b06ce1cf3d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.3:2379]}","request-path":"/0/members/597401b06ce1cf3d/attributes","cluster-id":"dfc54657ad8a2432","publish-timeout":"7s"} {"level":"info","ts":"2026-06-23T01:13:14.15075Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-23T01:13:14.15099Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-23T01:13:14.151028Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-23T01:13:14.150951Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-23T01:13:14.151346Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","cluster-version":"3.5"} {"level":"info","ts":"2026-06-23T01:13:14.151489Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-23T01:13:14.151534Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-23T01:13:14.154274Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-23T01:13:14.154599Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.3:2379"} {"level":"info","ts":"2026-06-23T01:13:58.298412Z","caller":"traceutil/trace.go:171","msg":"trace[131386107] linearizableReadLoop","detail":"{readStateIndex:619; appliedIndex:618; }","duration":"105.735396ms","start":"2026-06-23T01:13:58.19265Z","end":"2026-06-23T01:13:58.298386Z","steps":["trace[131386107] 'read index received' (duration: 105.47974ms)","trace[131386107] 'applied index is now lower than readState.Index' (duration: 254.636µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T01:13:58.298579Z","caller":"traceutil/trace.go:171","msg":"trace[246594003] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"143.960271ms","start":"2026-06-23T01:13:58.154581Z","end":"2026-06-23T01:13:58.298541Z","steps":["trace[246594003] 'process raft request' (duration: 143.646464ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T01:13:58.298696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.027623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-4vlvm\" ","response":"range_response_count:1 size:16957"} {"level":"info","ts":"2026-06-23T01:13:58.298764Z","caller":"traceutil/trace.go:171","msg":"trace[1859793257] range","detail":"{range_begin:/registry/pods/kube-system/cilium-4vlvm; range_end:; response_count:1; response_revision:592; }","duration":"106.121135ms","start":"2026-06-23T01:13:58.19263Z","end":"2026-06-23T01:13:58.298751Z","steps":["trace[1859793257] 'agreement among raft nodes before linearized reading' (duration: 105.9011ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:13:58.640776Z","caller":"traceutil/trace.go:171","msg":"trace[697653085] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:620; }","duration":"198.398662ms","start":"2026-06-23T01:13:58.442354Z","end":"2026-06-23T01:13:58.640752Z","steps":["trace[697653085] 'read index received' (duration: 193.620819ms)","trace[697653085] 'applied index is now lower than readState.Index' (duration: 4.776903ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T01:13:58.640836Z","caller":"traceutil/trace.go:171","msg":"trace[1406945580] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"213.298225ms","start":"2026-06-23T01:13:58.427508Z","end":"2026-06-23T01:13:58.640806Z","steps":["trace[1406945580] 'process raft request' (duration: 208.813299ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T01:13:58.641011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.642468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-23T01:13:58.641052Z","caller":"traceutil/trace.go:171","msg":"trace[215188062] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:594; }","duration":"198.72871ms","start":"2026-06-23T01:13:58.442312Z","end":"2026-06-23T01:13:58.641041Z","steps":["trace[215188062] 'agreement among raft nodes before linearized reading' (duration: 198.578676ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T01:13:58.641812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.568348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-23T01:13:58.641962Z","caller":"traceutil/trace.go:171","msg":"trace[535310591] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:594; }","duration":"166.782133ms","start":"2026-06-23T01:13:58.475142Z","end":"2026-06-23T01:13:58.641924Z","steps":["trace[535310591] 'agreement among raft nodes before linearized reading' (duration: 165.757958ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:13:58.927218Z","caller":"traceutil/trace.go:171","msg":"trace[1696837476] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"231.849805ms","start":"2026-06-23T01:13:58.695333Z","end":"2026-06-23T01:13:58.927182Z","steps":["trace[1696837476] 'process raft request' (duration: 231.799984ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:13:58.927255Z","caller":"traceutil/trace.go:171","msg":"trace[1202326734] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"277.571629ms","start":"2026-06-23T01:13:58.64964Z","end":"2026-06-23T01:13:58.927211Z","steps":["trace[1202326734] 'process raft request' (duration: 260.503733ms)","trace[1202326734] 'compare' (duration: 16.851629ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T01:13:59.633381Z","caller":"traceutil/trace.go:171","msg":"trace[67442577] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"294.896719ms","start":"2026-06-23T01:13:59.338457Z","end":"2026-06-23T01:13:59.633354Z","steps":["trace[67442577] 'process raft request' (duration: 282.26837ms)","trace[67442577] 'compare' (duration: 12.228059ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T01:14:14.517585Z","caller":"traceutil/trace.go:171","msg":"trace[1754680027] linearizableReadLoop","detail":"{readStateIndex:787; appliedIndex:786; }","duration":"130.756219ms","start":"2026-06-23T01:14:14.386802Z","end":"2026-06-23T01:14:14.517558Z","steps":["trace[1754680027] 'read index received' (duration: 130.620466ms)","trace[1754680027] 'applied index is now lower than readState.Index' (duration: 134.673µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T01:14:14.517745Z","caller":"traceutil/trace.go:171","msg":"trace[1626753418] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"215.708612ms","start":"2026-06-23T01:14:14.301981Z","end":"2026-06-23T01:14:14.517689Z","steps":["trace[1626753418] 'process raft request' (duration: 215.394475ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T01:14:14.517818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.996944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-23T01:14:14.517856Z","caller":"traceutil/trace.go:171","msg":"trace[1955099385] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:756; }","duration":"131.097117ms","start":"2026-06-23T01:14:14.386748Z","end":"2026-06-23T01:14:14.517845Z","steps":["trace[1955099385] 'agreement among raft nodes before linearized reading' (duration: 130.912703ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:15:07.734297Z","caller":"traceutil/trace.go:171","msg":"trace[1664860400] transaction","detail":"{read_only:false; response_revision:1419; number_of_response:1; }","duration":"103.626476ms","start":"2026-06-23T01:15:07.630645Z","end":"2026-06-23T01:15:07.734272Z","steps":["trace[1664860400] 'process raft request' (duration: 103.354ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:15:32.269318Z","caller":"traceutil/trace.go:171","msg":"trace[1176040070] transaction","detail":"{read_only:false; response_revision:1839; number_of_response:1; }","duration":"125.759205ms","start":"2026-06-23T01:15:32.143536Z","end":"2026-06-23T01:15:32.269295Z","steps":["trace[1176040070] 'process raft request' (duration: 125.588301ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:15:32.750387Z","caller":"traceutil/trace.go:171","msg":"trace[745614657] linearizableReadLoop","detail":"{readStateIndex:1915; appliedIndex:1914; }","duration":"230.217411ms","start":"2026-06-23T01:15:32.520141Z","end":"2026-06-23T01:15:32.750359Z","steps":["trace[745614657] 'read index received' (duration: 230.041817ms)","trace[745614657] 'applied index is now lower than readState.Index' (duration: 174.414µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T01:15:32.750447Z","caller":"traceutil/trace.go:171","msg":"trace[1901953055] transaction","detail":"{read_only:false; response_revision:1840; number_of_response:1; }","duration":"279.446924ms","start":"2026-06-23T01:15:32.470966Z","end":"2026-06-23T01:15:32.750413Z","steps":["trace[1901953055] 'process raft request' (duration: 279.173857ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T01:15:32.750623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.452337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-23T01:15:32.75068Z","caller":"traceutil/trace.go:171","msg":"trace[132881920] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1840; }","duration":"230.562729ms","start":"2026-06-23T01:15:32.5201Z","end":"2026-06-23T01:15:32.750662Z","steps":["trace[132881920] 'agreement among raft nodes before linearized reading' (duration: 230.388865ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:15:32.751811Z","caller":"traceutil/trace.go:171","msg":"trace[1498411814] transaction","detail":"{read_only:false; response_revision:1841; number_of_response:1; }","duration":"226.931654ms","start":"2026-06-23T01:15:32.524854Z","end":"2026-06-23T01:15:32.751786Z","steps":["trace[1498411814] 'process raft request' (duration: 226.605777ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:15:32.751837Z","caller":"traceutil/trace.go:171","msg":"trace[1802500133] transaction","detail":"{read_only:false; response_revision:1842; number_of_response:1; }","duration":"217.026893ms","start":"2026-06-23T01:15:32.534787Z","end":"2026-06-23T01:15:32.751814Z","steps":["trace[1802500133] 'process raft request' (duration: 216.788557ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:15:40.893701Z","caller":"traceutil/trace.go:171","msg":"trace[815369214] transaction","detail":"{read_only:false; response_revision:1914; number_of_response:1; }","duration":"115.492025ms","start":"2026-06-23T01:15:40.778187Z","end":"2026-06-23T01:15:40.89368Z","steps":["trace[815369214] 'process raft request' (duration: 115.365632ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:15:40.909453Z","caller":"traceutil/trace.go:171","msg":"trace[111070076] linearizableReadLoop","detail":"{readStateIndex:1993; appliedIndex:1991; }","duration":"121.854284ms","start":"2026-06-23T01:15:40.787548Z","end":"2026-06-23T01:15:40.909403Z","steps":["trace[111070076] 'read index received' (duration: 106.034893ms)","trace[111070076] 'applied index is now lower than readState.Index' (duration: 15.817111ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T01:15:40.909597Z","caller":"traceutil/trace.go:171","msg":"trace[1156640240] transaction","detail":"{read_only:false; response_revision:1915; number_of_response:1; }","duration":"129.297648ms","start":"2026-06-23T01:15:40.780209Z","end":"2026-06-23T01:15:40.909506Z","steps":["trace[1156640240] 'process raft request' (duration: 128.97446ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T01:15:40.909728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.155611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-23T01:15:40.909793Z","caller":"traceutil/trace.go:171","msg":"trace[1849043056] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1915; }","duration":"122.266294ms","start":"2026-06-23T01:15:40.787512Z","end":"2026-06-23T01:15:40.909778Z","steps":["trace[1849043056] 'agreement among raft nodes before linearized reading' (duration: 122.09477ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:16:23.555919Z","caller":"traceutil/trace.go:171","msg":"trace[1432961209] transaction","detail":"{read_only:false; response_revision:2166; number_of_response:1; }","duration":"148.439327ms","start":"2026-06-23T01:16:23.407446Z","end":"2026-06-23T01:16:23.555885Z","steps":["trace[1432961209] 'process raft request' (duration: 148.206161ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:16:23.716758Z","caller":"traceutil/trace.go:171","msg":"trace[496968772] linearizableReadLoop","detail":"{readStateIndex:2255; appliedIndex:2253; }","duration":"185.520505ms","start":"2026-06-23T01:16:23.531204Z","end":"2026-06-23T01:16:23.716724Z","steps":["trace[496968772] 'read index received' (duration: 24.519194ms)","trace[496968772] 'applied index is now lower than readState.Index' (duration: 161.000511ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T01:16:23.716864Z","caller":"traceutil/trace.go:171","msg":"trace[710203330] transaction","detail":"{read_only:false; response_revision:2167; number_of_response:1; }","duration":"257.92549ms","start":"2026-06-23T01:16:23.458927Z","end":"2026-06-23T01:16:23.716853Z","steps":["trace[710203330] 'process raft request' (duration: 257.665844ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T01:16:23.717168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.941945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-23T01:16:23.717248Z","caller":"traceutil/trace.go:171","msg":"trace[1668035438] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2167; }","duration":"186.088939ms","start":"2026-06-23T01:16:23.531139Z","end":"2026-06-23T01:16:23.717228Z","steps":["trace[1668035438] 'agreement among raft nodes before linearized reading' (duration: 185.810202ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:16:23.939997Z","caller":"traceutil/trace.go:171","msg":"trace[42129663] transaction","detail":"{read_only:false; response_revision:2169; number_of_response:1; }","duration":"217.043573ms","start":"2026-06-23T01:16:23.722924Z","end":"2026-06-23T01:16:23.939968Z","steps":["trace[42129663] 'process raft request' (duration: 216.961121ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:16:23.940026Z","caller":"traceutil/trace.go:171","msg":"trace[1301373523] transaction","detail":"{read_only:false; response_revision:2168; number_of_response:1; }","duration":"279.602377ms","start":"2026-06-23T01:16:23.660385Z","end":"2026-06-23T01:16:23.939987Z","steps":["trace[1301373523] 'process raft request' (duration: 190.924501ms)","trace[1301373523] 'compare' (duration: 88.41119ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T01:16:23.940034Z","caller":"traceutil/trace.go:171","msg":"trace[1665118438] linearizableReadLoop","detail":"{readStateIndex:2256; appliedIndex:2255; }","duration":"223.185466ms","start":"2026-06-23T01:16:23.716818Z","end":"2026-06-23T01:16:23.940004Z","steps":["trace[1665118438] 'read index received' (duration: 134.549191ms)","trace[1665118438] 'applied index is now lower than readState.Index' (duration: 88.633165ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T01:16:23.940394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.433244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-23T01:16:23.940465Z","caller":"traceutil/trace.go:171","msg":"trace[811216152] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2169; }","duration":"273.551767ms","start":"2026-06-23T01:16:23.666898Z","end":"2026-06-23T01:16:23.94045Z","steps":["trace[811216152] 'agreement among raft nodes before linearized reading' (duration: 273.30734ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T01:16:23.940549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.76736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-23T01:16:23.940637Z","caller":"traceutil/trace.go:171","msg":"trace[1508033762] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2169; }","duration":"138.910503ms","start":"2026-06-23T01:16:23.801706Z","end":"2026-06-23T01:16:23.940616Z","steps":["trace[1508033762] 'agreement among raft nodes before linearized reading' (duration: 138.595255ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:20:43.450743Z","caller":"traceutil/trace.go:171","msg":"trace[765295460] transaction","detail":"{read_only:false; response_revision:3940; number_of_response:1; }","duration":"174.009001ms","start":"2026-06-23T01:20:43.2767Z","end":"2026-06-23T01:20:43.450709Z","steps":["trace[765295460] 'process raft request' (duration: 173.793956ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:20:43.588898Z","caller":"traceutil/trace.go:171","msg":"trace[98479018] linearizableReadLoop","detail":"{readStateIndex:4097; appliedIndex:4094; }","duration":"208.855273ms","start":"2026-06-23T01:20:43.38001Z","end":"2026-06-23T01:20:43.588865Z","steps":["trace[98479018] 'read index received' (duration: 70.581594ms)","trace[98479018] 'applied index is now lower than readState.Index' (duration: 138.271799ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T01:20:43.588922Z","caller":"traceutil/trace.go:171","msg":"trace[542086556] transaction","detail":"{read_only:false; response_revision:3941; number_of_response:1; }","duration":"308.810417ms","start":"2026-06-23T01:20:43.280077Z","end":"2026-06-23T01:20:43.588887Z","steps":["trace[542086556] 'process raft request' (duration: 308.518719ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:20:43.588968Z","caller":"traceutil/trace.go:171","msg":"trace[2093249781] transaction","detail":"{read_only:false; response_revision:3942; number_of_response:1; }","duration":"308.446659ms","start":"2026-06-23T01:20:43.280495Z","end":"2026-06-23T01:20:43.588941Z","steps":["trace[2093249781] 'process raft request' (duration: 308.307425ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T01:20:43.589077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.036867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T01:20:43.589182Z","caller":"traceutil/trace.go:171","msg":"trace[1501579115] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:3942; }","duration":"209.210622ms","start":"2026-06-23T01:20:43.379956Z","end":"2026-06-23T01:20:43.589166Z","steps":["trace[1501579115] 'agreement among raft nodes before linearized reading' (duration: 209.031178ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T01:20:43.58982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T01:20:43.280042Z","time spent":"308.985591ms","remote":"127.0.0.1:43666","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-06-23T01:20:43.59002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T01:20:43.280473Z","time spent":"308.554921ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T01:22:06.148926Z","caller":"traceutil/trace.go:171","msg":"trace[1656094182] transaction","detail":"{read_only:false; response_revision:5119; number_of_response:1; }","duration":"132.422523ms","start":"2026-06-23T01:22:06.016469Z","end":"2026-06-23T01:22:06.148892Z","steps":["trace[1656094182] 'process raft request' (duration: 132.255889ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:22:17.741353Z","caller":"traceutil/trace.go:171","msg":"trace[186475484] transaction","detail":"{read_only:false; response_revision:5357; number_of_response:1; }","duration":"115.163377ms","start":"2026-06-23T01:22:17.626163Z","end":"2026-06-23T01:22:17.741327Z","steps":["trace[186475484] 'process raft request' (duration: 114.972813ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:22:18.171801Z","caller":"traceutil/trace.go:171","msg":"trace[1792316964] transaction","detail":"{read_only:false; response_revision:5366; number_of_response:1; }","duration":"113.901848ms","start":"2026-06-23T01:22:18.05786Z","end":"2026-06-23T01:22:18.171762Z","steps":["trace[1792316964] 'process raft request' (duration: 113.677471ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:22:26.06473Z","caller":"traceutil/trace.go:171","msg":"trace[665791111] transaction","detail":"{read_only:false; response_revision:5529; number_of_response:1; }","duration":"148.952061ms","start":"2026-06-23T01:22:25.915751Z","end":"2026-06-23T01:22:26.064703Z","steps":["trace[665791111] 'process raft request' (duration: 148.725886ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T01:22:26.501304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.731088ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T01:22:26.501563Z","caller":"traceutil/trace.go:171","msg":"trace[1522059121] transaction","detail":"{read_only:false; response_revision:5532; number_of_response:1; }","duration":"203.145139ms","start":"2026-06-23T01:22:26.298365Z","end":"2026-06-23T01:22:26.50151Z","steps":["trace[1522059121] 'process raft request' (duration: 72.95658ms)","trace[1522059121] 'compare' (duration: 129.466292ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T01:22:26.679982Z","caller":"traceutil/trace.go:171","msg":"trace[1917787332] transaction","detail":"{read_only:false; response_revision:5533; number_of_response:1; }","duration":"143.821769ms","start":"2026-06-23T01:22:26.536135Z","end":"2026-06-23T01:22:26.679957Z","steps":["trace[1917787332] 'process raft request' (duration: 143.664875ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:22:26.68137Z","caller":"traceutil/trace.go:171","msg":"trace[835573511] transaction","detail":"{read_only:false; response_revision:5534; number_of_response:1; }","duration":"107.887692ms","start":"2026-06-23T01:22:26.573452Z","end":"2026-06-23T01:22:26.68134Z","steps":["trace[835573511] 'process raft request' (duration: 107.80287ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:23:14.430235Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2961} {"level":"info","ts":"2026-06-23T01:23:14.611873Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2961,"took":"179.897078ms","hash":3457632285,"current-db-size-bytes":59236352,"current-db-size":"59 MB","current-db-size-in-use-bytes":33906688,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-23T01:23:14.611946Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3457632285,"revision":2961,"compact-revision":-1} {"level":"info","ts":"2026-06-23T01:28:14.436412Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5999} {"level":"info","ts":"2026-06-23T01:28:14.526739Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5999,"took":"88.352258ms","hash":3309437141,"current-db-size-bytes":59236352,"current-db-size":"59 MB","current-db-size-in-use-bytes":21528576,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-06-23T01:28:14.526809Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3309437141,"revision":5999,"compact-revision":2961} {"level":"info","ts":"2026-06-23T01:28:28.815452Z","caller":"traceutil/trace.go:171","msg":"trace[1303739544] transaction","detail":"{read_only:false; response_revision:8338; number_of_response:1; }","duration":"103.097864ms","start":"2026-06-23T01:28:28.71232Z","end":"2026-06-23T01:28:28.815418Z","steps":["trace[1303739544] 'process raft request' (duration: 102.834078ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:28:28.946966Z","caller":"traceutil/trace.go:171","msg":"trace[541002211] transaction","detail":"{read_only:false; response_revision:8339; number_of_response:1; }","duration":"125.671522ms","start":"2026-06-23T01:28:28.821237Z","end":"2026-06-23T01:28:28.946909Z","steps":["trace[541002211] 'process raft request' (duration: 103.668717ms)","trace[541002211] 'compare' (duration: 21.81167ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T01:28:40.472615Z","caller":"traceutil/trace.go:171","msg":"trace[168096316] linearizableReadLoop","detail":"{readStateIndex:8701; appliedIndex:8700; }","duration":"128.990233ms","start":"2026-06-23T01:28:40.343591Z","end":"2026-06-23T01:28:40.472582Z","steps":["trace[168096316] 'read index received' (duration: 30.935781ms)","trace[168096316] 'applied index is now lower than readState.Index' (duration: 98.053272ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T01:28:40.472875Z","caller":"traceutil/trace.go:171","msg":"trace[927173276] transaction","detail":"{read_only:false; response_revision:8398; number_of_response:1; }","duration":"214.018188ms","start":"2026-06-23T01:28:40.258817Z","end":"2026-06-23T01:28:40.472836Z","steps":["trace[927173276] 'process raft request' (duration: 115.793651ms)","trace[927173276] 'compare' (duration: 97.780575ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T01:28:40.473012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.405493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-23T01:28:40.473088Z","caller":"traceutil/trace.go:171","msg":"trace[2107155610] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8398; }","duration":"129.493735ms","start":"2026-06-23T01:28:40.343579Z","end":"2026-06-23T01:28:40.473073Z","steps":["trace[2107155610] 'agreement among raft nodes before linearized reading' (duration: 129.25375ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T01:28:41.400673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.614363ms","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-06-23T01:28:41.400798Z","caller":"traceutil/trace.go:171","msg":"trace[1132382324] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:8402; }","duration":"238.799437ms","start":"2026-06-23T01:28:41.161977Z","end":"2026-06-23T01:28:41.400777Z","steps":["trace[1132382324] 'count revisions from in-memory index tree' (duration: 238.541352ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:29:11.236495Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000022de.wal"} {"level":"info","ts":"2026-06-23T01:29:11.237158Z","caller":"traceutil/trace.go:171","msg":"trace[1216695073] transaction","detail":"{read_only:false; response_revision:8614; number_of_response:1; }","duration":"304.834171ms","start":"2026-06-23T01:29:10.932307Z","end":"2026-06-23T01:29:11.237141Z","steps":["trace[1216695073] 'process raft request' (duration: 304.448222ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:29:11.237143Z","caller":"traceutil/trace.go:171","msg":"trace[101716723] linearizableReadLoop","detail":"{readStateIndex:8925; appliedIndex:8924; }","duration":"289.830107ms","start":"2026-06-23T01:29:10.947278Z","end":"2026-06-23T01:29:11.237109Z","steps":["trace[101716723] 'read index received' (duration: 289.388306ms)","trace[101716723] 'applied index is now lower than readState.Index' (duration: 440.551µs)"],"step_count":2} {"level":"warn","ts":"2026-06-23T01:29:11.237285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T01:29:10.932276Z","time spent":"304.937493ms","remote":"127.0.0.1:45960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":414529,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T01:29:11.237255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.970391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T01:29:11.237462Z","caller":"traceutil/trace.go:171","msg":"trace[1174266240] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8614; }","duration":"290.168705ms","start":"2026-06-23T01:29:10.947234Z","end":"2026-06-23T01:29:11.237403Z","steps":["trace[1174266240] 'agreement among raft nodes before linearized reading' (duration: 289.96739ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:29:11.237838Z","caller":"traceutil/trace.go:171","msg":"trace[571621449] transaction","detail":"{read_only:false; response_revision:8615; number_of_response:1; }","duration":"197.316882ms","start":"2026-06-23T01:29:11.040502Z","end":"2026-06-23T01:29:11.237818Z","steps":["trace[571621449] 'process raft request' (duration: 197.195609ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T01:29:14.576325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.816278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T01:29:14.57641Z","caller":"traceutil/trace.go:171","msg":"trace[1839081939] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:8631; }","duration":"212.970902ms","start":"2026-06-23T01:29:14.363418Z","end":"2026-06-23T01:29:14.576389Z","steps":["trace[1839081939] 'count revisions from in-memory index tree' (duration: 212.709015ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:29:14.576624Z","caller":"traceutil/trace.go:171","msg":"trace[1758557531] transaction","detail":"{read_only:false; response_revision:8632; number_of_response:1; }","duration":"135.398277ms","start":"2026-06-23T01:29:14.441174Z","end":"2026-06-23T01:29:14.576572Z","steps":["trace[1758557531] 'process raft request' (duration: 50.534386ms)","trace[1758557531] 'compare' (duration: 84.721838ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T01:29:15.006314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.314565ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T01:29:15.006429Z","caller":"traceutil/trace.go:171","msg":"trace[1045608657] transaction","detail":"{read_only:false; response_revision:8634; number_of_response:1; }","duration":"348.02925ms","start":"2026-06-23T01:29:14.65838Z","end":"2026-06-23T01:29:15.006409Z","steps":["trace[1045608657] 'process raft request' (duration: 170.51759ms)","trace[1045608657] 'compare' (duration: 177.185983ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T01:29:15.006491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T01:29:14.658364Z","time spent":"348.098282ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T01:29:15.014795Z","caller":"traceutil/trace.go:171","msg":"trace[1658120725] transaction","detail":"{read_only:false; response_revision:8635; number_of_response:1; }","duration":"354.283913ms","start":"2026-06-23T01:29:14.660472Z","end":"2026-06-23T01:29:15.014756Z","steps":["trace[1658120725] 'process raft request' (duration: 354.055177ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T01:29:15.014997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T01:29:14.660463Z","time spent":"354.423876ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T01:29:25.857608Z","caller":"traceutil/trace.go:171","msg":"trace[2143708936] transaction","detail":"{read_only:false; response_revision:8737; number_of_response:1; }","duration":"123.382775ms","start":"2026-06-23T01:29:25.734192Z","end":"2026-06-23T01:29:25.857575Z","steps":["trace[2143708936] 'process raft request' (duration: 123.14255ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:30:43.952895Z","caller":"traceutil/trace.go:171","msg":"trace[1317364669] transaction","detail":"{read_only:false; response_revision:9496; number_of_response:1; }","duration":"192.782294ms","start":"2026-06-23T01:30:43.760045Z","end":"2026-06-23T01:30:43.952828Z","steps":["trace[1317364669] 'process raft request' (duration: 192.466576ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:31:04.3752Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"597401b06ce1cf3d","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-23T01:31:04.381114Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-23T01:31:04.381241Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-23T01:31:39.647952Z","caller":"traceutil/trace.go:171","msg":"trace[1298857471] transaction","detail":"{read_only:false; response_revision:9895; number_of_response:1; }","duration":"219.605487ms","start":"2026-06-23T01:31:39.428313Z","end":"2026-06-23T01:31:39.647919Z","steps":["trace[1298857471] 'process raft request' (duration: 219.372612ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:31:39.649414Z","caller":"traceutil/trace.go:171","msg":"trace[1724099450] transaction","detail":"{read_only:false; response_revision:9896; number_of_response:1; }","duration":"179.912332ms","start":"2026-06-23T01:31:39.46949Z","end":"2026-06-23T01:31:39.649403Z","steps":["trace[1724099450] 'process raft request' (duration: 179.573524ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:33:14.442903Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8124} {"level":"info","ts":"2026-06-23T01:33:14.506016Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8124,"took":"61.069913ms","hash":2721770733,"current-db-size-bytes":59236352,"current-db-size":"59 MB","current-db-size-in-use-bytes":28495872,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-23T01:33:14.506079Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2721770733,"revision":8124,"compact-revision":5999} {"level":"info","ts":"2026-06-23T01:35:37.027655Z","caller":"traceutil/trace.go:171","msg":"trace[1889349908] linearizableReadLoop","detail":"{readStateIndex:11880; appliedIndex:11879; }","duration":"127.605473ms","start":"2026-06-23T01:35:36.900023Z","end":"2026-06-23T01:35:37.027629Z","steps":["trace[1889349908] 'read index received' (duration: 127.337847ms)","trace[1889349908] 'applied index is now lower than readState.Index' (duration: 266.556µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T01:35:37.027764Z","caller":"traceutil/trace.go:171","msg":"trace[507582097] transaction","detail":"{read_only:false; response_revision:11476; number_of_response:1; }","duration":"194.221767ms","start":"2026-06-23T01:35:36.833491Z","end":"2026-06-23T01:35:37.027713Z","steps":["trace[507582097] 'process raft request' (duration: 193.979101ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T01:35:37.02799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.495891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-06-23T01:35:37.027911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.876099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-23T01:35:37.028061Z","caller":"traceutil/trace.go:171","msg":"trace[2016136119] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:11476; }","duration":"125.621394ms","start":"2026-06-23T01:35:36.902423Z","end":"2026-06-23T01:35:37.028045Z","steps":["trace[2016136119] 'agreement among raft nodes before linearized reading' (duration: 125.392198ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:35:37.028284Z","caller":"traceutil/trace.go:171","msg":"trace[1407148396] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:11476; }","duration":"128.082134ms","start":"2026-06-23T01:35:36.899969Z","end":"2026-06-23T01:35:37.028051Z","steps":["trace[1407148396] 'agreement among raft nodes before linearized reading' (duration: 127.818858ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:38:14.449758Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10489} {"level":"info","ts":"2026-06-23T01:38:14.536631Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10489,"took":"84.288566ms","hash":71195953,"current-db-size-bytes":59236352,"current-db-size":"59 MB","current-db-size-in-use-bytes":26497024,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-23T01:38:14.53669Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":71195953,"revision":10489,"compact-revision":8124} {"level":"info","ts":"2026-06-23T01:43:00.520516Z","caller":"traceutil/trace.go:171","msg":"trace[1802875523] transaction","detail":"{read_only:false; response_revision:14570; number_of_response:1; }","duration":"215.319649ms","start":"2026-06-23T01:43:00.30517Z","end":"2026-06-23T01:43:00.52049Z","steps":["trace[1802875523] 'process raft request' (duration: 215.156595ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:43:14.458033Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12676} {"level":"info","ts":"2026-06-23T01:43:14.547237Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12676,"took":"85.813116ms","hash":463875968,"current-db-size-bytes":59236352,"current-db-size":"59 MB","current-db-size-in-use-bytes":27934720,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-23T01:43:14.54735Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":463875968,"revision":12676,"compact-revision":10489} {"level":"info","ts":"2026-06-23T01:43:25.784813Z","caller":"traceutil/trace.go:171","msg":"trace[521636009] linearizableReadLoop","detail":"{readStateIndex:15439; appliedIndex:15438; }","duration":"167.079763ms","start":"2026-06-23T01:43:25.617708Z","end":"2026-06-23T01:43:25.784787Z","steps":["trace[521636009] 'read index received' (duration: 166.879308ms)","trace[521636009] 'applied index is now lower than readState.Index' (duration: 199.475µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T01:43:25.784998Z","caller":"traceutil/trace.go:171","msg":"trace[33385985] transaction","detail":"{read_only:false; response_revision:14915; number_of_response:1; }","duration":"181.8453ms","start":"2026-06-23T01:43:25.603083Z","end":"2026-06-23T01:43:25.784929Z","steps":["trace[33385985] 'process raft request' (duration: 181.556974ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T01:43:25.785093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.357066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-79b1ff95-94a2-4518-aab8-09a3c44db4dc\" ","response":"range_response_count:1 size:3635"} {"level":"warn","ts":"2026-06-23T01:43:25.785102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.38587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-23T01:43:25.785147Z","caller":"traceutil/trace.go:171","msg":"trace[1460799038] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-79b1ff95-94a2-4518-aab8-09a3c44db4dc; range_end:; response_count:1; response_revision:14915; }","duration":"116.441708ms","start":"2026-06-23T01:43:25.668679Z","end":"2026-06-23T01:43:25.785121Z","steps":["trace[1460799038] 'agreement among raft nodes before linearized reading' (duration: 116.255754ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:43:25.785173Z","caller":"traceutil/trace.go:171","msg":"trace[1364999084] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:14915; }","duration":"167.503203ms","start":"2026-06-23T01:43:25.617652Z","end":"2026-06-23T01:43:25.785155Z","steps":["trace[1364999084] 'agreement among raft nodes before linearized reading' (duration: 167.279718ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:48:14.475729Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14725} {"level":"info","ts":"2026-06-23T01:48:14.551054Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14725,"took":"72.092586ms","hash":3533674928,"current-db-size-bytes":59236352,"current-db-size":"59 MB","current-db-size-in-use-bytes":34054144,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-23T01:48:14.551105Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3533674928,"revision":14725,"compact-revision":12676} {"level":"info","ts":"2026-06-23T01:51:11.047Z","caller":"traceutil/trace.go:171","msg":"trace[299639570] transaction","detail":"{read_only:false; response_revision:18467; number_of_response:1; }","duration":"221.596557ms","start":"2026-06-23T01:51:10.825379Z","end":"2026-06-23T01:51:11.046975Z","steps":["trace[299639570] 'process raft request' (duration: 221.412543ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T01:51:11.533048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.352697ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T01:51:11.533468Z","caller":"traceutil/trace.go:171","msg":"trace[164458168] linearizableReadLoop","detail":"{readStateIndex:19106; appliedIndex:19104; }","duration":"585.768069ms","start":"2026-06-23T01:51:10.947472Z","end":"2026-06-23T01:51:11.53324Z","steps":["trace[164458168] 'read index received' (duration: 99.37106ms)","trace[164458168] 'applied index is now lower than readState.Index' (duration: 486.395859ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T01:51:11.534224Z","caller":"traceutil/trace.go:171","msg":"trace[1099486651] transaction","detail":"{read_only:false; response_revision:18468; number_of_response:1; }","duration":"600.618014ms","start":"2026-06-23T01:51:10.933591Z","end":"2026-06-23T01:51:11.534209Z","steps":["trace[1099486651] 'process raft request' (duration: 384.013327ms)","trace[1099486651] 'compare' (duration: 214.903797ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T01:51:11.534307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T01:51:10.933512Z","time spent":"600.755367ms","remote":"127.0.0.1:45960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417011,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T01:51:11.53475Z","caller":"traceutil/trace.go:171","msg":"trace[489059025] transaction","detail":"{read_only:false; response_revision:18469; number_of_response:1; }","duration":"488.188912ms","start":"2026-06-23T01:51:11.046549Z","end":"2026-06-23T01:51:11.534738Z","steps":["trace[489059025] 'process raft request' (duration: 486.615324ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T01:51:11.534822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T01:51:11.04652Z","time spent":"488.268885ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T01:51:11.53507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.594213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T01:51:11.535141Z","caller":"traceutil/trace.go:171","msg":"trace[1862559666] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18469; }","duration":"587.708386ms","start":"2026-06-23T01:51:10.947422Z","end":"2026-06-23T01:51:11.535131Z","steps":["trace[1862559666] 'agreement among raft nodes before linearized reading' (duration: 587.611593ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T01:51:11.535239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T01:51:10.947401Z","time spent":"587.763626ms","remote":"127.0.0.1:43414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-23T01:51:11.535537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.412986ms","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:8"} {"level":"info","ts":"2026-06-23T01:51:11.53911Z","caller":"traceutil/trace.go:171","msg":"trace[2014452412] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:18469; }","duration":"549.984751ms","start":"2026-06-23T01:51:10.989106Z","end":"2026-06-23T01:51:11.539091Z","steps":["trace[2014452412] 'agreement among raft nodes before linearized reading' (duration: 546.364295ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T01:51:11.539173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T01:51:10.989075Z","time spent":"550.080104ms","remote":"127.0.0.1:34646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-06-23T01:51:11.536657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.662457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T01:51:11.53955Z","caller":"traceutil/trace.go:171","msg":"trace[1112112886] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:18469; }","duration":"320.666649ms","start":"2026-06-23T01:51:11.218816Z","end":"2026-06-23T01:51:11.539483Z","steps":["trace[1112112886] 'agreement among raft nodes before linearized reading' (duration: 317.660217ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T01:51:11.536642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.753622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1989"} {"level":"info","ts":"2026-06-23T01:51:11.53971Z","caller":"traceutil/trace.go:171","msg":"trace[1148617815] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:18469; }","duration":"290.832456ms","start":"2026-06-23T01:51:11.248805Z","end":"2026-06-23T01:51:11.539638Z","steps":["trace[1148617815] 'agreement among raft nodes before linearized reading' (duration: 287.66903ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T01:51:11.536773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.653115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-4gdjz\" ","response":"range_response_count:1 size:22014"} {"level":"info","ts":"2026-06-23T01:51:11.539798Z","caller":"traceutil/trace.go:171","msg":"trace[2009072763] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-4gdjz; range_end:; response_count:1; response_revision:18469; }","duration":"355.728249ms","start":"2026-06-23T01:51:11.184051Z","end":"2026-06-23T01:51:11.53978Z","steps":["trace[2009072763] 'agreement among raft nodes before linearized reading' (duration: 352.431961ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T01:51:11.539798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T01:51:11.218795Z","time spent":"320.849673ms","remote":"127.0.0.1:34464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true "} {"level":"warn","ts":"2026-06-23T01:51:11.539849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T01:51:11.184034Z","time spent":"355.801131ms","remote":"127.0.0.1:43580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22037,"request content":"key:\"/registry/pods/openstack/nova-compute-default-4gdjz\" "} {"level":"warn","ts":"2026-06-23T01:51:11.536802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.854724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-djrww\" ","response":"range_response_count:1 size:20660"} {"level":"info","ts":"2026-06-23T01:51:11.539985Z","caller":"traceutil/trace.go:171","msg":"trace[1618347813] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-djrww; range_end:; response_count:1; response_revision:18469; }","duration":"263.03445ms","start":"2026-06-23T01:51:11.276894Z","end":"2026-06-23T01:51:11.539929Z","steps":["trace[1618347813] 'agreement among raft nodes before linearized reading' (duration: 259.749841ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:51:16.582978Z","caller":"traceutil/trace.go:171","msg":"trace[203254411] transaction","detail":"{read_only:false; response_revision:18571; number_of_response:1; }","duration":"182.86756ms","start":"2026-06-23T01:51:16.400084Z","end":"2026-06-23T01:51:16.582951Z","steps":["trace[203254411] 'process raft request' (duration: 182.684205ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:51:17.663409Z","caller":"traceutil/trace.go:171","msg":"trace[482545766] transaction","detail":"{read_only:false; response_revision:18575; number_of_response:1; }","duration":"110.590608ms","start":"2026-06-23T01:51:17.552792Z","end":"2026-06-23T01:51:17.663382Z","steps":["trace[482545766] 'process raft request' (duration: 109.162735ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:51:17.676424Z","caller":"traceutil/trace.go:171","msg":"trace[1365184735] transaction","detail":"{read_only:false; response_revision:18576; number_of_response:1; }","duration":"103.665943ms","start":"2026-06-23T01:51:17.572525Z","end":"2026-06-23T01:51:17.676191Z","steps":["trace[1365184735] 'process raft request' (duration: 103.193791ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:52:31.933148Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"597401b06ce1cf3d","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-23T01:52:31.939951Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-23T01:52:31.940107Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-23T01:52:35.510877Z","caller":"traceutil/trace.go:171","msg":"trace[1496605970] linearizableReadLoop","detail":"{readStateIndex:20019; appliedIndex:20018; }","duration":"478.135886ms","start":"2026-06-23T01:52:35.032721Z","end":"2026-06-23T01:52:35.510857Z","steps":["trace[1496605970] 'read index received' (duration: 477.974083ms)","trace[1496605970] 'applied index is now lower than readState.Index' (duration: 160.673µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T01:52:35.510985Z","caller":"traceutil/trace.go:171","msg":"trace[1131921030] transaction","detail":"{read_only:false; response_revision:19356; number_of_response:1; }","duration":"478.894505ms","start":"2026-06-23T01:52:35.032067Z","end":"2026-06-23T01:52:35.510961Z","steps":["trace[1131921030] 'process raft request' (duration: 478.619268ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T01:52:35.511021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.277159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T01:52:35.511049Z","caller":"traceutil/trace.go:171","msg":"trace[547612621] range","detail":"{range_begin:/registry/secretgen.k14s.io/certificates/; range_end:/registry/secretgen.k14s.io/certificates0; response_count:0; response_revision:19356; }","duration":"478.347172ms","start":"2026-06-23T01:52:35.032693Z","end":"2026-06-23T01:52:35.51104Z","steps":["trace[547612621] 'agreement among raft nodes before linearized reading' (duration: 478.253519ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T01:52:35.511073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T01:52:35.032681Z","time spent":"478.385922ms","remote":"127.0.0.1:46024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":29,"request content":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true "} {"level":"warn","ts":"2026-06-23T01:52:35.51113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T01:52:35.032047Z","time spent":"479.011128ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T01:52:35.516657Z","caller":"traceutil/trace.go:171","msg":"trace[1864359093] transaction","detail":"{read_only:false; response_revision:19357; number_of_response:1; }","duration":"172.291957ms","start":"2026-06-23T01:52:35.344338Z","end":"2026-06-23T01:52:35.51663Z","steps":["trace[1864359093] 'process raft request' (duration: 172.072611ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T01:52:35.516704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.945784ms","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:8"} {"level":"warn","ts":"2026-06-23T01:52:35.516784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.900607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-dr2kt\" ","response":"range_response_count:1 size:9705"} {"level":"info","ts":"2026-06-23T01:52:35.5168Z","caller":"traceutil/trace.go:171","msg":"trace[1833137443] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:19357; }","duration":"434.088568ms","start":"2026-06-23T01:52:35.082687Z","end":"2026-06-23T01:52:35.516776Z","steps":["trace[1833137443] 'agreement among raft nodes before linearized reading' (duration: 433.879793ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:52:35.516832Z","caller":"traceutil/trace.go:171","msg":"trace[1040738253] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-dr2kt; range_end:; response_count:1; response_revision:19357; }","duration":"290.963528ms","start":"2026-06-23T01:52:35.225857Z","end":"2026-06-23T01:52:35.516821Z","steps":["trace[1040738253] 'agreement among raft nodes before linearized reading' (duration: 290.781054ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T01:52:35.516865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T01:52:35.082671Z","time spent":"434.17929ms","remote":"127.0.0.1:34656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-06-23T01:52:35.517039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.530664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T01:52:35.51708Z","caller":"traceutil/trace.go:171","msg":"trace[1613225263] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:19357; }","duration":"433.594665ms","start":"2026-06-23T01:52:35.083475Z","end":"2026-06-23T01:52:35.51707Z","steps":["trace[1613225263] 'agreement among raft nodes before linearized reading' (duration: 433.513283ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T01:52:35.517104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T01:52:35.083469Z","time spent":"433.628995ms","remote":"127.0.0.1:35512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-06-23T01:53:14.481816Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17332} {"level":"info","ts":"2026-06-23T01:53:14.578967Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17332,"took":"93.980628ms","hash":3216496967,"current-db-size-bytes":59236352,"current-db-size":"59 MB","current-db-size-in-use-bytes":34619392,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-06-23T01:53:14.579041Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3216496967,"revision":17332,"compact-revision":14725} {"level":"info","ts":"2026-06-23T01:57:17.149124Z","caller":"traceutil/trace.go:171","msg":"trace[1413937340] transaction","detail":"{read_only:false; response_revision:21257; number_of_response:1; }","duration":"214.914999ms","start":"2026-06-23T01:57:16.934188Z","end":"2026-06-23T01:57:17.149103Z","steps":["trace[1413937340] 'process raft request' (duration: 214.727104ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:57:17.268338Z","caller":"traceutil/trace.go:171","msg":"trace[1937599514] transaction","detail":"{read_only:false; response_revision:21258; number_of_response:1; }","duration":"333.396835ms","start":"2026-06-23T01:57:16.934903Z","end":"2026-06-23T01:57:17.2683Z","steps":["trace[1937599514] 'process raft request' (duration: 297.403674ms)","trace[1937599514] 'compare' (duration: 35.800416ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T01:57:17.268481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.092047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-23T01:57:17.268513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T01:57:16.934891Z","time spent":"333.53889ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T01:57:17.268529Z","caller":"traceutil/trace.go:171","msg":"trace[758521257] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21258; }","duration":"321.16761ms","start":"2026-06-23T01:57:16.947347Z","end":"2026-06-23T01:57:17.268515Z","steps":["trace[758521257] 'agreement among raft nodes before linearized reading' (duration: 321.079548ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T01:57:17.268564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T01:57:16.947337Z","time spent":"321.220841ms","remote":"127.0.0.1:43414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-23T01:57:17.269484Z","caller":"traceutil/trace.go:171","msg":"trace[556192844] linearizableReadLoop","detail":"{readStateIndex:21988; appliedIndex:21987; }","duration":"320.843781ms","start":"2026-06-23T01:57:16.947381Z","end":"2026-06-23T01:57:17.268225Z","steps":["trace[556192844] 'read index received' (duration: 202.493778ms)","trace[556192844] 'applied index is now lower than readState.Index' (duration: 118.349043ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T01:57:17.514468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.241959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-23T01:57:17.514532Z","caller":"traceutil/trace.go:171","msg":"trace[1584893910] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:21258; }","duration":"125.374882ms","start":"2026-06-23T01:57:17.389145Z","end":"2026-06-23T01:57:17.51452Z","steps":["trace[1584893910] 'range keys from in-memory index tree' (duration: 125.069875ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T01:58:14.488464Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19636} {"level":"info","ts":"2026-06-23T01:58:14.598865Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19636,"took":"107.127642ms","hash":974541451,"current-db-size-bytes":59236352,"current-db-size":"59 MB","current-db-size-in-use-bytes":29872128,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-23T01:58:14.598922Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":974541451,"revision":19636,"compact-revision":17332} {"level":"info","ts":"2026-06-23T02:01:25.657834Z","caller":"traceutil/trace.go:171","msg":"trace[15008083] transaction","detail":"{read_only:false; response_revision:23866; number_of_response:1; }","duration":"133.152281ms","start":"2026-06-23T02:01:25.524655Z","end":"2026-06-23T02:01:25.657807Z","steps":["trace[15008083] 'process raft request' (duration: 132.951456ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:03:14.495235Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21831} {"level":"info","ts":"2026-06-23T02:03:14.611334Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21831,"took":"112.337495ms","hash":652581114,"current-db-size-bytes":59236352,"current-db-size":"59 MB","current-db-size-in-use-bytes":44548096,"current-db-size-in-use":"44 MB"} {"level":"info","ts":"2026-06-23T02:03:14.611406Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":652581114,"revision":21831,"compact-revision":19636} {"level":"info","ts":"2026-06-23T02:04:11.020749Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000066d7.wal"} {"level":"info","ts":"2026-06-23T02:05:08.025068Z","caller":"traceutil/trace.go:171","msg":"trace[1957767009] linearizableReadLoop","detail":"{readStateIndex:26950; appliedIndex:26949; }","duration":"125.616429ms","start":"2026-06-23T02:05:07.899427Z","end":"2026-06-23T02:05:08.025043Z","steps":["trace[1957767009] 'read index received' (duration: 125.406034ms)","trace[1957767009] 'applied index is now lower than readState.Index' (duration: 209.535µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T02:05:08.025151Z","caller":"traceutil/trace.go:171","msg":"trace[1126854557] transaction","detail":"{read_only:false; response_revision:26085; number_of_response:1; }","duration":"130.884495ms","start":"2026-06-23T02:05:07.894236Z","end":"2026-06-23T02:05:08.025121Z","steps":["trace[1126854557] 'process raft request' (duration: 130.652849ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:08.025416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.957967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-23T02:05:08.025507Z","caller":"traceutil/trace.go:171","msg":"trace[241142562] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26085; }","duration":"126.08094ms","start":"2026-06-23T02:05:07.899406Z","end":"2026-06-23T02:05:08.025487Z","steps":["trace[241142562] 'agreement among raft nodes before linearized reading' (duration: 125.816773ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:08.157865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.120899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-06-23T02:05:08.157958Z","caller":"traceutil/trace.go:171","msg":"trace[197624400] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26085; }","duration":"128.254933ms","start":"2026-06-23T02:05:08.029681Z","end":"2026-06-23T02:05:08.157936Z","steps":["trace[197624400] 'range keys from in-memory index tree' (duration: 128.004857ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:05:08.158634Z","caller":"traceutil/trace.go:171","msg":"trace[2023975383] transaction","detail":"{read_only:false; response_revision:26086; number_of_response:1; }","duration":"127.897454ms","start":"2026-06-23T02:05:08.030725Z","end":"2026-06-23T02:05:08.158622Z","steps":["trace[2023975383] 'process raft request' (duration: 124.240266ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:05:08.162963Z","caller":"traceutil/trace.go:171","msg":"trace[49601154] transaction","detail":"{read_only:false; response_revision:26087; number_of_response:1; }","duration":"120.740301ms","start":"2026-06-23T02:05:08.042194Z","end":"2026-06-23T02:05:08.162934Z","steps":["trace[49601154] 'process raft request' (duration: 120.588057ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:08.438246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.069484ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T02:05:08.438339Z","caller":"traceutil/trace.go:171","msg":"trace[929433305] linearizableReadLoop","detail":"{readStateIndex:26953; appliedIndex:26952; }","duration":"260.248484ms","start":"2026-06-23T02:05:08.178079Z","end":"2026-06-23T02:05:08.438327Z","steps":["trace[929433305] 'read index received' (duration: 109.040577ms)","trace[929433305] 'applied index is now lower than readState.Index' (duration: 151.206627ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T02:05:08.438392Z","caller":"traceutil/trace.go:171","msg":"trace[152756205] transaction","detail":"{read_only:false; response_revision:26088; number_of_response:1; }","duration":"269.94861ms","start":"2026-06-23T02:05:08.168437Z","end":"2026-06-23T02:05:08.438386Z","steps":["trace[152756205] 'process raft request' (duration: 118.657921ms)","trace[152756205] 'compare' (duration: 143.049449ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T02:05:08.438565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.46685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-23T02:05:08.438663Z","caller":"traceutil/trace.go:171","msg":"trace[557714408] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26088; }","duration":"260.607964ms","start":"2026-06-23T02:05:08.178031Z","end":"2026-06-23T02:05:08.438639Z","steps":["trace[557714408] 'agreement among raft nodes before linearized reading' (duration: 260.376648ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:05:08.589613Z","caller":"traceutil/trace.go:171","msg":"trace[1290396942] transaction","detail":"{read_only:false; response_revision:26089; number_of_response:1; }","duration":"239.269228ms","start":"2026-06-23T02:05:08.350315Z","end":"2026-06-23T02:05:08.589584Z","steps":["trace[1290396942] 'process raft request' (duration: 237.849473ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:05:08.58992Z","caller":"traceutil/trace.go:171","msg":"trace[1902775586] linearizableReadLoop","detail":"{readStateIndex:26954; appliedIndex:26953; }","duration":"151.513284ms","start":"2026-06-23T02:05:08.438354Z","end":"2026-06-23T02:05:08.589867Z","steps":["trace[1902775586] 'read index received' (duration: 149.829103ms)","trace[1902775586] 'applied index is now lower than readState.Index' (duration: 1.677121ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T02:05:08.590082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.834869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T02:05:08.59012Z","caller":"traceutil/trace.go:171","msg":"trace[1246126550] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:26089; }","duration":"186.952392ms","start":"2026-06-23T02:05:08.403159Z","end":"2026-06-23T02:05:08.590112Z","steps":["trace[1246126550] 'agreement among raft nodes before linearized reading' (duration: 186.84753ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:05:08.781308Z","caller":"traceutil/trace.go:171","msg":"trace[337697549] transaction","detail":"{read_only:false; response_revision:26090; number_of_response:1; }","duration":"335.821963ms","start":"2026-06-23T02:05:08.445449Z","end":"2026-06-23T02:05:08.781271Z","steps":["trace[337697549] 'process raft request' (duration: 297.27035ms)","trace[337697549] 'compare' (duration: 38.231435ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T02:05:08.781396Z","caller":"traceutil/trace.go:171","msg":"trace[1582677530] transaction","detail":"{read_only:false; response_revision:26091; number_of_response:1; }","duration":"326.065236ms","start":"2026-06-23T02:05:08.455286Z","end":"2026-06-23T02:05:08.781351Z","steps":["trace[1582677530] 'process raft request' (duration: 325.886961ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:08.78149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:08.445405Z","time spent":"335.986147ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T02:05:08.78168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:08.455264Z","time spent":"326.2202ms","remote":"127.0.0.1:44940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7897,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:05:08.78171Z","caller":"traceutil/trace.go:171","msg":"trace[774005006] transaction","detail":"{read_only:false; response_revision:26092; number_of_response:1; }","duration":"307.65124ms","start":"2026-06-23T02:05:08.474021Z","end":"2026-06-23T02:05:08.781672Z","steps":["trace[774005006] 'process raft request' (duration: 307.256811ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:08.781838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:08.474003Z","time spent":"307.754164ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T02:05:10.312242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.535167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-23T02:05:10.312301Z","caller":"traceutil/trace.go:171","msg":"trace[126926716] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26106; }","duration":"149.6305ms","start":"2026-06-23T02:05:10.162658Z","end":"2026-06-23T02:05:10.312289Z","steps":["trace[126926716] 'range keys from in-memory index tree' (duration: 149.424795ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:10.312825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.911265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-23T02:05:10.312926Z","caller":"traceutil/trace.go:171","msg":"trace[422916680] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26106; }","duration":"145.061319ms","start":"2026-06-23T02:05:10.167841Z","end":"2026-06-23T02:05:10.312902Z","steps":["trace[422916680] 'range keys from in-memory index tree' (duration: 144.733061ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:10.313838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.659386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-06-23T02:05:10.313911Z","caller":"traceutil/trace.go:171","msg":"trace[1594738648] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:26106; }","duration":"136.786078ms","start":"2026-06-23T02:05:10.177108Z","end":"2026-06-23T02:05:10.313894Z","steps":["trace[1594738648] 'count revisions from in-memory index tree' (duration: 136.607674ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:05:10.444582Z","caller":"traceutil/trace.go:171","msg":"trace[986165765] transaction","detail":"{read_only:false; response_revision:26107; number_of_response:1; }","duration":"128.607321ms","start":"2026-06-23T02:05:10.315946Z","end":"2026-06-23T02:05:10.444553Z","steps":["trace[986165765] 'process raft request' (duration: 128.427937ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:05:10.476066Z","caller":"traceutil/trace.go:171","msg":"trace[1564915322] transaction","detail":"{read_only:false; response_revision:26108; number_of_response:1; }","duration":"158.273308ms","start":"2026-06-23T02:05:10.317761Z","end":"2026-06-23T02:05:10.476035Z","steps":["trace[1564915322] 'process raft request' (duration: 158.047373ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:12.984088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.265382ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T02:05:12.984425Z","caller":"traceutil/trace.go:171","msg":"trace[1087498524] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:26142; }","duration":"128.611701ms","start":"2026-06-23T02:05:12.855782Z","end":"2026-06-23T02:05:12.984394Z","steps":["trace[1087498524] 'range keys from in-memory index tree' (duration: 128.244872ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:13.139385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.883089ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-23T02:05:13.139696Z","caller":"traceutil/trace.go:171","msg":"trace[1318137860] linearizableReadLoop","detail":"{readStateIndex:27009; appliedIndex:27007; }","duration":"339.311357ms","start":"2026-06-23T02:05:12.800364Z","end":"2026-06-23T02:05:13.139675Z","steps":["trace[1318137860] 'read index received' (duration: 176.13051ms)","trace[1318137860] 'applied index is now lower than readState.Index' (duration: 163.179407ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T02:05:13.139961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.581704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-23T02:05:13.140063Z","caller":"traceutil/trace.go:171","msg":"trace[1311420567] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26143; }","duration":"339.721226ms","start":"2026-06-23T02:05:12.80032Z","end":"2026-06-23T02:05:13.140042Z","steps":["trace[1311420567] 'agreement among raft nodes before linearized reading' (duration: 339.412289ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:13.140105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:12.8003Z","time spent":"339.795729ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-23T02:05:13.140465Z","caller":"traceutil/trace.go:171","msg":"trace[1458405065] transaction","detail":"{read_only:false; response_revision:26143; number_of_response:1; }","duration":"340.051625ms","start":"2026-06-23T02:05:12.799633Z","end":"2026-06-23T02:05:13.139685Z","steps":["trace[1458405065] 'process raft request' (duration: 339.86871ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:13.140601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:12.799606Z","time spent":"340.923635ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:05:13.311826Z","caller":"traceutil/trace.go:171","msg":"trace[255004263] transaction","detail":"{read_only:false; response_revision:26144; number_of_response:1; }","duration":"270.331868ms","start":"2026-06-23T02:05:13.041459Z","end":"2026-06-23T02:05:13.311791Z","steps":["trace[255004263] 'process raft request' (duration: 243.385437ms)","trace[255004263] 'compare' (duration: 26.684755ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T02:05:13.312013Z","caller":"traceutil/trace.go:171","msg":"trace[905138688] transaction","detail":"{read_only:false; response_revision:26145; number_of_response:1; }","duration":"266.744131ms","start":"2026-06-23T02:05:13.045226Z","end":"2026-06-23T02:05:13.31197Z","steps":["trace[905138688] 'process raft request' (duration: 266.517736ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:05:13.31221Z","caller":"traceutil/trace.go:171","msg":"trace[1172494632] linearizableReadLoop","detail":"{readStateIndex:27011; appliedIndex:27009; }","duration":"172.460962ms","start":"2026-06-23T02:05:13.139736Z","end":"2026-06-23T02:05:13.312197Z","steps":["trace[1172494632] 'read index received' (duration: 145.125281ms)","trace[1172494632] 'applied index is now lower than readState.Index' (duration: 27.332451ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T02:05:13.312176Z","caller":"traceutil/trace.go:171","msg":"trace[236149725] transaction","detail":"{read_only:false; response_revision:26147; number_of_response:1; }","duration":"116.937219ms","start":"2026-06-23T02:05:13.195208Z","end":"2026-06-23T02:05:13.312145Z","steps":["trace[236149725] 'process raft request' (duration: 116.882337ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:05:13.312245Z","caller":"traceutil/trace.go:171","msg":"trace[355482028] transaction","detail":"{read_only:false; response_revision:26146; number_of_response:1; }","duration":"168.942147ms","start":"2026-06-23T02:05:13.143296Z","end":"2026-06-23T02:05:13.312238Z","steps":["trace[355482028] 'process raft request' (duration: 168.68754ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:13.312405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.234785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T02:05:13.312447Z","caller":"traceutil/trace.go:171","msg":"trace[1688410319] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26147; }","duration":"365.328148ms","start":"2026-06-23T02:05:12.947108Z","end":"2026-06-23T02:05:13.312436Z","steps":["trace[1688410319] 'agreement among raft nodes before linearized reading' (duration: 365.195114ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:13.312474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:12.947102Z","time spent":"365.365278ms","remote":"127.0.0.1:43416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-23T02:05:13.312753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.691915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-06-23T02:05:13.312831Z","caller":"traceutil/trace.go:171","msg":"trace[320962266] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:26147; }","duration":"365.914021ms","start":"2026-06-23T02:05:12.946901Z","end":"2026-06-23T02:05:13.312815Z","steps":["trace[320962266] 'agreement among raft nodes before linearized reading' (duration: 365.533892ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:13.312871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:12.946865Z","time spent":"365.992723ms","remote":"127.0.0.1:40074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":163,"response size":32,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"warn","ts":"2026-06-23T02:05:29.813068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.028504ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T02:05:29.81315Z","caller":"traceutil/trace.go:171","msg":"trace[1588066346] transaction","detail":"{read_only:false; response_revision:26277; number_of_response:1; }","duration":"162.91341ms","start":"2026-06-23T02:05:29.650221Z","end":"2026-06-23T02:05:29.813134Z","steps":["trace[1588066346] 'process raft request' (duration: 23.738964ms)","trace[1588066346] 'compare' (duration: 138.937221ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T02:05:30.160647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.017276ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T02:05:30.160866Z","caller":"traceutil/trace.go:171","msg":"trace[1935160423] linearizableReadLoop","detail":"{readStateIndex:27148; appliedIndex:27147; }","duration":"369.590079ms","start":"2026-06-23T02:05:29.791253Z","end":"2026-06-23T02:05:30.160843Z","steps":["trace[1935160423] 'read index received' (duration: 253.226814ms)","trace[1935160423] 'applied index is now lower than readState.Index' (duration: 116.360585ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T02:05:30.161087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.443393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T02:05:30.161196Z","caller":"traceutil/trace.go:171","msg":"trace[2004376054] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26278; }","duration":"213.588446ms","start":"2026-06-23T02:05:29.947591Z","end":"2026-06-23T02:05:30.16118Z","steps":["trace[2004376054] 'agreement among raft nodes before linearized reading' (duration: 213.435583ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:30.161182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.870306ms","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:6"} {"level":"info","ts":"2026-06-23T02:05:30.161741Z","caller":"traceutil/trace.go:171","msg":"trace[1160014041] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:26278; }","duration":"370.48162ms","start":"2026-06-23T02:05:29.791241Z","end":"2026-06-23T02:05:30.161723Z","steps":["trace[1160014041] 'agreement among raft nodes before linearized reading' (duration: 369.799784ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:30.16179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:29.791195Z","time spent":"370.578022ms","remote":"127.0.0.1:42996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-06-23T02:05:30.16212Z","caller":"traceutil/trace.go:171","msg":"trace[411214440] transaction","detail":"{read_only:false; response_revision:26278; number_of_response:1; }","duration":"435.060613ms","start":"2026-06-23T02:05:29.727013Z","end":"2026-06-23T02:05:30.162074Z","steps":["trace[411214440] 'process raft request' (duration: 317.52289ms)","trace[411214440] 'compare' (duration: 115.7351ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T02:05:30.162896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:29.726989Z","time spent":"435.617107ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T02:05:30.656323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.928795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T02:05:30.656416Z","caller":"traceutil/trace.go:171","msg":"trace[28133695] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddressclaims/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddressclaims0; response_count:0; response_revision:26279; }","duration":"188.082199ms","start":"2026-06-23T02:05:30.468311Z","end":"2026-06-23T02:05:30.656394Z","steps":["trace[28133695] 'count revisions from in-memory index tree' (duration: 187.831413ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:30.656693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.795198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesets/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T02:05:30.656798Z","caller":"traceutil/trace.go:171","msg":"trace[1210152665] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesets/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesets0; response_count:0; response_revision:26279; }","duration":"236.974322ms","start":"2026-06-23T02:05:30.419796Z","end":"2026-06-23T02:05:30.656771Z","steps":["trace[1210152665] 'count revisions from in-memory index tree' (duration: 236.643874ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:05:30.765301Z","caller":"traceutil/trace.go:171","msg":"trace[560177252] transaction","detail":"{read_only:false; response_revision:26280; number_of_response:1; }","duration":"103.222247ms","start":"2026-06-23T02:05:30.662056Z","end":"2026-06-23T02:05:30.765279Z","steps":["trace[560177252] 'process raft request' (duration: 103.096364ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:05:30.824099Z","caller":"traceutil/trace.go:171","msg":"trace[774288420] transaction","detail":"{read_only:false; response_revision:26281; number_of_response:1; }","duration":"161.973328ms","start":"2026-06-23T02:05:30.662104Z","end":"2026-06-23T02:05:30.824077Z","steps":["trace[774288420] 'process raft request' (duration: 161.799044ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:05:30.824489Z","caller":"traceutil/trace.go:171","msg":"trace[1888618944] transaction","detail":"{read_only:false; response_revision:26282; number_of_response:1; }","duration":"159.810335ms","start":"2026-06-23T02:05:30.664606Z","end":"2026-06-23T02:05:30.824416Z","steps":["trace[1888618944] 'process raft request' (duration: 159.428826ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:05:30.82451Z","caller":"traceutil/trace.go:171","msg":"trace[2023994901] transaction","detail":"{read_only:false; response_revision:26283; number_of_response:1; }","duration":"154.567939ms","start":"2026-06-23T02:05:30.669907Z","end":"2026-06-23T02:05:30.824475Z","steps":["trace[2023994901] 'process raft request' (duration: 154.416835ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:31.271599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.423262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T02:05:31.271685Z","caller":"traceutil/trace.go:171","msg":"trace[222848662] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26283; }","duration":"323.535486ms","start":"2026-06-23T02:05:30.948132Z","end":"2026-06-23T02:05:31.271667Z","steps":["trace[222848662] 'range keys from in-memory index tree' (duration: 323.269818ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:31.27172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:30.948076Z","time spent":"323.635848ms","remote":"127.0.0.1:43414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-23T02:05:31.77312Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933266701815445305,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-23T02:05:31.876874Z","caller":"traceutil/trace.go:171","msg":"trace[637676795] transaction","detail":"{read_only:false; response_revision:26284; number_of_response:1; }","duration":"624.938427ms","start":"2026-06-23T02:05:31.251908Z","end":"2026-06-23T02:05:31.876847Z","steps":["trace[637676795] 'process raft request' (duration: 624.780452ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:31.877044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:31.251877Z","time spent":"625.07798ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:05:32.422283Z","caller":"traceutil/trace.go:171","msg":"trace[2036363962] transaction","detail":"{read_only:false; response_revision:26285; number_of_response:1; }","duration":"962.91356ms","start":"2026-06-23T02:05:31.45934Z","end":"2026-06-23T02:05:32.422254Z","steps":["trace[2036363962] 'process raft request' (duration: 900.665235ms)","trace[2036363962] 'compare' (duration: 61.969129ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T02:05:32.422446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:31.459314Z","time spent":"963.051604ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:05:32.422584Z","caller":"traceutil/trace.go:171","msg":"trace[228246270] transaction","detail":"{read_only:false; response_revision:26286; number_of_response:1; }","duration":"962.312566ms","start":"2026-06-23T02:05:31.460253Z","end":"2026-06-23T02:05:32.422565Z","steps":["trace[228246270] 'process raft request' (duration: 961.933057ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:32.422676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:31.460226Z","time spent":"962.401717ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:05:32.423016Z","caller":"traceutil/trace.go:171","msg":"trace[771948576] transaction","detail":"{read_only:false; response_revision:26287; number_of_response:1; }","duration":"956.634369ms","start":"2026-06-23T02:05:31.466365Z","end":"2026-06-23T02:05:32.423Z","steps":["trace[771948576] 'process raft request' (duration: 956.123306ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:32.423114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:31.466337Z","time spent":"956.725782ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:05:32.423313Z","caller":"traceutil/trace.go:171","msg":"trace[1632386112] transaction","detail":"{read_only:false; response_revision:26288; number_of_response:1; }","duration":"893.878291ms","start":"2026-06-23T02:05:31.529419Z","end":"2026-06-23T02:05:32.423297Z","steps":["trace[1632386112] 'process raft request' (duration: 893.492651ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:32.423397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:31.529382Z","time spent":"893.968764ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":628,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:05:32.423627Z","caller":"traceutil/trace.go:171","msg":"trace[668036591] transaction","detail":"{read_only:false; response_revision:26289; number_of_response:1; }","duration":"884.157357ms","start":"2026-06-23T02:05:31.539453Z","end":"2026-06-23T02:05:32.42361Z","steps":["trace[668036591] 'process raft request' (duration: 883.778598ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:32.423718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:31.539421Z","time spent":"884.249908ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:05:32.423993Z","caller":"traceutil/trace.go:171","msg":"trace[1330844659] linearizableReadLoop","detail":"{readStateIndex:27159; appliedIndex:27153; }","duration":"1.151231615s","start":"2026-06-23T02:05:31.272743Z","end":"2026-06-23T02:05:32.423975Z","steps":["trace[1330844659] 'read index received' (duration: 603.938547ms)","trace[1330844659] 'applied index is now lower than readState.Index' (duration: 547.290048ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T02:05:32.424122Z","caller":"traceutil/trace.go:171","msg":"trace[930712574] transaction","detail":"{read_only:false; response_revision:26290; number_of_response:1; }","duration":"604.804809ms","start":"2026-06-23T02:05:31.819299Z","end":"2026-06-23T02:05:32.424104Z","steps":["trace[930712574] 'process raft request' (duration: 604.250195ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:32.424208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:31.819273Z","time spent":"604.889101ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T02:05:32.424392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.124664722s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-06-23T02:05:32.424464Z","caller":"traceutil/trace.go:171","msg":"trace[43740293] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26291; }","duration":"1.124750474s","start":"2026-06-23T02:05:31.299679Z","end":"2026-06-23T02:05:32.424429Z","steps":["trace[43740293] 'agreement among raft nodes before linearized reading' (duration: 1.12457184s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:32.424529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:31.299661Z","time spent":"1.124854707s","remote":"127.0.0.1:43580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-06-23T02:05:32.42454Z","caller":"traceutil/trace.go:171","msg":"trace[1769434253] transaction","detail":"{read_only:false; response_revision:26291; number_of_response:1; }","duration":"257.009197ms","start":"2026-06-23T02:05:32.167513Z","end":"2026-06-23T02:05:32.424522Z","steps":["trace[1769434253] 'process raft request' (duration: 256.400982ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:32.424743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.151994335s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-23T02:05:32.424759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.979893ms","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:8"} {"level":"info","ts":"2026-06-23T02:05:32.424786Z","caller":"traceutil/trace.go:171","msg":"trace[660896733] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26291; }","duration":"1.152070236s","start":"2026-06-23T02:05:31.272703Z","end":"2026-06-23T02:05:32.424773Z","steps":["trace[660896733] 'agreement among raft nodes before linearized reading' (duration: 1.151375819s)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:05:32.424804Z","caller":"traceutil/trace.go:171","msg":"trace[1942066980] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:26291; }","duration":"180.063725ms","start":"2026-06-23T02:05:32.244727Z","end":"2026-06-23T02:05:32.42479Z","steps":["trace[1942066980] 'agreement among raft nodes before linearized reading' (duration: 179.986693ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:32.424825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:31.272688Z","time spent":"1.152128068s","remote":"127.0.0.1:43416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-23T02:05:32.42509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.200818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-06-23T02:05:32.42514Z","caller":"traceutil/trace.go:171","msg":"trace[1403496226] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26291; }","duration":"249.28968ms","start":"2026-06-23T02:05:32.175833Z","end":"2026-06-23T02:05:32.425122Z","steps":["trace[1403496226] 'agreement among raft nodes before linearized reading' (duration: 249.165637ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:32.425413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.270885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T02:05:32.42547Z","caller":"traceutil/trace.go:171","msg":"trace[34749204] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:26291; }","duration":"542.366538ms","start":"2026-06-23T02:05:31.883088Z","end":"2026-06-23T02:05:32.425454Z","steps":["trace[34749204] 'agreement among raft nodes before linearized reading' (duration: 542.279096ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:32.425566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:31.88307Z","time spent":"542.43161ms","remote":"127.0.0.1:56130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":29,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "} {"level":"warn","ts":"2026-06-23T02:05:32.425912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"890.474709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-23T02:05:32.425956Z","caller":"traceutil/trace.go:171","msg":"trace[181255411] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26291; }","duration":"890.55013ms","start":"2026-06-23T02:05:31.535394Z","end":"2026-06-23T02:05:32.425944Z","steps":["trace[181255411] 'agreement among raft nodes before linearized reading' (duration: 890.424617ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:32.425995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:31.535382Z","time spent":"890.603222ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-23T02:05:32.60614Z","caller":"traceutil/trace.go:171","msg":"trace[1420072882] linearizableReadLoop","detail":"{readStateIndex:27162; appliedIndex:27161; }","duration":"168.567987ms","start":"2026-06-23T02:05:32.437545Z","end":"2026-06-23T02:05:32.606113Z","steps":["trace[1420072882] 'read index received' (duration: 159.386285ms)","trace[1420072882] 'applied index is now lower than readState.Index' (duration: 9.180552ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T02:05:32.606248Z","caller":"traceutil/trace.go:171","msg":"trace[1666814286] transaction","detail":"{read_only:false; response_revision:26292; number_of_response:1; }","duration":"173.098657ms","start":"2026-06-23T02:05:32.433115Z","end":"2026-06-23T02:05:32.606213Z","steps":["trace[1666814286] 'process raft request' (duration: 163.661599ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:32.606677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.09865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T02:05:32.606937Z","caller":"traceutil/trace.go:171","msg":"trace[1211219699] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26292; }","duration":"169.420948ms","start":"2026-06-23T02:05:32.437497Z","end":"2026-06-23T02:05:32.606918Z","steps":["trace[1211219699] 'agreement among raft nodes before linearized reading' (duration: 169.016998ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:05:32.8147Z","caller":"traceutil/trace.go:171","msg":"trace[355746076] transaction","detail":"{read_only:false; response_revision:26293; number_of_response:1; }","duration":"376.801363ms","start":"2026-06-23T02:05:32.437874Z","end":"2026-06-23T02:05:32.814676Z","steps":["trace[355746076] 'process raft request' (duration: 314.908016ms)","trace[355746076] 'compare' (duration: 61.735944ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T02:05:32.81483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:32.437848Z","time spent":"376.917526ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:05:32.814857Z","caller":"traceutil/trace.go:171","msg":"trace[1743902631] linearizableReadLoop","detail":"{readStateIndex:27164; appliedIndex:27162; }","duration":"208.623745ms","start":"2026-06-23T02:05:32.606206Z","end":"2026-06-23T02:05:32.81483Z","steps":["trace[1743902631] 'read index received' (duration: 146.513663ms)","trace[1743902631] 'applied index is now lower than readState.Index' (duration: 62.109032ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T02:05:32.815026Z","caller":"traceutil/trace.go:171","msg":"trace[1747305884] transaction","detail":"{read_only:false; response_revision:26294; number_of_response:1; }","duration":"289.929542ms","start":"2026-06-23T02:05:32.525086Z","end":"2026-06-23T02:05:32.815016Z","steps":["trace[1747305884] 'process raft request' (duration: 289.549063ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:32.815265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.554032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T02:05:32.815319Z","caller":"traceutil/trace.go:171","msg":"trace[955902880] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:26294; }","duration":"377.712155ms","start":"2026-06-23T02:05:32.437591Z","end":"2026-06-23T02:05:32.815304Z","steps":["trace[955902880] 'agreement among raft nodes before linearized reading' (duration: 377.617793ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:32.815361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:32.437569Z","time spent":"377.783218ms","remote":"127.0.0.1:43584","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" "} {"level":"warn","ts":"2026-06-23T02:05:32.815596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.919631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-06-23T02:05:32.815631Z","caller":"traceutil/trace.go:171","msg":"trace[1013078648] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26294; }","duration":"378.014653ms","start":"2026-06-23T02:05:32.437608Z","end":"2026-06-23T02:05:32.815623Z","steps":["trace[1013078648] 'agreement among raft nodes before linearized reading' (duration: 377.89736ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:32.815657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:32.43759Z","time spent":"378.061104ms","remote":"127.0.0.1:43580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-23T02:05:33.106669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.665699ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-23T02:05:33.106843Z","caller":"traceutil/trace.go:171","msg":"trace[1073228261] linearizableReadLoop","detail":"{readStateIndex:27165; appliedIndex:27164; }","duration":"291.907151ms","start":"2026-06-23T02:05:32.814923Z","end":"2026-06-23T02:05:33.10683Z","steps":["trace[1073228261] 'read index received' (duration: 18.018667ms)","trace[1073228261] 'applied index is now lower than readState.Index' (duration: 273.887754ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T02:05:33.106988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.631586ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T02:05:33.107107Z","caller":"traceutil/trace.go:171","msg":"trace[1125994578] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:26294; }","duration":"251.772119ms","start":"2026-06-23T02:05:32.855316Z","end":"2026-06-23T02:05:33.107088Z","steps":["trace[1125994578] 'range keys from in-memory index tree' (duration: 251.613526ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:33.10717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.052283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-23T02:05:33.107165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.0391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T02:05:33.107199Z","caller":"traceutil/trace.go:171","msg":"trace[459060336] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26294; }","duration":"337.134295ms","start":"2026-06-23T02:05:32.770057Z","end":"2026-06-23T02:05:33.107191Z","steps":["trace[459060336] 'agreement among raft nodes before linearized reading' (duration: 337.027082ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:33.107227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:32.769992Z","time spent":"337.229436ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-23T02:05:33.107237Z","caller":"traceutil/trace.go:171","msg":"trace[1079782222] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26294; }","duration":"499.199153ms","start":"2026-06-23T02:05:32.608017Z","end":"2026-06-23T02:05:33.107216Z","steps":["trace[1079782222] 'agreement among raft nodes before linearized reading' (duration: 499.07241ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:33.107272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:32.607993Z","time spent":"499.271926ms","remote":"127.0.0.1:43416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-23T02:05:33.107413Z","caller":"traceutil/trace.go:171","msg":"trace[1284033868] transaction","detail":"{read_only:false; response_revision:26295; number_of_response:1; }","duration":"275.696419ms","start":"2026-06-23T02:05:32.831703Z","end":"2026-06-23T02:05:33.107399Z","steps":["trace[1284033868] 'process raft request' (duration: 275.050593ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:33.376587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.306324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-23T02:05:33.376671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.258641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"warn","ts":"2026-06-23T02:05:33.376699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.071937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-23T02:05:33.376722Z","caller":"traceutil/trace.go:171","msg":"trace[680196189] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:26295; }","duration":"553.458637ms","start":"2026-06-23T02:05:32.823216Z","end":"2026-06-23T02:05:33.376675Z","steps":["trace[680196189] 'agreement among raft nodes before linearized reading' (duration: 284.218935ms)","trace[680196189] 'range keys from in-memory index tree' (duration: 269.064558ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T02:05:33.376758Z","caller":"traceutil/trace.go:171","msg":"trace[675215264] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26295; }","duration":"548.150678ms","start":"2026-06-23T02:05:32.82859Z","end":"2026-06-23T02:05:33.376741Z","steps":["trace[675215264] 'agreement among raft nodes before linearized reading' (duration: 278.838764ms)","trace[675215264] 'range keys from in-memory index tree' (duration: 269.16922ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T02:05:33.376766Z","caller":"traceutil/trace.go:171","msg":"trace[455793653] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26295; }","duration":"548.340783ms","start":"2026-06-23T02:05:32.828382Z","end":"2026-06-23T02:05:33.376723Z","steps":["trace[455793653] 'agreement among raft nodes before linearized reading' (duration: 279.037319ms)","trace[455793653] 'range keys from in-memory index tree' (duration: 269.12216ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T02:05:33.376798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:32.828582Z","time spent":"548.20863ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-23T02:05:33.376774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:32.823199Z","time spent":"553.56171ms","remote":"127.0.0.1:35394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" "} {"level":"warn","ts":"2026-06-23T02:05:33.376812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:32.828339Z","time spent":"548.462626ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-23T02:05:33.377383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.95039ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T02:05:33.377443Z","caller":"traceutil/trace.go:171","msg":"trace[708091000] transaction","detail":"{read_only:false; response_revision:26296; number_of_response:1; }","duration":"265.093001ms","start":"2026-06-23T02:05:33.11234Z","end":"2026-06-23T02:05:33.377433Z","steps":["trace[708091000] 'process raft request' (duration: 126.035848ms)","trace[708091000] 'compare' (duration: 137.498986ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T02:05:33.377624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.389554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18292"} {"level":"info","ts":"2026-06-23T02:05:33.377696Z","caller":"traceutil/trace.go:171","msg":"trace[870446269] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:26295; }","duration":"560.476296ms","start":"2026-06-23T02:05:32.817181Z","end":"2026-06-23T02:05:33.377658Z","steps":["trace[870446269] 'agreement among raft nodes before linearized reading' (duration: 290.195829ms)","trace[870446269] 'range keys from in-memory index tree' (duration: 268.819733ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T02:05:33.377749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:32.817163Z","time spent":"560.567079ms","remote":"127.0.0.1:43572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":18315,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-06-23T02:05:33.691652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.446531ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T02:05:33.692553Z","caller":"traceutil/trace.go:171","msg":"trace[2072462953] linearizableReadLoop","detail":"{readStateIndex:27169; appliedIndex:27167; }","duration":"309.169908ms","start":"2026-06-23T02:05:33.383363Z","end":"2026-06-23T02:05:33.692533Z","steps":["trace[2072462953] 'read index received' (duration: 147.765464ms)","trace[2072462953] 'applied index is now lower than readState.Index' (duration: 161.403434ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T02:05:33.69286Z","caller":"traceutil/trace.go:171","msg":"trace[636072796] transaction","detail":"{read_only:false; response_revision:26298; number_of_response:1; }","duration":"310.439509ms","start":"2026-06-23T02:05:33.382402Z","end":"2026-06-23T02:05:33.692842Z","steps":["trace[636072796] 'process raft request' (duration: 310.05232ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:33.69298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:33.382386Z","time spent":"310.547842ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T02:05:33.693244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.884916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T02:05:33.693279Z","caller":"traceutil/trace.go:171","msg":"trace[1728991941] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:26298; }","duration":"309.938297ms","start":"2026-06-23T02:05:33.383329Z","end":"2026-06-23T02:05:33.693268Z","steps":["trace[1728991941] 'agreement among raft nodes before linearized reading' (duration: 309.877155ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:33.693315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:33.383321Z","time spent":"309.986388ms","remote":"127.0.0.1:35394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" "} {"level":"warn","ts":"2026-06-23T02:05:33.693558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.045199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-23T02:05:33.693604Z","caller":"traceutil/trace.go:171","msg":"trace[1165551651] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:26298; }","duration":"305.11641ms","start":"2026-06-23T02:05:33.388477Z","end":"2026-06-23T02:05:33.693594Z","steps":["trace[1165551651] 'agreement among raft nodes before linearized reading' (duration: 305.018627ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:33.693636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:33.388462Z","time spent":"305.163431ms","remote":"127.0.0.1:40036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":31,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "} {"level":"info","ts":"2026-06-23T02:05:33.693727Z","caller":"traceutil/trace.go:171","msg":"trace[299190930] transaction","detail":"{read_only:false; response_revision:26297; number_of_response:1; }","duration":"312.279323ms","start":"2026-06-23T02:05:33.381414Z","end":"2026-06-23T02:05:33.693693Z","steps":["trace[299190930] 'process raft request' (duration: 149.697661ms)","trace[299190930] 'compare' (duration: 160.311307ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T02:05:33.693908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.990611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T02:05:33.693977Z","caller":"traceutil/trace.go:171","msg":"trace[441666185] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26298; }","duration":"196.098412ms","start":"2026-06-23T02:05:33.497862Z","end":"2026-06-23T02:05:33.69396Z","steps":["trace[441666185] 'agreement among raft nodes before linearized reading' (duration: 195.98387ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:33.693992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:33.381395Z","time spent":"312.397745ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:05:34.285073Z","caller":"traceutil/trace.go:171","msg":"trace[1503476854] linearizableReadLoop","detail":"{readStateIndex:27170; appliedIndex:27169; }","duration":"335.831083ms","start":"2026-06-23T02:05:33.949209Z","end":"2026-06-23T02:05:34.28504Z","steps":["trace[1503476854] 'read index received' (duration: 335.469405ms)","trace[1503476854] 'applied index is now lower than readState.Index' (duration: 359.698µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T02:05:34.285179Z","caller":"traceutil/trace.go:171","msg":"trace[2127205401] transaction","detail":"{read_only:false; response_revision:26299; number_of_response:1; }","duration":"400.974689ms","start":"2026-06-23T02:05:33.884157Z","end":"2026-06-23T02:05:34.285131Z","steps":["trace[2127205401] 'process raft request' (duration: 400.643811ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:34.285267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.622995ms","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:8"} {"level":"warn","ts":"2026-06-23T02:05:34.285344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:33.884137Z","time spent":"401.117521ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:05:34.285347Z","caller":"traceutil/trace.go:171","msg":"trace[1114254151] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:26299; }","duration":"270.762208ms","start":"2026-06-23T02:05:34.014562Z","end":"2026-06-23T02:05:34.285325Z","steps":["trace[1114254151] 'agreement among raft nodes before linearized reading' (duration: 270.630945ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:34.285273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.036478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-23T02:05:34.285387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.021778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddresses/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddresses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T02:05:34.285433Z","caller":"traceutil/trace.go:171","msg":"trace[2026297770] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26299; }","duration":"336.258093ms","start":"2026-06-23T02:05:33.949159Z","end":"2026-06-23T02:05:34.285417Z","steps":["trace[2026297770] 'agreement among raft nodes before linearized reading' (duration: 336.031058ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:34.285425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.993128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1782"} {"level":"warn","ts":"2026-06-23T02:05:34.285466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:33.949138Z","time spent":"336.321515ms","remote":"127.0.0.1:43414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-23T02:05:34.285464Z","caller":"traceutil/trace.go:171","msg":"trace[597918674] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddresses/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddresses0; response_count:0; response_revision:26299; }","duration":"212.12664ms","start":"2026-06-23T02:05:34.073304Z","end":"2026-06-23T02:05:34.28543Z","steps":["trace[597918674] 'agreement among raft nodes before linearized reading' (duration: 212.011687ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:05:34.285492Z","caller":"traceutil/trace.go:171","msg":"trace[803336950] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:26299; }","duration":"119.113611ms","start":"2026-06-23T02:05:34.166361Z","end":"2026-06-23T02:05:34.285474Z","steps":["trace[803336950] 'agreement among raft nodes before linearized reading' (duration: 118.873945ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:05:34.772411Z","caller":"traceutil/trace.go:171","msg":"trace[1643741824] linearizableReadLoop","detail":"{readStateIndex:27176; appliedIndex:27171; }","duration":"196.414221ms","start":"2026-06-23T02:05:34.57596Z","end":"2026-06-23T02:05:34.772374Z","steps":["trace[1643741824] 'read index received' (duration: 195.929089ms)","trace[1643741824] 'applied index is now lower than readState.Index' (duration: 484.322µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T02:05:34.772618Z","caller":"traceutil/trace.go:171","msg":"trace[325279446] transaction","detail":"{read_only:false; response_revision:26304; number_of_response:1; }","duration":"342.475143ms","start":"2026-06-23T02:05:34.430113Z","end":"2026-06-23T02:05:34.772588Z","steps":["trace[325279446] 'process raft request' (duration: 342.121654ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:05:34.772729Z","caller":"traceutil/trace.go:171","msg":"trace[484649260] transaction","detail":"{read_only:false; response_revision:26302; number_of_response:1; }","duration":"342.875943ms","start":"2026-06-23T02:05:34.429812Z","end":"2026-06-23T02:05:34.772688Z","steps":["trace[484649260] 'process raft request' (duration: 342.33714ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:34.7728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:34.430099Z","time spent":"342.601096ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T02:05:34.772825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.635418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-06-23T02:05:34.772848Z","caller":"traceutil/trace.go:171","msg":"trace[1974434180] transaction","detail":"{read_only:false; response_revision:26305; number_of_response:1; }","duration":"342.415931ms","start":"2026-06-23T02:05:34.430409Z","end":"2026-06-23T02:05:34.772825Z","steps":["trace[1974434180] 'process raft request' (duration: 341.870798ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:05:34.772883Z","caller":"traceutil/trace.go:171","msg":"trace[1605355135] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26305; }","duration":"163.749681ms","start":"2026-06-23T02:05:34.609119Z","end":"2026-06-23T02:05:34.772869Z","steps":["trace[1605355135] 'agreement among raft nodes before linearized reading' (duration: 163.546276ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:34.772947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:34.429789Z","time spent":"343.049447ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T02:05:34.772975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:34.430393Z","time spent":"342.498624ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:05:34.772976Z","caller":"traceutil/trace.go:171","msg":"trace[502493827] transaction","detail":"{read_only:false; response_revision:26301; number_of_response:1; }","duration":"343.536949ms","start":"2026-06-23T02:05:34.429425Z","end":"2026-06-23T02:05:34.772962Z","steps":["trace[502493827] 'process raft request' (duration: 342.530845ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:05:34.773007Z","caller":"traceutil/trace.go:171","msg":"trace[643510916] transaction","detail":"{read_only:false; response_revision:26303; number_of_response:1; }","duration":"343.097058ms","start":"2026-06-23T02:05:34.429901Z","end":"2026-06-23T02:05:34.772998Z","steps":["trace[643510916] 'process raft request' (duration: 342.293938ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:34.772769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.792379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"warn","ts":"2026-06-23T02:05:34.773082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:34.429875Z","time spent":"343.153899ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:05:34.77311Z","caller":"traceutil/trace.go:171","msg":"trace[1654806730] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:26305; }","duration":"197.183889ms","start":"2026-06-23T02:05:34.575915Z","end":"2026-06-23T02:05:34.773099Z","steps":["trace[1654806730] 'agreement among raft nodes before linearized reading' (duration: 196.678817ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:34.773057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:34.4294Z","time spent":"343.61279ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:05:46.021621Z","caller":"traceutil/trace.go:171","msg":"trace[278483064] linearizableReadLoop","detail":"{readStateIndex:27258; appliedIndex:27257; }","duration":"239.998565ms","start":"2026-06-23T02:05:45.781603Z","end":"2026-06-23T02:05:46.021601Z","steps":["trace[278483064] 'read index received' (duration: 239.854152ms)","trace[278483064] 'applied index is now lower than readState.Index' (duration: 143.783µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T02:05:46.021694Z","caller":"traceutil/trace.go:171","msg":"trace[634369499] transaction","detail":"{read_only:false; response_revision:26385; number_of_response:1; }","duration":"256.085245ms","start":"2026-06-23T02:05:45.765584Z","end":"2026-06-23T02:05:46.021669Z","steps":["trace[634369499] 'process raft request' (duration: 255.860979ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:46.021864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.24076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-23T02:05:46.021935Z","caller":"traceutil/trace.go:171","msg":"trace[937469054] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26385; }","duration":"240.368154ms","start":"2026-06-23T02:05:45.781548Z","end":"2026-06-23T02:05:46.021917Z","steps":["trace[937469054] 'agreement among raft nodes before linearized reading' (duration: 240.136078ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:05:46.318452Z","caller":"traceutil/trace.go:171","msg":"trace[1372076423] transaction","detail":"{read_only:false; response_revision:26386; number_of_response:1; }","duration":"292.336001ms","start":"2026-06-23T02:05:46.026086Z","end":"2026-06-23T02:05:46.318422Z","steps":["trace[1372076423] 'process raft request' (duration: 251.945594ms)","trace[1372076423] 'compare' (duration: 39.965827ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T02:05:46.893164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.851124ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T02:05:46.894569Z","caller":"traceutil/trace.go:171","msg":"trace[968840557] transaction","detail":"{read_only:false; response_revision:26387; number_of_response:1; }","duration":"558.15782ms","start":"2026-06-23T02:05:46.336373Z","end":"2026-06-23T02:05:46.894531Z","steps":["trace[968840557] 'process raft request' (duration: 282.810411ms)","trace[968840557] 'compare' (duration: 273.301411ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T02:05:46.894958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:46.336345Z","time spent":"558.306853ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:05:46.895326Z","caller":"traceutil/trace.go:171","msg":"trace[535721723] linearizableReadLoop","detail":"{readStateIndex:27261; appliedIndex:27259; }","duration":"323.715291ms","start":"2026-06-23T02:05:46.571591Z","end":"2026-06-23T02:05:46.895307Z","steps":["trace[535721723] 'read index received' (duration: 47.605102ms)","trace[535721723] 'applied index is now lower than readState.Index' (duration: 276.108999ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T02:05:46.895328Z","caller":"traceutil/trace.go:171","msg":"trace[693970392] transaction","detail":"{read_only:false; response_revision:26388; number_of_response:1; }","duration":"479.738424ms","start":"2026-06-23T02:05:46.415552Z","end":"2026-06-23T02:05:46.89529Z","steps":["trace[693970392] 'process raft request' (duration: 477.730196ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:05:46.895427Z","caller":"traceutil/trace.go:171","msg":"trace[107496461] transaction","detail":"{read_only:false; response_revision:26389; number_of_response:1; }","duration":"294.013531ms","start":"2026-06-23T02:05:46.601382Z","end":"2026-06-23T02:05:46.895395Z","steps":["trace[107496461] 'process raft request' (duration: 293.842197ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:46.895463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.862264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-23T02:05:46.895469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:46.415526Z","time spent":"479.886198ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:05:46.895526Z","caller":"traceutil/trace.go:171","msg":"trace[491244911] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0; response_count:0; response_revision:26389; }","duration":"323.978377ms","start":"2026-06-23T02:05:46.571534Z","end":"2026-06-23T02:05:46.895512Z","steps":["trace[491244911] 'agreement among raft nodes before linearized reading' (duration: 323.873224ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:46.895557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:46.57151Z","time spent":"324.039429ms","remote":"127.0.0.1:56126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0\" count_only:true "} {"level":"info","ts":"2026-06-23T02:05:47.471465Z","caller":"traceutil/trace.go:171","msg":"trace[1062097995] transaction","detail":"{read_only:false; response_revision:26390; number_of_response:1; }","duration":"624.266039ms","start":"2026-06-23T02:05:46.847169Z","end":"2026-06-23T02:05:47.471435Z","steps":["trace[1062097995] 'process raft request' (duration: 555.354213ms)","trace[1062097995] 'compare' (duration: 68.313992ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T02:05:47.471642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:46.847141Z","time spent":"624.411163ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:05:47.476743Z","caller":"traceutil/trace.go:171","msg":"trace[859775456] linearizableReadLoop","detail":"{readStateIndex:27267; appliedIndex:27262; }","duration":"570.009386ms","start":"2026-06-23T02:05:46.90672Z","end":"2026-06-23T02:05:47.47673Z","steps":["trace[859775456] 'read index received' (duration: 495.817632ms)","trace[859775456] 'applied index is now lower than readState.Index' (duration: 74.190264ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T02:05:47.476919Z","caller":"traceutil/trace.go:171","msg":"trace[388650241] transaction","detail":"{read_only:false; response_revision:26391; number_of_response:1; }","duration":"580.999942ms","start":"2026-06-23T02:05:46.895909Z","end":"2026-06-23T02:05:47.476909Z","steps":["trace[388650241] 'process raft request' (duration: 580.558272ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:47.477177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:46.895884Z","time spent":"581.055723ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:05:47.477279Z","caller":"traceutil/trace.go:171","msg":"trace[1171009589] transaction","detail":"{read_only:false; response_revision:26392; number_of_response:1; }","duration":"577.890317ms","start":"2026-06-23T02:05:46.899382Z","end":"2026-06-23T02:05:47.477272Z","steps":["trace[1171009589] 'process raft request' (duration: 577.16082ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:47.477317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:46.899365Z","time spent":"577.932788ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:05:47.477403Z","caller":"traceutil/trace.go:171","msg":"trace[1174817337] transaction","detail":"{read_only:false; response_revision:26393; number_of_response:1; }","duration":"575.271304ms","start":"2026-06-23T02:05:46.902123Z","end":"2026-06-23T02:05:47.477395Z","steps":["trace[1174817337] 'process raft request' (duration: 574.454994ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:47.477445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:46.902097Z","time spent":"575.327205ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:05:47.477567Z","caller":"traceutil/trace.go:171","msg":"trace[1080577265] transaction","detail":"{read_only:false; response_revision:26394; number_of_response:1; }","duration":"574.022693ms","start":"2026-06-23T02:05:46.903537Z","end":"2026-06-23T02:05:47.47756Z","steps":["trace[1080577265] 'process raft request' (duration: 573.118261ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:47.477608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:46.903527Z","time spent":"574.058863ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:05:47.477698Z","caller":"traceutil/trace.go:171","msg":"trace[1857610888] transaction","detail":"{read_only:false; response_revision:26395; number_of_response:1; }","duration":"259.463526ms","start":"2026-06-23T02:05:47.218226Z","end":"2026-06-23T02:05:47.477689Z","steps":["trace[1857610888] 'process raft request' (duration: 258.469951ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:47.477859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.137904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-23T02:05:47.477886Z","caller":"traceutil/trace.go:171","msg":"trace[1013622479] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26395; }","duration":"571.187215ms","start":"2026-06-23T02:05:46.906692Z","end":"2026-06-23T02:05:47.477879Z","steps":["trace[1013622479] 'agreement among raft nodes before linearized reading' (duration: 571.099033ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:47.477904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:46.906683Z","time spent":"571.215826ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-23T02:05:48.093797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.801007ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T02:05:48.09402Z","caller":"traceutil/trace.go:171","msg":"trace[340051771] linearizableReadLoop","detail":"{readStateIndex:27269; appliedIndex:27268; }","duration":"617.21572ms","start":"2026-06-23T02:05:47.476781Z","end":"2026-06-23T02:05:48.093997Z","steps":["trace[340051771] 'read index received' (duration: 349.112415ms)","trace[340051771] 'applied index is now lower than readState.Index' (duration: 268.101975ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T02:05:48.094132Z","caller":"traceutil/trace.go:171","msg":"trace[172986697] transaction","detail":"{read_only:false; response_revision:26396; number_of_response:1; }","duration":"641.094587ms","start":"2026-06-23T02:05:47.453026Z","end":"2026-06-23T02:05:48.09412Z","steps":["trace[172986697] 'process raft request' (duration: 372.852318ms)","trace[172986697] 'compare' (duration: 267.580312ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T02:05:48.094209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:47.453001Z","time spent":"641.165258ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":628,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T02:05:48.094461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"959.054718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-23T02:05:48.094539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.156765858s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-23T02:05:48.094549Z","caller":"traceutil/trace.go:171","msg":"trace[2095414098] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:26397; }","duration":"959.203271ms","start":"2026-06-23T02:05:47.135325Z","end":"2026-06-23T02:05:48.094529Z","steps":["trace[2095414098] 'agreement among raft nodes before linearized reading' (duration: 959.004877ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:48.094546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"704.772077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T02:05:48.094589Z","caller":"traceutil/trace.go:171","msg":"trace[1053745697] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26397; }","duration":"1.156844071s","start":"2026-06-23T02:05:46.937734Z","end":"2026-06-23T02:05:48.094578Z","steps":["trace[1053745697] 'agreement among raft nodes before linearized reading' (duration: 1.156698467s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:48.0946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:47.135304Z","time spent":"959.284883ms","remote":"127.0.0.1:41236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-06-23T02:05:48.094623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:46.937717Z","time spent":"1.156900193s","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-23T02:05:48.094629Z","caller":"traceutil/trace.go:171","msg":"trace[842214855] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26397; }","duration":"704.89991ms","start":"2026-06-23T02:05:47.38971Z","end":"2026-06-23T02:05:48.09461Z","steps":["trace[842214855] 'agreement among raft nodes before linearized reading' (duration: 704.757587ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:48.094615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.856608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-23T02:05:48.094628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"618.178512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-23T02:05:48.09467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:47.389691Z","time spent":"704.971662ms","remote":"127.0.0.1:43414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-23T02:05:48.094641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.894717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T02:05:48.09471Z","caller":"traceutil/trace.go:171","msg":"trace[1020667383] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26397; }","duration":"145.984251ms","start":"2026-06-23T02:05:47.948702Z","end":"2026-06-23T02:05:48.094686Z","steps":["trace[1020667383] 'agreement among raft nodes before linearized reading' (duration: 145.824947ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:05:48.094725Z","caller":"traceutil/trace.go:171","msg":"trace[783531617] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26397; }","duration":"618.304096ms","start":"2026-06-23T02:05:47.476399Z","end":"2026-06-23T02:05:48.094703Z","steps":["trace[783531617] 'agreement among raft nodes before linearized reading' (duration: 618.06487ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:05:48.094749Z","caller":"traceutil/trace.go:171","msg":"trace[340394660] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:0; response_revision:26397; }","duration":"246.039511ms","start":"2026-06-23T02:05:47.848688Z","end":"2026-06-23T02:05:48.094727Z","steps":["trace[340394660] 'agreement among raft nodes before linearized reading' (duration: 245.850967ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:05:48.094595Z","caller":"traceutil/trace.go:171","msg":"trace[1857399228] transaction","detail":"{read_only:false; response_revision:26397; number_of_response:1; }","duration":"611.44669ms","start":"2026-06-23T02:05:47.482774Z","end":"2026-06-23T02:05:48.094221Z","steps":["trace[1857399228] 'process raft request' (duration: 611.151233ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:48.094786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:47.476384Z","time spent":"618.388077ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-23T02:05:48.094626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.25529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.3\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-23T02:05:48.094842Z","caller":"traceutil/trace.go:171","msg":"trace[1914082362] range","detail":"{range_begin:/registry/masterleases/199.204.45.3; range_end:; response_count:1; response_revision:26397; }","duration":"610.489147ms","start":"2026-06-23T02:05:47.484341Z","end":"2026-06-23T02:05:48.09483Z","steps":["trace[1914082362] 'agreement among raft nodes before linearized reading' (duration: 610.145298ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:48.094887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:47.484331Z","time spent":"610.545058ms","remote":"127.0.0.1:43446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.3\" "} {"level":"warn","ts":"2026-06-23T02:05:48.094947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:05:47.482756Z","time spent":"612.057334ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:05:48.422425Z","caller":"traceutil/trace.go:171","msg":"trace[1128609804] linearizableReadLoop","detail":"{readStateIndex:27276; appliedIndex:27275; }","duration":"249.080225ms","start":"2026-06-23T02:05:48.173321Z","end":"2026-06-23T02:05:48.422401Z","steps":["trace[1128609804] 'read index received' (duration: 248.87821ms)","trace[1128609804] 'applied index is now lower than readState.Index' (duration: 201.184µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T02:05:48.422539Z","caller":"traceutil/trace.go:171","msg":"trace[1543694080] transaction","detail":"{read_only:false; response_revision:26402; number_of_response:1; }","duration":"295.512638ms","start":"2026-06-23T02:05:48.127013Z","end":"2026-06-23T02:05:48.422525Z","steps":["trace[1543694080] 'process raft request' (duration: 295.248772ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:48.422824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.936277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-23T02:05:48.422935Z","caller":"traceutil/trace.go:171","msg":"trace[1615204430] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:26402; }","duration":"119.107152ms","start":"2026-06-23T02:05:48.303799Z","end":"2026-06-23T02:05:48.422906Z","steps":["trace[1615204430] 'agreement among raft nodes before linearized reading' (duration: 118.780794ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:48.422849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.507604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-06-23T02:05:48.423034Z","caller":"traceutil/trace.go:171","msg":"trace[279300807] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:26402; }","duration":"249.706339ms","start":"2026-06-23T02:05:48.173308Z","end":"2026-06-23T02:05:48.423014Z","steps":["trace[279300807] 'agreement among raft nodes before linearized reading' (duration: 249.31069ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:49.849345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.036236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T02:05:49.849431Z","caller":"traceutil/trace.go:171","msg":"trace[984359287] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:26467; }","duration":"147.178839ms","start":"2026-06-23T02:05:49.702234Z","end":"2026-06-23T02:05:49.849413Z","steps":["trace[984359287] 'count revisions from in-memory index tree' (duration: 146.955363ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:49.849597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.285474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-014b5bff-3ec0-4b4b-a4cb-dfcf3872e1d4\" ","response":"range_response_count:1 size:3642"} {"level":"info","ts":"2026-06-23T02:05:49.84967Z","caller":"traceutil/trace.go:171","msg":"trace[1330798593] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-014b5bff-3ec0-4b4b-a4cb-dfcf3872e1d4; range_end:; response_count:1; response_revision:26467; }","duration":"212.409887ms","start":"2026-06-23T02:05:49.637245Z","end":"2026-06-23T02:05:49.849655Z","steps":["trace[1330798593] 'range keys from in-memory index tree' (duration: 212.094921ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:05:49.850682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.960626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-06-23T02:05:49.850747Z","caller":"traceutil/trace.go:171","msg":"trace[716203581] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:26467; }","duration":"114.055399ms","start":"2026-06-23T02:05:49.736672Z","end":"2026-06-23T02:05:49.850728Z","steps":["trace[716203581] 'count revisions from in-memory index tree' (duration: 113.839333ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:05:51.606758Z","caller":"traceutil/trace.go:171","msg":"trace[1257161179] transaction","detail":"{read_only:false; response_revision:26481; number_of_response:1; }","duration":"124.387658ms","start":"2026-06-23T02:05:51.482349Z","end":"2026-06-23T02:05:51.606737Z","steps":["trace[1257161179] 'process raft request' (duration: 124.251415ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:05:51.766908Z","caller":"traceutil/trace.go:171","msg":"trace[216685738] transaction","detail":"{read_only:false; response_revision:26482; number_of_response:1; }","duration":"278.545678ms","start":"2026-06-23T02:05:51.488328Z","end":"2026-06-23T02:05:51.766874Z","steps":["trace[216685738] 'process raft request' (duration: 264.826166ms)","trace[216685738] 'compare' (duration: 13.516968ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T02:05:51.76714Z","caller":"traceutil/trace.go:171","msg":"trace[810642528] transaction","detail":"{read_only:false; response_revision:26483; number_of_response:1; }","duration":"275.084193ms","start":"2026-06-23T02:05:51.492027Z","end":"2026-06-23T02:05:51.767112Z","steps":["trace[810642528] 'process raft request' (duration: 274.792126ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:05:51.767265Z","caller":"traceutil/trace.go:171","msg":"trace[2096132850] transaction","detail":"{read_only:false; response_revision:26486; number_of_response:1; }","duration":"274.463859ms","start":"2026-06-23T02:05:51.492774Z","end":"2026-06-23T02:05:51.767238Z","steps":["trace[2096132850] 'process raft request' (duration: 274.414808ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:05:51.76736Z","caller":"traceutil/trace.go:171","msg":"trace[2003885483] transaction","detail":"{read_only:false; response_revision:26484; number_of_response:1; }","duration":"274.841968ms","start":"2026-06-23T02:05:51.492507Z","end":"2026-06-23T02:05:51.767349Z","steps":["trace[2003885483] 'process raft request' (duration: 274.49961ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:05:51.767441Z","caller":"traceutil/trace.go:171","msg":"trace[1808874831] transaction","detail":"{read_only:false; response_revision:26485; number_of_response:1; }","duration":"274.837028ms","start":"2026-06-23T02:05:51.492597Z","end":"2026-06-23T02:05:51.767434Z","steps":["trace[1808874831] 'process raft request' (duration: 274.553041ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:02.103216Z","caller":"traceutil/trace.go:171","msg":"trace[613254123] transaction","detail":"{read_only:false; response_revision:26584; number_of_response:1; }","duration":"249.813332ms","start":"2026-06-23T02:06:01.853377Z","end":"2026-06-23T02:06:02.103191Z","steps":["trace[613254123] 'process raft request' (duration: 249.697859ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:02.103218Z","caller":"traceutil/trace.go:171","msg":"trace[1364703150] transaction","detail":"{read_only:false; response_revision:26583; number_of_response:1; }","duration":"251.107343ms","start":"2026-06-23T02:06:01.85207Z","end":"2026-06-23T02:06:02.103177Z","steps":["trace[1364703150] 'process raft request' (duration: 250.824786ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:02.103528Z","caller":"traceutil/trace.go:171","msg":"trace[1599809953] transaction","detail":"{read_only:false; response_revision:26586; number_of_response:1; }","duration":"243.082109ms","start":"2026-06-23T02:06:01.860434Z","end":"2026-06-23T02:06:02.103516Z","steps":["trace[1599809953] 'process raft request' (duration: 242.986837ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:02.103525Z","caller":"traceutil/trace.go:171","msg":"trace[1429455731] linearizableReadLoop","detail":"{readStateIndex:27462; appliedIndex:27458; }","duration":"156.019533ms","start":"2026-06-23T02:06:01.947486Z","end":"2026-06-23T02:06:02.103505Z","steps":["trace[1429455731] 'read index received' (duration: 155.284425ms)","trace[1429455731] 'applied index is now lower than readState.Index' (duration: 734.318µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T02:06:02.103524Z","caller":"traceutil/trace.go:171","msg":"trace[1952145358] transaction","detail":"{read_only:false; response_revision:26585; number_of_response:1; }","duration":"243.478608ms","start":"2026-06-23T02:06:01.860012Z","end":"2026-06-23T02:06:02.103491Z","steps":["trace[1952145358] 'process raft request' (duration: 243.112169ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:06:02.103671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.183948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T02:06:02.103694Z","caller":"traceutil/trace.go:171","msg":"trace[1512790282] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26586; }","duration":"156.244309ms","start":"2026-06-23T02:06:01.947442Z","end":"2026-06-23T02:06:02.103686Z","steps":["trace[1512790282] 'agreement among raft nodes before linearized reading' (duration: 156.167037ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:06:02.103766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.002578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-23T02:06:02.103851Z","caller":"traceutil/trace.go:171","msg":"trace[1735336775] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:26586; }","duration":"133.13671ms","start":"2026-06-23T02:06:01.970693Z","end":"2026-06-23T02:06:02.103829Z","steps":["trace[1735336775] 'agreement among raft nodes before linearized reading' (duration: 132.956216ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:02.380918Z","caller":"traceutil/trace.go:171","msg":"trace[416878805] transaction","detail":"{read_only:false; response_revision:26588; number_of_response:1; }","duration":"121.12996ms","start":"2026-06-23T02:06:02.259761Z","end":"2026-06-23T02:06:02.380891Z","steps":["trace[416878805] 'process raft request' (duration: 108.791852ms)","trace[416878805] 'compare' (duration: 12.239205ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T02:06:02.450516Z","caller":"traceutil/trace.go:171","msg":"trace[383950809] transaction","detail":"{read_only:false; response_revision:26589; number_of_response:1; }","duration":"186.90715ms","start":"2026-06-23T02:06:02.263583Z","end":"2026-06-23T02:06:02.450491Z","steps":["trace[383950809] 'process raft request' (duration: 186.717606ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:02.450741Z","caller":"traceutil/trace.go:171","msg":"trace[797994139] transaction","detail":"{read_only:false; response_revision:26590; number_of_response:1; }","duration":"187.056253ms","start":"2026-06-23T02:06:02.263652Z","end":"2026-06-23T02:06:02.450708Z","steps":["trace[797994139] 'process raft request' (duration: 186.799177ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:05.264976Z","caller":"traceutil/trace.go:171","msg":"trace[326466347] transaction","detail":"{read_only:false; response_revision:26607; number_of_response:1; }","duration":"228.066786ms","start":"2026-06-23T02:06:05.036886Z","end":"2026-06-23T02:06:05.264952Z","steps":["trace[326466347] 'process raft request' (duration: 227.915212ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:05.303437Z","caller":"traceutil/trace.go:171","msg":"trace[1024134376] transaction","detail":"{read_only:false; response_revision:26608; number_of_response:1; }","duration":"265.796449ms","start":"2026-06-23T02:06:05.037582Z","end":"2026-06-23T02:06:05.303378Z","steps":["trace[1024134376] 'process raft request' (duration: 265.512422ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:09.50682Z","caller":"traceutil/trace.go:171","msg":"trace[1176980021] transaction","detail":"{read_only:false; response_revision:26642; number_of_response:1; }","duration":"146.670057ms","start":"2026-06-23T02:06:09.360121Z","end":"2026-06-23T02:06:09.506791Z","steps":["trace[1176980021] 'process raft request' (duration: 146.499393ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:09.542578Z","caller":"traceutil/trace.go:171","msg":"trace[388245329] linearizableReadLoop","detail":"{readStateIndex:27521; appliedIndex:27519; }","duration":"135.986059ms","start":"2026-06-23T02:06:09.406567Z","end":"2026-06-23T02:06:09.542553Z","steps":["trace[388245329] 'read index received' (duration: 100.068251ms)","trace[388245329] 'applied index is now lower than readState.Index' (duration: 35.916418ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T02:06:09.542722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.136383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T02:06:09.542728Z","caller":"traceutil/trace.go:171","msg":"trace[2137538326] transaction","detail":"{read_only:false; response_revision:26643; number_of_response:1; }","duration":"181.787447ms","start":"2026-06-23T02:06:09.360905Z","end":"2026-06-23T02:06:09.542692Z","steps":["trace[2137538326] 'process raft request' (duration: 181.50462ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:09.542862Z","caller":"traceutil/trace.go:171","msg":"trace[193123551] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26643; }","duration":"136.227575ms","start":"2026-06-23T02:06:09.406512Z","end":"2026-06-23T02:06:09.54274Z","steps":["trace[193123551] 'agreement among raft nodes before linearized reading' (duration: 136.123652ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:21.453601Z","caller":"traceutil/trace.go:171","msg":"trace[1859614749] transaction","detail":"{read_only:false; response_revision:26740; number_of_response:1; }","duration":"237.162786ms","start":"2026-06-23T02:06:21.216414Z","end":"2026-06-23T02:06:21.453577Z","steps":["trace[1859614749] 'process raft request' (duration: 236.688765ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:22.085717Z","caller":"traceutil/trace.go:171","msg":"trace[2075288416] linearizableReadLoop","detail":"{readStateIndex:27624; appliedIndex:27623; }","duration":"114.742804ms","start":"2026-06-23T02:06:21.970947Z","end":"2026-06-23T02:06:22.08569Z","steps":["trace[2075288416] 'read index received' (duration: 114.616221ms)","trace[2075288416] 'applied index is now lower than readState.Index' (duration: 125.223µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T02:06:22.085762Z","caller":"traceutil/trace.go:171","msg":"trace[209751500] transaction","detail":"{read_only:false; response_revision:26744; number_of_response:1; }","duration":"121.344434ms","start":"2026-06-23T02:06:21.96439Z","end":"2026-06-23T02:06:22.085735Z","steps":["trace[209751500] 'process raft request' (duration: 121.109619ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:06:22.086085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.109245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T02:06:22.08618Z","caller":"traceutil/trace.go:171","msg":"trace[1196763062] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26744; }","duration":"115.271608ms","start":"2026-06-23T02:06:21.970887Z","end":"2026-06-23T02:06:22.086159Z","steps":["trace[1196763062] 'agreement among raft nodes before linearized reading' (duration: 114.92444ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:22.360195Z","caller":"traceutil/trace.go:171","msg":"trace[794700645] linearizableReadLoop","detail":"{readStateIndex:27625; appliedIndex:27624; }","duration":"274.379576ms","start":"2026-06-23T02:06:22.08579Z","end":"2026-06-23T02:06:22.360169Z","steps":["trace[794700645] 'read index received' (duration: 244.458673ms)","trace[794700645] 'applied index is now lower than readState.Index' (duration: 29.919703ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T02:06:22.360235Z","caller":"traceutil/trace.go:171","msg":"trace[1167711240] transaction","detail":"{read_only:false; response_revision:26745; number_of_response:1; }","duration":"383.612637ms","start":"2026-06-23T02:06:21.976597Z","end":"2026-06-23T02:06:22.36021Z","steps":["trace[1167711240] 'process raft request' (duration: 353.637893ms)","trace[1167711240] 'compare' (duration: 29.80942ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T02:06:22.360607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:06:21.976574Z","time spent":"383.922356ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T02:06:22.360769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.890457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-23T02:06:22.360946Z","caller":"traceutil/trace.go:171","msg":"trace[1212978693] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:26745; }","duration":"284.106882ms","start":"2026-06-23T02:06:22.076817Z","end":"2026-06-23T02:06:22.360924Z","steps":["trace[1212978693] 'agreement among raft nodes before linearized reading' (duration: 283.59602ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:22.361375Z","caller":"traceutil/trace.go:171","msg":"trace[1916289102] transaction","detail":"{read_only:false; response_revision:26747; number_of_response:1; }","duration":"187.972377ms","start":"2026-06-23T02:06:22.173379Z","end":"2026-06-23T02:06:22.361352Z","steps":["trace[1916289102] 'process raft request' (duration: 187.865274ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:22.361372Z","caller":"traceutil/trace.go:171","msg":"trace[2119261863] transaction","detail":"{read_only:false; response_revision:26746; number_of_response:1; }","duration":"193.374297ms","start":"2026-06-23T02:06:22.167967Z","end":"2026-06-23T02:06:22.361341Z","steps":["trace[2119261863] 'process raft request' (duration: 193.177523ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:22.361685Z","caller":"traceutil/trace.go:171","msg":"trace[871474298] transaction","detail":"{read_only:false; response_revision:26748; number_of_response:1; }","duration":"187.319431ms","start":"2026-06-23T02:06:22.174353Z","end":"2026-06-23T02:06:22.361673Z","steps":["trace[871474298] 'process raft request' (duration: 186.945012ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:22.361701Z","caller":"traceutil/trace.go:171","msg":"trace[865441419] transaction","detail":"{read_only:false; response_revision:26749; number_of_response:1; }","duration":"185.049906ms","start":"2026-06-23T02:06:22.176631Z","end":"2026-06-23T02:06:22.361681Z","steps":["trace[865441419] 'process raft request' (duration: 184.76847ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:22.505078Z","caller":"traceutil/trace.go:171","msg":"trace[1048759875] transaction","detail":"{read_only:false; response_revision:26750; number_of_response:1; }","duration":"138.018498ms","start":"2026-06-23T02:06:22.367032Z","end":"2026-06-23T02:06:22.50505Z","steps":["trace[1048759875] 'process raft request' (duration: 131.584533ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:22.742097Z","caller":"traceutil/trace.go:171","msg":"trace[23181922] linearizableReadLoop","detail":"{readStateIndex:27631; appliedIndex:27630; }","duration":"152.867948ms","start":"2026-06-23T02:06:22.589204Z","end":"2026-06-23T02:06:22.742072Z","steps":["trace[23181922] 'read index received' (duration: 152.693194ms)","trace[23181922] 'applied index is now lower than readState.Index' (duration: 173.424µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T02:06:22.742414Z","caller":"traceutil/trace.go:171","msg":"trace[911397207] transaction","detail":"{read_only:false; response_revision:26751; number_of_response:1; }","duration":"192.938337ms","start":"2026-06-23T02:06:22.54946Z","end":"2026-06-23T02:06:22.742399Z","steps":["trace[911397207] 'process raft request' (duration: 192.453505ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:06:22.742714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.499503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-06-23T02:06:22.742751Z","caller":"traceutil/trace.go:171","msg":"trace[1011084046] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26751; }","duration":"153.571864ms","start":"2026-06-23T02:06:22.589168Z","end":"2026-06-23T02:06:22.74274Z","steps":["trace[1011084046] 'agreement among raft nodes before linearized reading' (duration: 153.429881ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:06:22.74279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.428241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-23T02:06:22.742852Z","caller":"traceutil/trace.go:171","msg":"trace[1554916204] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26751; }","duration":"129.518262ms","start":"2026-06-23T02:06:22.613318Z","end":"2026-06-23T02:06:22.742836Z","steps":["trace[1554916204] 'agreement among raft nodes before linearized reading' (duration: 129.310747ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:06:22.742928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.669993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-23T02:06:22.743015Z","caller":"traceutil/trace.go:171","msg":"trace[2054667425] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26751; }","duration":"128.812956ms","start":"2026-06-23T02:06:22.614181Z","end":"2026-06-23T02:06:22.742994Z","steps":["trace[2054667425] 'agreement among raft nodes before linearized reading' (duration: 128.5413ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:06:23.014519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.1633ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T02:06:23.014836Z","caller":"traceutil/trace.go:171","msg":"trace[165650380] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:26754; }","duration":"159.530709ms","start":"2026-06-23T02:06:22.855274Z","end":"2026-06-23T02:06:23.014805Z","steps":["trace[165650380] 'range keys from in-memory index tree' (duration: 159.131909ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:06:24.158878Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933266701815446445,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-23T02:06:24.21409Z","caller":"traceutil/trace.go:171","msg":"trace[379228646] transaction","detail":"{read_only:false; response_revision:26756; number_of_response:1; }","duration":"578.924322ms","start":"2026-06-23T02:06:23.635135Z","end":"2026-06-23T02:06:24.214059Z","steps":["trace[379228646] 'process raft request' (duration: 578.696177ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:06:24.214247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:06:23.63511Z","time spent":"579.054895ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:06:24.332927Z","caller":"traceutil/trace.go:171","msg":"trace[1350097425] transaction","detail":"{read_only:false; response_revision:26757; number_of_response:1; }","duration":"675.483338ms","start":"2026-06-23T02:06:23.657412Z","end":"2026-06-23T02:06:24.332895Z","steps":["trace[1350097425] 'process raft request' (duration: 672.163997ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:24.332943Z","caller":"traceutil/trace.go:171","msg":"trace[1047340243] linearizableReadLoop","detail":"{readStateIndex:27640; appliedIndex:27636; }","duration":"674.060424ms","start":"2026-06-23T02:06:23.658851Z","end":"2026-06-23T02:06:24.332912Z","steps":["trace[1047340243] 'read index received' (duration: 555.023755ms)","trace[1047340243] 'applied index is now lower than readState.Index' (duration: 119.034759ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T02:06:24.332961Z","caller":"traceutil/trace.go:171","msg":"trace[818530150] transaction","detail":"{read_only:false; response_revision:26759; number_of_response:1; }","duration":"503.666353ms","start":"2026-06-23T02:06:23.829268Z","end":"2026-06-23T02:06:24.332934Z","steps":["trace[818530150] 'process raft request' (duration: 503.585531ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:06:24.333062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:06:23.657392Z","time spent":"675.59632ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T02:06:24.333077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:06:23.829251Z","time spent":"503.774595ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:06:24.333082Z","caller":"traceutil/trace.go:171","msg":"trace[1775411959] transaction","detail":"{read_only:false; response_revision:26758; number_of_response:1; }","duration":"644.203911ms","start":"2026-06-23T02:06:23.688836Z","end":"2026-06-23T02:06:24.33304Z","steps":["trace[1775411959] 'process raft request' (duration: 643.942405ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:06:24.33322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.916455ms","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:6"} {"level":"warn","ts":"2026-06-23T02:06:24.333233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"674.354941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/volumes/\" range_end:\"/registry/openstack.k-orc.cloud/volumes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-23T02:06:24.333282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.730781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T02:06:24.333306Z","caller":"traceutil/trace.go:171","msg":"trace[1118918609] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26759; }","duration":"383.799013ms","start":"2026-06-23T02:06:23.949502Z","end":"2026-06-23T02:06:24.333301Z","steps":["trace[1118918609] 'agreement among raft nodes before linearized reading' (duration: 383.765173ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:24.333304Z","caller":"traceutil/trace.go:171","msg":"trace[1510766439] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/volumes/; range_end:/registry/openstack.k-orc.cloud/volumes0; response_count:0; response_revision:26759; }","duration":"674.449783ms","start":"2026-06-23T02:06:23.658835Z","end":"2026-06-23T02:06:24.333285Z","steps":["trace[1510766439] 'agreement among raft nodes before linearized reading' (duration: 674.223368ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:06:24.333372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:06:23.658797Z","time spent":"674.559506ms","remote":"127.0.0.1:56264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/volumes/\" range_end:\"/registry/openstack.k-orc.cloud/volumes0\" count_only:true "} {"level":"warn","ts":"2026-06-23T02:06:24.333593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.45448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T02:06:24.333251Z","caller":"traceutil/trace.go:171","msg":"trace[381401436] 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:26759; }","duration":"569.947276ms","start":"2026-06-23T02:06:23.763293Z","end":"2026-06-23T02:06:24.33324Z","steps":["trace[381401436] 'agreement among raft nodes before linearized reading' (duration: 569.894285ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:24.333628Z","caller":"traceutil/trace.go:171","msg":"trace[364007059] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:26759; }","duration":"518.489851ms","start":"2026-06-23T02:06:23.815129Z","end":"2026-06-23T02:06:24.333619Z","steps":["trace[364007059] 'agreement among raft nodes before linearized reading' (duration: 518.209774ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:06:24.333649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:06:23.815113Z","time spent":"518.530992ms","remote":"127.0.0.1:56130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":29,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "} {"level":"warn","ts":"2026-06-23T02:06:24.333667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:06:23.763274Z","time spent":"570.372566ms","remote":"127.0.0.1:43000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-23T02:06:24.333328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:06:23.949487Z","time spent":"383.836304ms","remote":"127.0.0.1:43414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-23T02:06:24.333992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:06:23.688813Z","time spent":"644.363805ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:06:40.868349Z","caller":"traceutil/trace.go:171","msg":"trace[805205782] transaction","detail":"{read_only:false; response_revision:26874; number_of_response:1; }","duration":"452.31849ms","start":"2026-06-23T02:06:40.416004Z","end":"2026-06-23T02:06:40.868322Z","steps":["trace[805205782] 'process raft request' (duration: 452.137726ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:06:40.868527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:06:40.415981Z","time spent":"452.450254ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:06:40.871001Z","caller":"traceutil/trace.go:171","msg":"trace[1522680182] transaction","detail":"{read_only:false; response_revision:26876; number_of_response:1; }","duration":"447.141614ms","start":"2026-06-23T02:06:40.423835Z","end":"2026-06-23T02:06:40.870976Z","steps":["trace[1522680182] 'process raft request' (duration: 447.050132ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:40.871064Z","caller":"traceutil/trace.go:171","msg":"trace[2001287957] transaction","detail":"{read_only:false; response_revision:26875; number_of_response:1; }","duration":"451.407918ms","start":"2026-06-23T02:06:40.419562Z","end":"2026-06-23T02:06:40.87097Z","steps":["trace[2001287957] 'process raft request' (duration: 451.180723ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:06:40.871138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:06:40.419545Z","time spent":"451.550352ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T02:06:40.871148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:06:40.42382Z","time spent":"447.245067ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:06:40.871255Z","caller":"traceutil/trace.go:171","msg":"trace[58782302] transaction","detail":"{read_only:false; response_revision:26877; number_of_response:1; }","duration":"419.681461ms","start":"2026-06-23T02:06:40.451533Z","end":"2026-06-23T02:06:40.871215Z","steps":["trace[58782302] 'process raft request' (duration: 419.392414ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:40.871319Z","caller":"traceutil/trace.go:171","msg":"trace[1079828272] transaction","detail":"{read_only:false; response_revision:26879; number_of_response:1; }","duration":"417.095799ms","start":"2026-06-23T02:06:40.454214Z","end":"2026-06-23T02:06:40.87131Z","steps":["trace[1079828272] 'process raft request' (duration: 416.998957ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:40.871322Z","caller":"traceutil/trace.go:171","msg":"trace[1594192585] linearizableReadLoop","detail":"{readStateIndex:27764; appliedIndex:27758; }","duration":"274.891849ms","start":"2026-06-23T02:06:40.596413Z","end":"2026-06-23T02:06:40.871305Z","steps":["trace[1594192585] 'read index received' (duration: 271.700752ms)","trace[1594192585] 'applied index is now lower than readState.Index' (duration: 3.189857ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T02:06:40.871376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:06:40.454194Z","time spent":"417.15189ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T02:06:40.871401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:06:40.451521Z","time spent":"419.799955ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:06:40.871275Z","caller":"traceutil/trace.go:171","msg":"trace[1478664916] transaction","detail":"{read_only:false; response_revision:26878; number_of_response:1; }","duration":"418.8469ms","start":"2026-06-23T02:06:40.452415Z","end":"2026-06-23T02:06:40.871262Z","steps":["trace[1478664916] 'process raft request' (duration: 418.709507ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:06:40.871479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:06:40.452409Z","time spent":"419.047006ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T02:06:40.871543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.136175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-23T02:06:40.871588Z","caller":"traceutil/trace.go:171","msg":"trace[476456640] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26880; }","duration":"275.182096ms","start":"2026-06-23T02:06:40.596395Z","end":"2026-06-23T02:06:40.871577Z","steps":["trace[476456640] 'agreement among raft nodes before linearized reading' (duration: 275.056563ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:47.170865Z","caller":"traceutil/trace.go:171","msg":"trace[759749268] transaction","detail":"{read_only:false; response_revision:26929; number_of_response:1; }","duration":"276.516129ms","start":"2026-06-23T02:06:46.894304Z","end":"2026-06-23T02:06:47.17082Z","steps":["trace[759749268] 'process raft request' (duration: 241.212274ms)","trace[759749268] 'compare' (duration: 35.057599ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T02:06:47.170967Z","caller":"traceutil/trace.go:171","msg":"trace[72349196] transaction","detail":"{read_only:false; response_revision:26932; number_of_response:1; }","duration":"263.35016ms","start":"2026-06-23T02:06:46.907592Z","end":"2026-06-23T02:06:47.170942Z","steps":["trace[72349196] 'process raft request' (duration: 263.266078ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:47.171001Z","caller":"traceutil/trace.go:171","msg":"trace[993428020] transaction","detail":"{read_only:false; response_revision:26930; number_of_response:1; }","duration":"273.821414ms","start":"2026-06-23T02:06:46.897149Z","end":"2026-06-23T02:06:47.170971Z","steps":["trace[993428020] 'process raft request' (duration: 273.595608ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:47.171169Z","caller":"traceutil/trace.go:171","msg":"trace[1960466485] transaction","detail":"{read_only:false; response_revision:26931; number_of_response:1; }","duration":"263.612566ms","start":"2026-06-23T02:06:46.907533Z","end":"2026-06-23T02:06:47.171146Z","steps":["trace[1960466485] 'process raft request' (duration: 263.282418ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:47.171283Z","caller":"traceutil/trace.go:171","msg":"trace[358385972] transaction","detail":"{read_only:false; response_revision:26933; number_of_response:1; }","duration":"262.252013ms","start":"2026-06-23T02:06:46.90902Z","end":"2026-06-23T02:06:47.171272Z","steps":["trace[358385972] 'process raft request' (duration: 261.882004ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:47.171571Z","caller":"traceutil/trace.go:171","msg":"trace[1459276558] linearizableReadLoop","detail":"{readStateIndex:27821; appliedIndex:27813; }","duration":"255.002738ms","start":"2026-06-23T02:06:46.916555Z","end":"2026-06-23T02:06:47.171558Z","steps":["trace[1459276558] 'read index received' (duration: 46.115456ms)","trace[1459276558] 'applied index is now lower than readState.Index' (duration: 208.886212ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T02:06:47.171611Z","caller":"traceutil/trace.go:171","msg":"trace[805515736] transaction","detail":"{read_only:false; response_revision:26934; number_of_response:1; }","duration":"262.536779ms","start":"2026-06-23T02:06:46.909053Z","end":"2026-06-23T02:06:47.171589Z","steps":["trace[805515736] 'process raft request' (duration: 262.136ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:47.171667Z","caller":"traceutil/trace.go:171","msg":"trace[4880336] transaction","detail":"{read_only:false; response_revision:26935; number_of_response:1; }","duration":"262.456767ms","start":"2026-06-23T02:06:46.909199Z","end":"2026-06-23T02:06:47.171656Z","steps":["trace[4880336] 'process raft request' (duration: 262.272192ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:06:47.171862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.287625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-23T02:06:47.171903Z","caller":"traceutil/trace.go:171","msg":"trace[1197392352] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26935; }","duration":"255.378486ms","start":"2026-06-23T02:06:46.916515Z","end":"2026-06-23T02:06:47.171893Z","steps":["trace[1197392352] 'agreement among raft nodes before linearized reading' (duration: 255.223043ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:06:47.171973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.26662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"warn","ts":"2026-06-23T02:06:47.171961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.705135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"warn","ts":"2026-06-23T02:06:47.172039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.674116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-23T02:06:47.172048Z","caller":"traceutil/trace.go:171","msg":"trace[441875876] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26935; }","duration":"254.370602ms","start":"2026-06-23T02:06:46.917659Z","end":"2026-06-23T02:06:47.17203Z","steps":["trace[441875876] 'agreement among raft nodes before linearized reading' (duration: 254.145076ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:47.172059Z","caller":"traceutil/trace.go:171","msg":"trace[2009446434] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26935; }","duration":"241.837049ms","start":"2026-06-23T02:06:46.930202Z","end":"2026-06-23T02:06:47.172039Z","steps":["trace[2009446434] 'agreement among raft nodes before linearized reading' (duration: 241.646294ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:06:47.172045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.569297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-23T02:06:47.172199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.151617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-06-23T02:06:47.172264Z","caller":"traceutil/trace.go:171","msg":"trace[1967059181] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26935; }","duration":"254.23755ms","start":"2026-06-23T02:06:46.918008Z","end":"2026-06-23T02:06:47.172246Z","steps":["trace[1967059181] 'agreement among raft nodes before linearized reading' (duration: 254.095615ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:47.17222Z","caller":"traceutil/trace.go:171","msg":"trace[1383118218] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26935; }","duration":"223.751702ms","start":"2026-06-23T02:06:46.948422Z","end":"2026-06-23T02:06:47.172174Z","steps":["trace[1383118218] 'agreement among raft nodes before linearized reading' (duration: 223.564647ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:47.172075Z","caller":"traceutil/trace.go:171","msg":"trace[1922379771] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26935; }","duration":"253.731657ms","start":"2026-06-23T02:06:46.918335Z","end":"2026-06-23T02:06:47.172067Z","steps":["trace[1922379771] 'agreement among raft nodes before linearized reading' (duration: 253.644724ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:06:47.446146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.690111ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T02:06:47.446262Z","caller":"traceutil/trace.go:171","msg":"trace[402643649] transaction","detail":"{read_only:false; response_revision:26936; number_of_response:1; }","duration":"269.407206ms","start":"2026-06-23T02:06:47.176836Z","end":"2026-06-23T02:06:47.446243Z","steps":["trace[402643649] 'process raft request' (duration: 133.52253ms)","trace[402643649] 'compare' (duration: 135.577279ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T02:06:47.962087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.423314ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T02:06:47.962573Z","caller":"traceutil/trace.go:171","msg":"trace[1453977127] transaction","detail":"{read_only:false; response_revision:26937; number_of_response:1; }","duration":"785.704745ms","start":"2026-06-23T02:06:47.176845Z","end":"2026-06-23T02:06:47.96255Z","steps":["trace[1453977127] 'process raft request' (duration: 463.730517ms)","trace[1453977127] 'compare' (duration: 321.072035ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T02:06:47.962685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:06:47.176825Z","time spent":"785.800207ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:06:47.962718Z","caller":"traceutil/trace.go:171","msg":"trace[1196743913] transaction","detail":"{read_only:false; response_revision:26938; number_of_response:1; }","duration":"785.739506ms","start":"2026-06-23T02:06:47.176924Z","end":"2026-06-23T02:06:47.962664Z","steps":["trace[1196743913] 'process raft request' (duration: 785.257464ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:47.962706Z","caller":"traceutil/trace.go:171","msg":"trace[933077432] transaction","detail":"{read_only:false; response_revision:26939; number_of_response:1; }","duration":"785.741145ms","start":"2026-06-23T02:06:47.176943Z","end":"2026-06-23T02:06:47.962684Z","steps":["trace[933077432] 'process raft request' (duration: 785.615302ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:06:47.962856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:06:47.176908Z","time spent":"785.882149ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:06:47.962884Z","caller":"traceutil/trace.go:171","msg":"trace[1162859563] transaction","detail":"{read_only:false; response_revision:26940; number_of_response:1; }","duration":"784.804192ms","start":"2026-06-23T02:06:47.178055Z","end":"2026-06-23T02:06:47.962859Z","steps":["trace[1162859563] 'process raft request' (duration: 784.549346ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:47.962831Z","caller":"traceutil/trace.go:171","msg":"trace[500407203] linearizableReadLoop","detail":"{readStateIndex:27826; appliedIndex:27822; }","duration":"475.8799ms","start":"2026-06-23T02:06:47.48692Z","end":"2026-06-23T02:06:47.9628Z","steps":["trace[500407203] 'read index received' (duration: 153.672457ms)","trace[500407203] 'applied index is now lower than readState.Index' (duration: 322.204373ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T02:06:47.963013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.084105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.3\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-06-23T02:06:47.963006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:06:47.176922Z","time spent":"785.977371ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:06:47.963041Z","caller":"traceutil/trace.go:171","msg":"trace[323235437] range","detail":"{range_begin:/registry/masterleases/199.204.45.3; range_end:; response_count:1; response_revision:26940; }","duration":"476.164287ms","start":"2026-06-23T02:06:47.48687Z","end":"2026-06-23T02:06:47.963034Z","steps":["trace[323235437] 'agreement among raft nodes before linearized reading' (duration: 476.004814ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:06:47.963062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:06:47.48684Z","time spent":"476.217308ms","remote":"127.0.0.1:43446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.3\" "} {"level":"warn","ts":"2026-06-23T02:06:47.963057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:06:47.178047Z","time spent":"784.951126ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T02:06:47.963103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.117723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-23T02:06:47.96313Z","caller":"traceutil/trace.go:171","msg":"trace[56380116] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:26940; }","duration":"105.183845ms","start":"2026-06-23T02:06:47.857938Z","end":"2026-06-23T02:06:47.963122Z","steps":["trace[56380116] 'agreement among raft nodes before linearized reading' (duration: 105.122183ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:06:48.457111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:06:47.963799Z","time spent":"493.306372ms","remote":"127.0.0.1:43446","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-23T02:06:48.789599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.867723ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T02:06:48.789718Z","caller":"traceutil/trace.go:171","msg":"trace[1559980805] linearizableReadLoop","detail":"{readStateIndex:27828; appliedIndex:27826; }","duration":"527.264743ms","start":"2026-06-23T02:06:48.26243Z","end":"2026-06-23T02:06:48.789695Z","steps":["trace[1559980805] 'read index received' (duration: 169.51083ms)","trace[1559980805] 'applied index is now lower than readState.Index' (duration: 357.751903ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T02:06:48.790019Z","caller":"traceutil/trace.go:171","msg":"trace[1468346797] transaction","detail":"{read_only:false; response_revision:26941; number_of_response:1; }","duration":"602.161834ms","start":"2026-06-23T02:06:48.187836Z","end":"2026-06-23T02:06:48.789998Z","steps":["trace[1468346797] 'process raft request' (duration: 449.719227ms)","trace[1468346797] 'compare' (duration: 151.533516ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T02:06:48.790122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:06:48.187811Z","time spent":"602.259047ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T02:06:48.790454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.98253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/floatingips/\" range_end:\"/registry/openstack.k-orc.cloud/floatingips0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T02:06:48.790504Z","caller":"traceutil/trace.go:171","msg":"trace[1435099439] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/floatingips/; range_end:/registry/openstack.k-orc.cloud/floatingips0; response_count:0; response_revision:26941; }","duration":"528.100973ms","start":"2026-06-23T02:06:48.262387Z","end":"2026-06-23T02:06:48.790488Z","steps":["trace[1435099439] 'agreement among raft nodes before linearized reading' (duration: 527.943929ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:06:48.790548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:06:48.262368Z","time spent":"528.166714ms","remote":"127.0.0.1:32846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/floatingips/\" range_end:\"/registry/openstack.k-orc.cloud/floatingips0\" count_only:true "} {"level":"info","ts":"2026-06-23T02:06:48.812527Z","caller":"traceutil/trace.go:171","msg":"trace[1943314202] transaction","detail":"{read_only:false; response_revision:26942; number_of_response:1; }","duration":"370.215644ms","start":"2026-06-23T02:06:48.442287Z","end":"2026-06-23T02:06:48.812503Z","steps":["trace[1943314202] 'process raft request' (duration: 370.0183ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:06:48.81279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.324323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusterclasses/\" range_end:\"/registry/cluster.x-k8s.io/clusterclasses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T02:06:48.812857Z","caller":"traceutil/trace.go:171","msg":"trace[2036908693] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusterclasses/; range_end:/registry/cluster.x-k8s.io/clusterclasses0; response_count:0; response_revision:26943; }","duration":"240.439785ms","start":"2026-06-23T02:06:48.572402Z","end":"2026-06-23T02:06:48.812842Z","steps":["trace[2036908693] 'agreement among raft nodes before linearized reading' (duration: 240.281082ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:06:48.812887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:06:48.442265Z","time spent":"370.332647ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:06:48.812776Z","caller":"traceutil/trace.go:171","msg":"trace[1560458966] transaction","detail":"{read_only:false; response_revision:26943; number_of_response:1; }","duration":"353.92952ms","start":"2026-06-23T02:06:48.458819Z","end":"2026-06-23T02:06:48.812749Z","steps":["trace[1560458966] 'process raft request' (duration: 353.628763ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:06:48.813016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:06:48.458794Z","time spent":"354.150705ms","remote":"127.0.0.1:43446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":117,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T02:06:49.26386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.450585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T02:06:49.263939Z","caller":"traceutil/trace.go:171","msg":"trace[597648852] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26943; }","duration":"316.600598ms","start":"2026-06-23T02:06:48.947319Z","end":"2026-06-23T02:06:49.26392Z","steps":["trace[597648852] 'range keys from in-memory index tree' (duration: 316.330321ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:06:49.263972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:06:48.947294Z","time spent":"316.669919ms","remote":"127.0.0.1:43414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-23T02:06:49.26431Z","caller":"traceutil/trace.go:171","msg":"trace[747530060] linearizableReadLoop","detail":"{readStateIndex:27831; appliedIndex:27830; }","duration":"256.638037ms","start":"2026-06-23T02:06:49.007661Z","end":"2026-06-23T02:06:49.264299Z","steps":["trace[747530060] 'read index received' (duration: 208.250057ms)","trace[747530060] 'applied index is now lower than readState.Index' (duration: 48.38654ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T02:06:49.26434Z","caller":"traceutil/trace.go:171","msg":"trace[1319539584] transaction","detail":"{read_only:false; response_revision:26944; number_of_response:1; }","duration":"295.951987ms","start":"2026-06-23T02:06:48.968362Z","end":"2026-06-23T02:06:49.264314Z","steps":["trace[1319539584] 'process raft request' (duration: 247.544607ms)","trace[1319539584] 'compare' (duration: 47.831047ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T02:06:49.264432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.752379ms","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:8"} {"level":"info","ts":"2026-06-23T02:06:49.264508Z","caller":"traceutil/trace.go:171","msg":"trace[2107155825] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:26944; }","duration":"256.876953ms","start":"2026-06-23T02:06:49.007611Z","end":"2026-06-23T02:06:49.264488Z","steps":["trace[2107155825] 'agreement among raft nodes before linearized reading' (duration: 256.745579ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:49.360478Z","caller":"traceutil/trace.go:171","msg":"trace[1483422808] transaction","detail":"{read_only:false; response_revision:26945; number_of_response:1; }","duration":"183.98321ms","start":"2026-06-23T02:06:49.176471Z","end":"2026-06-23T02:06:49.360454Z","steps":["trace[1483422808] 'process raft request' (duration: 183.819367ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:49.360939Z","caller":"traceutil/trace.go:171","msg":"trace[962477326] transaction","detail":"{read_only:false; response_revision:26947; number_of_response:1; }","duration":"181.688125ms","start":"2026-06-23T02:06:49.179234Z","end":"2026-06-23T02:06:49.360922Z","steps":["trace[962477326] 'process raft request' (duration: 181.49197ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:49.36116Z","caller":"traceutil/trace.go:171","msg":"trace[1107754596] transaction","detail":"{read_only:false; response_revision:26948; number_of_response:1; }","duration":"181.886539ms","start":"2026-06-23T02:06:49.179236Z","end":"2026-06-23T02:06:49.361123Z","steps":["trace[1107754596] 'process raft request' (duration: 181.628283ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:49.361239Z","caller":"traceutil/trace.go:171","msg":"trace[1602619502] transaction","detail":"{read_only:false; response_revision:26949; number_of_response:1; }","duration":"181.8885ms","start":"2026-06-23T02:06:49.179331Z","end":"2026-06-23T02:06:49.361219Z","steps":["trace[1602619502] 'process raft request' (duration: 181.571262ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:49.361382Z","caller":"traceutil/trace.go:171","msg":"trace[396220327] transaction","detail":"{read_only:false; response_revision:26951; number_of_response:1; }","duration":"178.939388ms","start":"2026-06-23T02:06:49.182435Z","end":"2026-06-23T02:06:49.361374Z","steps":["trace[396220327] 'process raft request' (duration: 178.611711ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:49.36147Z","caller":"traceutil/trace.go:171","msg":"trace[257560845] transaction","detail":"{read_only:false; response_revision:26950; number_of_response:1; }","duration":"181.164773ms","start":"2026-06-23T02:06:49.180094Z","end":"2026-06-23T02:06:49.361259Z","steps":["trace[257560845] 'process raft request' (duration: 180.843755ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:06:49.361806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.838462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0\" ","response":"range_response_count:1 size:1864"} {"level":"info","ts":"2026-06-23T02:06:49.361848Z","caller":"traceutil/trace.go:171","msg":"trace[733669350] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0; range_end:; response_count:1; response_revision:26951; }","duration":"220.940734ms","start":"2026-06-23T02:06:49.140895Z","end":"2026-06-23T02:06:49.361836Z","steps":["trace[733669350] 'agreement among raft nodes before linearized reading' (duration: 220.77451ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:49.362085Z","caller":"traceutil/trace.go:171","msg":"trace[757911182] transaction","detail":"{read_only:false; response_revision:26946; number_of_response:1; }","duration":"183.383966ms","start":"2026-06-23T02:06:49.177654Z","end":"2026-06-23T02:06:49.361038Z","steps":["trace[757911182] 'process raft request' (duration: 182.764222ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:52.233031Z","caller":"traceutil/trace.go:171","msg":"trace[1301581043] transaction","detail":"{read_only:false; response_revision:26969; number_of_response:1; }","duration":"253.571633ms","start":"2026-06-23T02:06:51.979431Z","end":"2026-06-23T02:06:52.233003Z","steps":["trace[1301581043] 'process raft request' (duration: 253.349938ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:52.290752Z","caller":"traceutil/trace.go:171","msg":"trace[925195974] transaction","detail":"{read_only:false; response_revision:26971; number_of_response:1; }","duration":"310.738157ms","start":"2026-06-23T02:06:51.979988Z","end":"2026-06-23T02:06:52.290726Z","steps":["trace[925195974] 'process raft request' (duration: 310.642634ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:52.290779Z","caller":"traceutil/trace.go:171","msg":"trace[106108465] transaction","detail":"{read_only:false; response_revision:26970; number_of_response:1; }","duration":"310.793628ms","start":"2026-06-23T02:06:51.979945Z","end":"2026-06-23T02:06:52.290739Z","steps":["trace[106108465] 'process raft request' (duration: 310.527141ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:06:52.290923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:06:51.979957Z","time spent":"310.885199ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T02:06:52.29097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:06:51.97993Z","time spent":"310.931541ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:06:52.291224Z","caller":"traceutil/trace.go:171","msg":"trace[1051588377] transaction","detail":"{read_only:false; response_revision:26973; number_of_response:1; }","duration":"173.314682ms","start":"2026-06-23T02:06:52.117879Z","end":"2026-06-23T02:06:52.291193Z","steps":["trace[1051588377] 'process raft request' (duration: 173.135667ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:06:52.291435Z","caller":"traceutil/trace.go:171","msg":"trace[1138133036] transaction","detail":"{read_only:false; response_revision:26972; number_of_response:1; }","duration":"311.302999ms","start":"2026-06-23T02:06:51.980122Z","end":"2026-06-23T02:06:52.291425Z","steps":["trace[1138133036] 'process raft request' (duration: 310.565052ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:06:52.291677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T02:06:51.980082Z","time spent":"311.510534ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T02:08:14.502915Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24970} {"level":"info","ts":"2026-06-23T02:08:14.642567Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24970,"took":"136.290183ms","hash":3465382260,"current-db-size-bytes":59236352,"current-db-size":"59 MB","current-db-size-in-use-bytes":36667392,"current-db-size-in-use":"37 MB"} {"level":"info","ts":"2026-06-23T02:08:14.642633Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3465382260,"revision":24970,"compact-revision":21831} {"level":"info","ts":"2026-06-23T02:08:40.914623Z","caller":"traceutil/trace.go:171","msg":"trace[1451516780] transaction","detail":"{read_only:false; response_revision:28042; number_of_response:1; }","duration":"125.840183ms","start":"2026-06-23T02:08:40.788759Z","end":"2026-06-23T02:08:40.914599Z","steps":["trace[1451516780] 'process raft request' (duration: 84.599166ms)","trace[1451516780] 'compare' (duration: 40.196692ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T02:10:19.315335Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"597401b06ce1cf3d","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-23T02:10:19.321463Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-06-23T02:10:19.321584Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-06-23T02:13:14.509677Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27799} {"level":"info","ts":"2026-06-23T02:13:14.643126Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27799,"took":"129.424701ms","hash":3502944105,"current-db-size-bytes":59236352,"current-db-size":"59 MB","current-db-size-in-use-bytes":33968128,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-23T02:13:14.643194Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3502944105,"revision":27799,"compact-revision":24970} {"level":"info","ts":"2026-06-23T02:18:14.518677Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30448} {"level":"info","ts":"2026-06-23T02:18:14.655443Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30448,"took":"133.245407ms","hash":1939564049,"current-db-size-bytes":59236352,"current-db-size":"59 MB","current-db-size-in-use-bytes":30720000,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-23T02:18:14.655538Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1939564049,"revision":30448,"compact-revision":27799} {"level":"info","ts":"2026-06-23T02:23:14.524667Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32707} {"level":"info","ts":"2026-06-23T02:23:14.667951Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32707,"took":"138.777128ms","hash":617833642,"current-db-size-bytes":59236352,"current-db-size":"59 MB","current-db-size-in-use-bytes":30359552,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-23T02:23:14.668033Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":617833642,"revision":32707,"compact-revision":30448} {"level":"info","ts":"2026-06-23T02:28:14.531706Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34935} {"level":"info","ts":"2026-06-23T02:28:14.671889Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34935,"took":"136.347514ms","hash":372784659,"current-db-size-bytes":59236352,"current-db-size":"59 MB","current-db-size-in-use-bytes":31707136,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-23T02:28:14.671965Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":372784659,"revision":34935,"compact-revision":32707} {"level":"info","ts":"2026-06-23T02:31:35.786711Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"597401b06ce1cf3d","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-23T02:31:35.79341Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-06-23T02:31:35.793558Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-06-23T02:33:14.538379Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37237} {"level":"info","ts":"2026-06-23T02:33:14.671412Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37237,"took":"129.396951ms","hash":2419280539,"current-db-size-bytes":59236352,"current-db-size":"59 MB","current-db-size-in-use-bytes":32923648,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-06-23T02:33:14.671476Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2419280539,"revision":37237,"compact-revision":34935} {"level":"warn","ts":"2026-06-23T02:35:45.930045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.96282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/orc-system/kube-root-ca.crt\" ","response":"range_response_count:1 size:1747"} {"level":"info","ts":"2026-06-23T02:35:45.930174Z","caller":"traceutil/trace.go:171","msg":"trace[257852696] range","detail":"{range_begin:/registry/configmaps/orc-system/kube-root-ca.crt; range_end:; response_count:1; response_revision:40661; }","duration":"122.147175ms","start":"2026-06-23T02:35:45.807998Z","end":"2026-06-23T02:35:45.930145Z","steps":["trace[257852696] 'range keys from in-memory index tree' (duration: 121.746625ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T02:35:45.930448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.917691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:12026"} {"level":"info","ts":"2026-06-23T02:35:45.930541Z","caller":"traceutil/trace.go:171","msg":"trace[963267418] range","detail":"{range_begin:/registry/statefulsets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:40661; }","duration":"127.085585ms","start":"2026-06-23T02:35:45.803433Z","end":"2026-06-23T02:35:45.930518Z","steps":["trace[963267418] 'range keys from in-memory index tree' (duration: 126.655725ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T02:38:14.545946Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39511} {"level":"info","ts":"2026-06-23T02:38:14.670687Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39511,"took":"120.27147ms","hash":616126946,"current-db-size-bytes":59236352,"current-db-size":"59 MB","current-db-size-in-use-bytes":30801920,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-23T02:38:14.670797Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":616126946,"revision":39511,"compact-revision":37237}