{"level":"warn","ts":"2026-06-30T17:53:49.481538Z","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-30T17:53:49.481657Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.157: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.157:2380","--initial-cluster=instance=https://199.204.45.157:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.157:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.157: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-30T17:53:49.481756Z","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-30T17:53:49.481774Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.157:2380"]} {"level":"info","ts":"2026-06-30T17:53:49.4818Z","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-30T17:53:49.482722Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"]} {"level":"info","ts":"2026-06-30T17:53:49.482823Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.157:2380"],"listen-peer-urls":["https://199.204.45.157:2380"],"advertise-client-urls":["https://199.204.45.157:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.157: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-30T17:53:49.487384Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.314929ms"} {"level":"info","ts":"2026-06-30T17:53:49.496384Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5f170c75a1d97cc","cluster-id":"44a3176ec85feb9"} {"level":"info","ts":"2026-06-30T17:53:49.496475Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=()"} {"level":"info","ts":"2026-06-30T17:53:49.496507Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became follower at term 0"} {"level":"info","ts":"2026-06-30T17:53:49.496523Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5f170c75a1d97cc [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-30T17:53:49.49654Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became follower at term 1"} {"level":"info","ts":"2026-06-30T17:53:49.496584Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=(428247441089599436)"} {"level":"warn","ts":"2026-06-30T17:53:49.503555Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-30T17:53:49.50485Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-30T17:53:49.506377Z","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-30T17:53:49.508965Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5f170c75a1d97cc","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-30T17:53:49.509178Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5f170c75a1d97cc","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-30T17:53:49.509354Z","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-30T17:53:49.509519Z","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-30T17:53:49.509543Z","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-30T17:53:49.515102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=(428247441089599436)"} {"level":"info","ts":"2026-06-30T17:53:49.515381Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"44a3176ec85feb9","local-member-id":"5f170c75a1d97cc","added-peer-id":"5f170c75a1d97cc","added-peer-peer-urls":["https://199.204.45.157:2380"]} {"level":"info","ts":"2026-06-30T17:53:49.516384Z","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-30T17:53:49.516624Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5f170c75a1d97cc","initial-advertise-peer-urls":["https://199.204.45.157:2380"],"listen-peer-urls":["https://199.204.45.157:2380"],"advertise-client-urls":["https://199.204.45.157:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-30T17:53:49.516669Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-30T17:53:49.516802Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.157:2380"} {"level":"info","ts":"2026-06-30T17:53:49.516841Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.157:2380"} {"level":"info","ts":"2026-06-30T17:53:49.796788Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc is starting a new election at term 1"} {"level":"info","ts":"2026-06-30T17:53:49.796905Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became pre-candidate at term 1"} {"level":"info","ts":"2026-06-30T17:53:49.796954Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc received MsgPreVoteResp from 5f170c75a1d97cc at term 1"} {"level":"info","ts":"2026-06-30T17:53:49.796983Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became candidate at term 2"} {"level":"info","ts":"2026-06-30T17:53:49.797001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc received MsgVoteResp from 5f170c75a1d97cc at term 2"} {"level":"info","ts":"2026-06-30T17:53:49.797025Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became leader at term 2"} {"level":"info","ts":"2026-06-30T17:53:49.797047Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5f170c75a1d97cc elected leader 5f170c75a1d97cc at term 2"} {"level":"info","ts":"2026-06-30T17:53:49.841036Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T17:53:49.910626Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5f170c75a1d97cc","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.157:2379]}","request-path":"/0/members/5f170c75a1d97cc/attributes","cluster-id":"44a3176ec85feb9","publish-timeout":"7s"} {"level":"info","ts":"2026-06-30T17:53:49.910738Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-30T17:53:49.91251Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-30T17:53:49.912635Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-30T17:53:49.912916Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-30T17:53:49.912952Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-30T17:53:49.915728Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.157:2379"} {"level":"info","ts":"2026-06-30T17:53:50.09497Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"44a3176ec85feb9","local-member-id":"5f170c75a1d97cc","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T17:53:50.095407Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T17:53:50.095532Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T17:54:27.423241Z","caller":"traceutil/trace.go:171","msg":"trace[1107879379] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"175.353823ms","start":"2026-06-30T17:54:27.247857Z","end":"2026-06-30T17:54:27.423211Z","steps":["trace[1107879379] 'process raft request' (duration: 175.173414ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:27.430881Z","caller":"traceutil/trace.go:171","msg":"trace[971025532] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"163.816375ms","start":"2026-06-30T17:54:27.267027Z","end":"2026-06-30T17:54:27.430844Z","steps":["trace[971025532] 'process raft request' (duration: 163.610705ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:27.431146Z","caller":"traceutil/trace.go:171","msg":"trace[919879782] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"167.372081ms","start":"2026-06-30T17:54:27.263732Z","end":"2026-06-30T17:54:27.431104Z","steps":["trace[919879782] 'process raft request' (duration: 166.863436ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:27.43124Z","caller":"traceutil/trace.go:171","msg":"trace[87385788] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"161.693211ms","start":"2026-06-30T17:54:27.269493Z","end":"2026-06-30T17:54:27.431186Z","steps":["trace[87385788] 'process raft request' (duration: 161.222088ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:27.431515Z","caller":"traceutil/trace.go:171","msg":"trace[1478168630] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"183.289944ms","start":"2026-06-30T17:54:27.248203Z","end":"2026-06-30T17:54:27.431493Z","steps":["trace[1478168630] 'process raft request' (duration: 182.159188ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:27.431537Z","caller":"traceutil/trace.go:171","msg":"trace[1066217597] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"144.096244ms","start":"2026-06-30T17:54:27.287402Z","end":"2026-06-30T17:54:27.431498Z","steps":["trace[1066217597] 'process raft request' (duration: 143.361728ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:27.431679Z","caller":"traceutil/trace.go:171","msg":"trace[1059840225] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"183.175238ms","start":"2026-06-30T17:54:27.248491Z","end":"2026-06-30T17:54:27.431666Z","steps":["trace[1059840225] 'process raft request' (duration: 181.98932ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:27.431713Z","caller":"traceutil/trace.go:171","msg":"trace[1278814231] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"170.722776ms","start":"2026-06-30T17:54:27.260972Z","end":"2026-06-30T17:54:27.431695Z","steps":["trace[1278814231] 'process raft request' (duration: 169.547868ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:27.431774Z","caller":"traceutil/trace.go:171","msg":"trace[1946691501] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"110.666538ms","start":"2026-06-30T17:54:27.321097Z","end":"2026-06-30T17:54:27.431764Z","steps":["trace[1946691501] 'process raft request' (duration: 109.716441ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:27.431947Z","caller":"traceutil/trace.go:171","msg":"trace[1013943281] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"163.580043ms","start":"2026-06-30T17:54:27.268311Z","end":"2026-06-30T17:54:27.431891Z","steps":["trace[1013943281] 'process raft request' (duration: 162.362454ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:54:27.432044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.894972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:54:27.435628Z","caller":"traceutil/trace.go:171","msg":"trace[1762839622] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:494; }","duration":"164.51538ms","start":"2026-06-30T17:54:27.271097Z","end":"2026-06-30T17:54:27.435613Z","steps":["trace[1762839622] 'agreement among raft nodes before linearized reading' (duration: 160.804227ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:27.432732Z","caller":"traceutil/trace.go:171","msg":"trace[1975314328] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"170.646702ms","start":"2026-06-30T17:54:27.262069Z","end":"2026-06-30T17:54:27.432716Z","steps":["trace[1975314328] 'process raft request' (duration: 168.489995ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:27.430942Z","caller":"traceutil/trace.go:171","msg":"trace[124924775] linearizableReadLoop","detail":"{readStateIndex:508; appliedIndex:500; }","duration":"159.773326ms","start":"2026-06-30T17:54:27.271118Z","end":"2026-06-30T17:54:27.430891Z","steps":["trace[124924775] 'read index received' (duration: 152.610874ms)","trace[124924775] 'applied index is now lower than readState.Index' (duration: 7.161092ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:54:27.445532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.373157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-30T17:54:27.445576Z","caller":"traceutil/trace.go:171","msg":"trace[1381626142] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:495; }","duration":"173.44666ms","start":"2026-06-30T17:54:27.272119Z","end":"2026-06-30T17:54:27.445566Z","steps":["trace[1381626142] 'agreement among raft nodes before linearized reading' (duration: 173.336214ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:54:28.707146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.362048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gateways.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:59631"} {"level":"info","ts":"2026-06-30T17:54:28.707251Z","caller":"traceutil/trace.go:171","msg":"trace[2115252890] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/gateways.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:580; }","duration":"101.531976ms","start":"2026-06-30T17:54:28.605692Z","end":"2026-06-30T17:54:28.707224Z","steps":["trace[2115252890] 'range keys from in-memory index tree' (duration: 101.111485ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:34.597008Z","caller":"traceutil/trace.go:171","msg":"trace[228566288] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"144.70434ms","start":"2026-06-30T17:54:34.452278Z","end":"2026-06-30T17:54:34.596982Z","steps":["trace[228566288] 'process raft request' (duration: 144.476749ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:34.719715Z","caller":"traceutil/trace.go:171","msg":"trace[1470753039] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"116.450317ms","start":"2026-06-30T17:54:34.603234Z","end":"2026-06-30T17:54:34.719684Z","steps":["trace[1470753039] 'process raft request' (duration: 67.151487ms)","trace[1470753039] 'compare' (duration: 48.90204ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:54:34.719866Z","caller":"traceutil/trace.go:171","msg":"trace[1198274528] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"115.731191ms","start":"2026-06-30T17:54:34.604095Z","end":"2026-06-30T17:54:34.719827Z","steps":["trace[1198274528] 'process raft request' (duration: 115.354072ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:34.722404Z","caller":"traceutil/trace.go:171","msg":"trace[426846083] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"117.092328ms","start":"2026-06-30T17:54:34.605284Z","end":"2026-06-30T17:54:34.722376Z","steps":["trace[426846083] 'process raft request' (duration: 114.359373ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:35.378198Z","caller":"traceutil/trace.go:171","msg":"trace[499697752] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:673; }","duration":"104.745691ms","start":"2026-06-30T17:54:35.273423Z","end":"2026-06-30T17:54:35.378169Z","steps":["trace[499697752] 'read index received' (duration: 104.554282ms)","trace[499697752] 'applied index is now lower than readState.Index' (duration: 190.079µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:54:35.378241Z","caller":"traceutil/trace.go:171","msg":"trace[383949963] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"229.96171ms","start":"2026-06-30T17:54:35.148226Z","end":"2026-06-30T17:54:35.378188Z","steps":["trace[383949963] 'process raft request' (duration: 229.75779ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:54:35.378359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.910959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:54:35.378406Z","caller":"traceutil/trace.go:171","msg":"trace[632239817] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:650; }","duration":"105.014564ms","start":"2026-06-30T17:54:35.273378Z","end":"2026-06-30T17:54:35.378393Z","steps":["trace[632239817] 'agreement among raft nodes before linearized reading' (duration: 104.901819ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:56:07.80472Z","caller":"traceutil/trace.go:171","msg":"trace[683998638] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"141.750057ms","start":"2026-06-30T17:56:07.662943Z","end":"2026-06-30T17:56:07.804693Z","steps":["trace[683998638] 'process raft request' (duration: 141.580743ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:56:07.980452Z","caller":"traceutil/trace.go:171","msg":"trace[1411292073] transaction","detail":"{read_only:false; response_revision:1839; number_of_response:1; }","duration":"106.636614ms","start":"2026-06-30T17:56:07.873748Z","end":"2026-06-30T17:56:07.980385Z","steps":["trace[1411292073] 'process raft request' (duration: 90.630281ms)","trace[1411292073] 'compare' (duration: 15.718205ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:56:42.391696Z","caller":"traceutil/trace.go:171","msg":"trace[398751887] linearizableReadLoop","detail":"{readStateIndex:2156; appliedIndex:2155; }","duration":"132.452109ms","start":"2026-06-30T17:56:42.259219Z","end":"2026-06-30T17:56:42.391671Z","steps":["trace[398751887] 'read index received' (duration: 132.242612ms)","trace[398751887] 'applied index is now lower than readState.Index' (duration: 207.947µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:56:42.391749Z","caller":"traceutil/trace.go:171","msg":"trace[1312327724] transaction","detail":"{read_only:false; response_revision:2074; number_of_response:1; }","duration":"135.67835ms","start":"2026-06-30T17:56:42.256024Z","end":"2026-06-30T17:56:42.391702Z","steps":["trace[1312327724] 'process raft request' (duration: 135.432512ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:56:42.392164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.927685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-30T17:56:42.392206Z","caller":"traceutil/trace.go:171","msg":"trace[775743527] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2074; }","duration":"133.013388ms","start":"2026-06-30T17:56:42.259184Z","end":"2026-06-30T17:56:42.392197Z","steps":["trace[775743527] 'agreement among raft nodes before linearized reading' (duration: 132.628995ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:56:42.540091Z","caller":"traceutil/trace.go:171","msg":"trace[430200057] linearizableReadLoop","detail":"{readStateIndex:2157; appliedIndex:2156; }","duration":"148.243055ms","start":"2026-06-30T17:56:42.391781Z","end":"2026-06-30T17:56:42.540024Z","steps":["trace[430200057] 'read index received' (duration: 142.500037ms)","trace[430200057] 'applied index is now lower than readState.Index' (duration: 5.741278ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:56:42.540456Z","caller":"traceutil/trace.go:171","msg":"trace[570721906] transaction","detail":"{read_only:false; response_revision:2075; number_of_response:1; }","duration":"223.136699ms","start":"2026-06-30T17:56:42.317274Z","end":"2026-06-30T17:56:42.540411Z","steps":["trace[570721906] 'process raft request' (duration: 217.464343ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:56:42.540662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.477118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:56:42.54077Z","caller":"traceutil/trace.go:171","msg":"trace[67118225] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2075; }","duration":"267.629543ms","start":"2026-06-30T17:56:42.273109Z","end":"2026-06-30T17:56:42.540739Z","steps":["trace[67118225] 'agreement among raft nodes before linearized reading' (duration: 267.292692ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:56:42.619114Z","caller":"traceutil/trace.go:171","msg":"trace[1836289734] transaction","detail":"{read_only:false; response_revision:2076; number_of_response:1; }","duration":"221.581914ms","start":"2026-06-30T17:56:42.39751Z","end":"2026-06-30T17:56:42.619092Z","steps":["trace[1836289734] 'process raft request' (duration: 221.375987ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:56:42.619292Z","caller":"traceutil/trace.go:171","msg":"trace[1336585987] transaction","detail":"{read_only:false; response_revision:2077; number_of_response:1; }","duration":"179.633167ms","start":"2026-06-30T17:56:42.439647Z","end":"2026-06-30T17:56:42.61928Z","steps":["trace[1336585987] 'process raft request' (duration: 179.396289ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:56:42.619724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.29873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:56:42.619781Z","caller":"traceutil/trace.go:171","msg":"trace[2041579506] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:2077; }","duration":"220.416954ms","start":"2026-06-30T17:56:42.399346Z","end":"2026-06-30T17:56:42.619763Z","steps":["trace[2041579506] 'agreement among raft nodes before linearized reading' (duration: 220.321471ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:56:42.821364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.17997ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:56:42.82152Z","caller":"traceutil/trace.go:171","msg":"trace[1170735386] linearizableReadLoop","detail":"{readStateIndex:2160; appliedIndex:2159; }","duration":"201.858125ms","start":"2026-06-30T17:56:42.61964Z","end":"2026-06-30T17:56:42.821498Z","steps":["trace[1170735386] 'read index received' (duration: 48.650669ms)","trace[1170735386] 'applied index is now lower than readState.Index' (duration: 153.206075ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:56:42.821558Z","caller":"traceutil/trace.go:171","msg":"trace[1778181021] transaction","detail":"{read_only:false; response_revision:2078; number_of_response:1; }","duration":"277.357869ms","start":"2026-06-30T17:56:42.544165Z","end":"2026-06-30T17:56:42.821522Z","steps":["trace[1778181021] 'process raft request' (duration: 124.128713ms)","trace[1778181021] 'compare' (duration: 151.986524ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:56:42.82174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.947012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"warn","ts":"2026-06-30T17:56:42.821598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.95709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:56:42.821784Z","caller":"traceutil/trace.go:171","msg":"trace[2049326092] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2078; }","duration":"212.019195ms","start":"2026-06-30T17:56:42.60975Z","end":"2026-06-30T17:56:42.821769Z","steps":["trace[2049326092] 'agreement among raft nodes before linearized reading' (duration: 211.86666ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:56:42.821946Z","caller":"traceutil/trace.go:171","msg":"trace[2057106319] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2078; }","duration":"278.179477ms","start":"2026-06-30T17:56:42.543631Z","end":"2026-06-30T17:56:42.821811Z","steps":["trace[2057106319] 'agreement among raft nodes before linearized reading' (duration: 277.925409ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:56:42.822479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.037932ms","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-30T17:56:42.82262Z","caller":"traceutil/trace.go:171","msg":"trace[477303812] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2078; }","duration":"269.448156ms","start":"2026-06-30T17:56:42.553116Z","end":"2026-06-30T17:56:42.822564Z","steps":["trace[477303812] 'agreement among raft nodes before linearized reading' (duration: 268.511563ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:13.84403Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938292527558938297,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-30T17:58:14.335633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.906307ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"info","ts":"2026-06-30T17:58:14.336489Z","caller":"traceutil/trace.go:171","msg":"trace[1641404064] linearizableReadLoop","detail":"{readStateIndex:2781; appliedIndex:2779; }","duration":"992.997373ms","start":"2026-06-30T17:58:13.343469Z","end":"2026-06-30T17:58:14.336466Z","steps":["trace[1641404064] 'read index received' (duration: 648.250761ms)","trace[1641404064] 'applied index is now lower than readState.Index' (duration: 344.745362ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:58:14.336711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:13.342965Z","time spent":"993.737763ms","remote":"127.0.0.1:34218","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-30T17:58:14.336988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"993.500554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"warn","ts":"2026-06-30T17:58:14.337015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"928.810817ms","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-30T17:58:14.337072Z","caller":"traceutil/trace.go:171","msg":"trace[1723317458] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2677; }","duration":"993.620999ms","start":"2026-06-30T17:58:13.343438Z","end":"2026-06-30T17:58:14.337059Z","steps":["trace[1723317458] 'agreement among raft nodes before linearized reading' (duration: 993.326197ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:14.336989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.598882ms","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-30T17:58:14.337196Z","caller":"traceutil/trace.go:171","msg":"trace[188702277] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2677; }","duration":"542.848612ms","start":"2026-06-30T17:58:13.794337Z","end":"2026-06-30T17:58:14.337186Z","steps":["trace[188702277] 'agreement among raft nodes before linearized reading' (duration: 542.521129ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:14.337177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:13.343426Z","time spent":"993.737243ms","remote":"127.0.0.1:34486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":577,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-06-30T17:58:14.337107Z","caller":"traceutil/trace.go:171","msg":"trace[749470345] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2677; }","duration":"928.951952ms","start":"2026-06-30T17:58:13.408132Z","end":"2026-06-30T17:58:14.337084Z","steps":["trace[749470345] 'agreement among raft nodes before linearized reading' (duration: 928.713732ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:14.337395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:13.40811Z","time spent":"929.277755ms","remote":"127.0.0.1:34486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-30T17:58:14.337235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:13.79432Z","time spent":"542.903165ms","remote":"127.0.0.1:34416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-06-30T17:58:14.33662Z","caller":"traceutil/trace.go:171","msg":"trace[238312979] transaction","detail":"{read_only:false; response_revision:2677; number_of_response:1; }","duration":"984.852395ms","start":"2026-06-30T17:58:13.351745Z","end":"2026-06-30T17:58:14.336597Z","steps":["trace[238312979] 'process raft request' (duration: 984.582944ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:14.337619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"929.199062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-06-30T17:58:14.337713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:13.351723Z","time spent":"985.910659ms","remote":"127.0.0.1:34486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:58:14.337793Z","caller":"traceutil/trace.go:171","msg":"trace[507548556] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2677; }","duration":"929.438983ms","start":"2026-06-30T17:58:13.408292Z","end":"2026-06-30T17:58:14.337731Z","steps":["trace[507548556] 'agreement among raft nodes before linearized reading' (duration: 928.774175ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:14.337203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"892.711646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"warn","ts":"2026-06-30T17:58:14.337886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:13.408251Z","time spent":"929.62138ms","remote":"127.0.0.1:34486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-30T17:58:14.33806Z","caller":"traceutil/trace.go:171","msg":"trace[2142817079] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2677; }","duration":"893.536771ms","start":"2026-06-30T17:58:13.444393Z","end":"2026-06-30T17:58:14.33793Z","steps":["trace[2142817079] 'agreement among raft nodes before linearized reading' (duration: 892.54072ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:14.338181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:13.444362Z","time spent":"893.803152ms","remote":"127.0.0.1:34486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":581,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-06-30T17:58:15.794966Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.343505936s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-30T17:58:15.797853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.346387426s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:58:15.798237Z","caller":"traceutil/trace.go:171","msg":"trace[448318575] linearizableReadLoop","detail":"{readStateIndex:2784; appliedIndex:2781; }","duration":"1.454411099s","start":"2026-06-30T17:58:14.343807Z","end":"2026-06-30T17:58:15.798218Z","steps":["trace[448318575] 'read index received' (duration: 107.687138ms)","trace[448318575] 'applied index is now lower than readState.Index' (duration: 1.346722801s)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:58:15.798323Z","caller":"traceutil/trace.go:171","msg":"trace[356920356] transaction","detail":"{read_only:false; response_revision:2678; number_of_response:1; }","duration":"1.457839871s","start":"2026-06-30T17:58:14.340472Z","end":"2026-06-30T17:58:15.798311Z","steps":["trace[356920356] 'process raft request' (duration: 110.863069ms)","trace[356920356] 'compare' (duration: 1.344625333s)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:58:15.798385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:14.340456Z","time spent":"1.457895223s","remote":"127.0.0.1:34218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:58:15.798652Z","caller":"traceutil/trace.go:171","msg":"trace[1477693276] transaction","detail":"{read_only:false; response_revision:2682; number_of_response:1; }","duration":"1.454111405s","start":"2026-06-30T17:58:14.344506Z","end":"2026-06-30T17:58:15.798618Z","steps":["trace[1477693276] 'process raft request' (duration: 1.453671697s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:15.798835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:14.344497Z","time spent":"1.454220049s","remote":"127.0.0.1:34486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:58:15.798888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.455066166s","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-30T17:58:15.799Z","caller":"traceutil/trace.go:171","msg":"trace[842157333] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2682; }","duration":"1.455226172s","start":"2026-06-30T17:58:14.343749Z","end":"2026-06-30T17:58:15.798975Z","steps":["trace[842157333] 'agreement among raft nodes before linearized reading' (duration: 1.454866347s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:15.799059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:14.34373Z","time spent":"1.455318746s","remote":"127.0.0.1:34416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-06-30T17:58:15.799093Z","caller":"traceutil/trace.go:171","msg":"trace[646594196] transaction","detail":"{read_only:false; response_revision:2681; number_of_response:1; }","duration":"1.454735361s","start":"2026-06-30T17:58:14.344344Z","end":"2026-06-30T17:58:15.79908Z","steps":["trace[646594196] 'process raft request' (duration: 1.453789171s)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:58:15.798934Z","caller":"traceutil/trace.go:171","msg":"trace[474228740] transaction","detail":"{read_only:false; response_revision:2680; number_of_response:1; }","duration":"1.454974801s","start":"2026-06-30T17:58:14.343746Z","end":"2026-06-30T17:58:15.798721Z","steps":["trace[474228740] 'process raft request' (duration: 1.454345985s)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:58:15.799265Z","caller":"traceutil/trace.go:171","msg":"trace[1453765481] transaction","detail":"{read_only:false; response_revision:2679; number_of_response:1; }","duration":"1.455575916s","start":"2026-06-30T17:58:14.343677Z","end":"2026-06-30T17:58:15.799253Z","steps":["trace[1453765481] 'process raft request' (duration: 1.454298323s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:15.799332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:14.34364Z","time spent":"1.45565839s","remote":"127.0.0.1:34486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:58:15.799415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:14.343723Z","time spent":"1.455566256s","remote":"127.0.0.1:34486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:58:15.799162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:14.34433Z","time spent":"1.454798703s","remote":"127.0.0.1:34486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:58:16.299371Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938292527558938313,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-30T17:58:17.052663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"583.149566ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:58:17.053048Z","caller":"traceutil/trace.go:171","msg":"trace[1711110698] linearizableReadLoop","detail":"{readStateIndex:2790; appliedIndex:2786; }","duration":"1.254756437s","start":"2026-06-30T17:58:15.79827Z","end":"2026-06-30T17:58:17.053027Z","steps":["trace[1711110698] 'read index received' (duration: 671.091359ms)","trace[1711110698] 'applied index is now lower than readState.Index' (duration: 583.663758ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:58:17.053176Z","caller":"traceutil/trace.go:171","msg":"trace[146266395] transaction","detail":"{read_only:false; response_revision:2683; number_of_response:1; }","duration":"2.055116361s","start":"2026-06-30T17:58:14.998047Z","end":"2026-06-30T17:58:17.053163Z","steps":["trace[146266395] 'process raft request' (duration: 1.47135398s)","trace[146266395] 'compare' (duration: 582.99417ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:58:17.053308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:14.998026Z","time spent":"2.055210076s","remote":"127.0.0.1:34486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:58:17.053513Z","caller":"traceutil/trace.go:171","msg":"trace[806634133] transaction","detail":"{read_only:false; response_revision:2686; number_of_response:1; }","duration":"1.42949405s","start":"2026-06-30T17:58:15.623991Z","end":"2026-06-30T17:58:17.053485Z","steps":["trace[806634133] 'process raft request' (duration: 1.428982368s)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:58:17.053543Z","caller":"traceutil/trace.go:171","msg":"trace[1079277252] transaction","detail":"{read_only:false; response_revision:2685; number_of_response:1; }","duration":"1.755058947s","start":"2026-06-30T17:58:15.298432Z","end":"2026-06-30T17:58:17.053491Z","steps":["trace[1079277252] 'process raft request' (duration: 1.754496413s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:17.053649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.672561544s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-30T17:58:17.053683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.008297443s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18bded9a6e79a852\" ","response":"range_response_count:1 size:781"} {"level":"info","ts":"2026-06-30T17:58:17.0537Z","caller":"traceutil/trace.go:171","msg":"trace[1899674264] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:2686; }","duration":"2.672667868s","start":"2026-06-30T17:58:14.381018Z","end":"2026-06-30T17:58:17.053686Z","steps":["trace[1899674264] 'agreement among raft nodes before linearized reading' (duration: 2.672572784s)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:58:17.053719Z","caller":"traceutil/trace.go:171","msg":"trace[1117326135] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18bded9a6e79a852; range_end:; response_count:1; response_revision:2686; }","duration":"2.008401278s","start":"2026-06-30T17:58:15.045307Z","end":"2026-06-30T17:58:17.053708Z","steps":["trace[1117326135] 'agreement among raft nodes before linearized reading' (duration: 2.008223661s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:17.053767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:15.045281Z","time spent":"2.008475901s","remote":"127.0.0.1:34272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":803,"request content":"key:\"/registry/events/auth-system/keycloak-0.18bded9a6e79a852\" "} {"level":"warn","ts":"2026-06-30T17:58:17.053848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.306477553s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"warn","ts":"2026-06-30T17:58:17.053846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.085214185s","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-30T17:58:17.053875Z","caller":"traceutil/trace.go:171","msg":"trace[350356819] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2686; }","duration":"2.306559318s","start":"2026-06-30T17:58:14.74731Z","end":"2026-06-30T17:58:17.05387Z","steps":["trace[350356819] 'agreement among raft nodes before linearized reading' (duration: 2.306485945s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:17.053891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:14.747283Z","time spent":"2.306604019s","remote":"127.0.0.1:34426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1391,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"info","ts":"2026-06-30T17:58:17.053895Z","caller":"traceutil/trace.go:171","msg":"trace[70802406] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2686; }","duration":"2.085300628s","start":"2026-06-30T17:58:14.968571Z","end":"2026-06-30T17:58:17.053872Z","steps":["trace[70802406] 'agreement among raft nodes before linearized reading' (duration: 2.085173582s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:17.053914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:14.968541Z","time spent":"2.08536793s","remote":"127.0.0.1:34486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-30T17:58:17.053908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:15.298415Z","time spent":"1.755213363s","remote":"127.0.0.1:34486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:58:17.05373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:14.380998Z","time spent":"2.672725911s","remote":"127.0.0.1:51560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"warn","ts":"2026-06-30T17:58:17.053584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.394304965s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-30T17:58:17.053661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:15.623962Z","time spent":"1.429618535s","remote":"127.0.0.1:34486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:58:17.054108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.780253705s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-30T17:58:17.054116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.252119239s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:9281"} {"level":"info","ts":"2026-06-30T17:58:17.054195Z","caller":"traceutil/trace.go:171","msg":"trace[1025217102] transaction","detail":"{read_only:false; response_revision:2684; number_of_response:1; }","duration":"1.889858746s","start":"2026-06-30T17:58:15.164325Z","end":"2026-06-30T17:58:17.054184Z","steps":["trace[1025217102] 'process raft request' (duration: 1.888479358s)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:58:17.054245Z","caller":"traceutil/trace.go:171","msg":"trace[44515219] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:2686; }","duration":"1.394845978s","start":"2026-06-30T17:58:15.659174Z","end":"2026-06-30T17:58:17.05402Z","steps":["trace[44515219] 'agreement among raft nodes before linearized reading' (duration: 1.394296775s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:17.054351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:15.16429Z","time spent":"1.889997182s","remote":"127.0.0.1:34486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:58:17.054157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"710.569253ms","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-30T17:58:17.054171Z","caller":"traceutil/trace.go:171","msg":"trace[602919691] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2686; }","duration":"1.780351269s","start":"2026-06-30T17:58:15.273802Z","end":"2026-06-30T17:58:17.054153Z","steps":["trace[602919691] 'agreement among raft nodes before linearized reading' (duration: 1.780143211s)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:58:17.054432Z","caller":"traceutil/trace.go:171","msg":"trace[1914935992] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2686; }","duration":"710.895396ms","start":"2026-06-30T17:58:16.343527Z","end":"2026-06-30T17:58:17.054423Z","steps":["trace[1914935992] 'agreement among raft nodes before linearized reading' (duration: 710.587874ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:17.054465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:16.343502Z","time spent":"710.952939ms","remote":"127.0.0.1:34486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-30T17:58:17.054372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:15.659145Z","time spent":"1.395203402s","remote":"127.0.0.1:51370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-06-30T17:58:17.054579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:15.273784Z","time spent":"1.780654312s","remote":"127.0.0.1:34180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-30T17:58:17.05386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.9449835s","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-30T17:58:17.054247Z","caller":"traceutil/trace.go:171","msg":"trace[1810149663] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:2686; }","duration":"1.252335787s","start":"2026-06-30T17:58:15.801891Z","end":"2026-06-30T17:58:17.054227Z","steps":["trace[1810149663] 'agreement among raft nodes before linearized reading' (duration: 1.251991293s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:17.054853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:15.801867Z","time spent":"1.252974594s","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":9303,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-06-30T17:58:17.054745Z","caller":"traceutil/trace.go:171","msg":"trace[2099581405] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2686; }","duration":"1.945872446s","start":"2026-06-30T17:58:15.10886Z","end":"2026-06-30T17:58:17.054733Z","steps":["trace[2099581405] 'agreement among raft nodes before linearized reading' (duration: 1.944450468s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:17.055074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:15.108786Z","time spent":"1.946275023s","remote":"127.0.0.1:34486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-30T17:58:17.054284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.251354507s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-06-30T17:58:17.055238Z","caller":"traceutil/trace.go:171","msg":"trace[727611935] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:2686; }","duration":"1.252329507s","start":"2026-06-30T17:58:15.802899Z","end":"2026-06-30T17:58:17.055229Z","steps":["trace[727611935] 'agreement among raft nodes before linearized reading' (duration: 1.251362377s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:17.055269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:15.802888Z","time spent":"1.252370169s","remote":"127.0.0.1:34402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":444,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"warn","ts":"2026-06-30T17:58:18.004253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"738.636685ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:58:18.004371Z","caller":"traceutil/trace.go:171","msg":"trace[303750718] linearizableReadLoop","detail":"{readStateIndex:2791; appliedIndex:2790; }","duration":"947.532861ms","start":"2026-06-30T17:58:17.05682Z","end":"2026-06-30T17:58:18.004353Z","steps":["trace[303750718] 'read index received' (duration: 208.778591ms)","trace[303750718] 'applied index is now lower than readState.Index' (duration: 738.75295ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:58:18.004464Z","caller":"traceutil/trace.go:171","msg":"trace[1022343807] transaction","detail":"{read_only:false; response_revision:2687; number_of_response:1; }","duration":"947.982349ms","start":"2026-06-30T17:58:17.05647Z","end":"2026-06-30T17:58:18.004453Z","steps":["trace[1022343807] 'process raft request' (duration: 209.051732ms)","trace[1022343807] 'compare' (duration: 738.50987ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:58:18.004522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:17.056436Z","time spent":"948.053603ms","remote":"127.0.0.1:34272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":766,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:58:18.004724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"947.878175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:58:18.004797Z","caller":"traceutil/trace.go:171","msg":"trace[577691299] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2687; }","duration":"947.975418ms","start":"2026-06-30T17:58:17.056802Z","end":"2026-06-30T17:58:18.004778Z","steps":["trace[577691299] 'agreement among raft nodes before linearized reading' (duration: 947.817492ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:18.00485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:17.056779Z","time spent":"948.063552ms","remote":"127.0.0.1:34188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-30T17:58:18.256442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.645807ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:58:18.256615Z","caller":"traceutil/trace.go:171","msg":"trace[1210680820] linearizableReadLoop","detail":"{readStateIndex:2794; appliedIndex:2791; }","duration":"252.204169ms","start":"2026-06-30T17:58:18.004397Z","end":"2026-06-30T17:58:18.256601Z","steps":["trace[1210680820] 'read index received' (duration: 146.25863ms)","trace[1210680820] 'applied index is now lower than readState.Index' (duration: 105.944749ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:58:18.256785Z","caller":"traceutil/trace.go:171","msg":"trace[488858991] transaction","detail":"{read_only:false; response_revision:2688; number_of_response:1; }","duration":"1.1961402s","start":"2026-06-30T17:58:17.060636Z","end":"2026-06-30T17:58:18.256777Z","steps":["trace[488858991] 'process raft request' (duration: 1.090083057s)","trace[488858991] 'compare' (duration: 105.037971ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:58:18.256829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:17.06061Z","time spent":"1.196195662s","remote":"127.0.0.1:34486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:58:18.256969Z","caller":"traceutil/trace.go:171","msg":"trace[647772953] transaction","detail":"{read_only:false; response_revision:2689; number_of_response:1; }","duration":"1.196195202s","start":"2026-06-30T17:58:17.060767Z","end":"2026-06-30T17:58:18.256962Z","steps":["trace[647772953] 'process raft request' (duration: 1.195755104s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:18.257005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:17.060761Z","time spent":"1.196222284s","remote":"127.0.0.1:34486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:58:18.257087Z","caller":"traceutil/trace.go:171","msg":"trace[1527776840] transaction","detail":"{read_only:false; response_revision:2690; number_of_response:1; }","duration":"1.196257125s","start":"2026-06-30T17:58:17.060825Z","end":"2026-06-30T17:58:18.257082Z","steps":["trace[1527776840] 'process raft request' (duration: 1.195741384s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:18.257119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:17.060811Z","time spent":"1.196290267s","remote":"127.0.0.1:34486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:58:18.257239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.727179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T17:58:18.257302Z","caller":"traceutil/trace.go:171","msg":"trace[502544321] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:2690; }","duration":"418.830813ms","start":"2026-06-30T17:58:17.838458Z","end":"2026-06-30T17:58:18.257289Z","steps":["trace[502544321] 'agreement among raft nodes before linearized reading' (duration: 418.73684ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:18.257323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:17.838437Z","time spent":"418.880726ms","remote":"127.0.0.1:34402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":21,"response size":29,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "} {"level":"warn","ts":"2026-06-30T17:58:18.257419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.196320168s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-30T17:58:18.257479Z","caller":"traceutil/trace.go:171","msg":"trace[795231111] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:2690; }","duration":"1.196429162s","start":"2026-06-30T17:58:17.061035Z","end":"2026-06-30T17:58:18.257464Z","steps":["trace[795231111] 'agreement among raft nodes before linearized reading' (duration: 1.196171981s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:18.257514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:17.061027Z","time spent":"1.196477664s","remote":"127.0.0.1:34218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" "} {"level":"warn","ts":"2026-06-30T17:58:18.257581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.196907762s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-metrics\" ","response":"range_response_count:1 size:1443"} {"level":"info","ts":"2026-06-30T17:58:18.257605Z","caller":"traceutil/trace.go:171","msg":"trace[165262460] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-metrics; range_end:; response_count:1; response_revision:2690; }","duration":"1.196966174s","start":"2026-06-30T17:58:17.060633Z","end":"2026-06-30T17:58:18.257599Z","steps":["trace[165262460] 'agreement among raft nodes before linearized reading' (duration: 1.19687123s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:18.257623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:17.060615Z","time spent":"1.197004286s","remote":"127.0.0.1:34426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":1465,"request content":"key:\"/registry/services/specs/auth-system/keycloak-metrics\" "} {"level":"warn","ts":"2026-06-30T17:58:18.257719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.189404ms","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-30T17:58:18.257741Z","caller":"traceutil/trace.go:171","msg":"trace[1198041583] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2690; }","duration":"452.222826ms","start":"2026-06-30T17:58:17.805511Z","end":"2026-06-30T17:58:18.257733Z","steps":["trace[1198041583] 'agreement among raft nodes before linearized reading' (duration: 452.157793ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:18.25776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:17.805504Z","time spent":"452.252377ms","remote":"127.0.0.1:34486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-30T17:58:18.257922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.439545ms","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-30T17:58:18.25794Z","caller":"traceutil/trace.go:171","msg":"trace[316950616] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2690; }","duration":"452.476597ms","start":"2026-06-30T17:58:17.805458Z","end":"2026-06-30T17:58:18.257934Z","steps":["trace[316950616] 'agreement among raft nodes before linearized reading' (duration: 452.415295ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:18.257957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:17.805449Z","time spent":"452.504798ms","remote":"127.0.0.1:34486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-30T17:58:18.258056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.167045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-06-30T17:58:18.258074Z","caller":"traceutil/trace.go:171","msg":"trace[210424602] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2690; }","duration":"453.235489ms","start":"2026-06-30T17:58:17.804832Z","end":"2026-06-30T17:58:18.258067Z","steps":["trace[210424602] 'agreement among raft nodes before linearized reading' (duration: 453.185897ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:18.258091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:17.804792Z","time spent":"453.29491ms","remote":"127.0.0.1:34486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":577,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-06-30T17:58:18.258163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.136974384s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:58:18.258188Z","caller":"traceutil/trace.go:171","msg":"trace[1238683261] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2690; }","duration":"1.137044297s","start":"2026-06-30T17:58:17.121138Z","end":"2026-06-30T17:58:18.258183Z","steps":["trace[1238683261] 'agreement among raft nodes before linearized reading' (duration: 1.137005476s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:18.258206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:17.121117Z","time spent":"1.137085669s","remote":"127.0.0.1:34660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":27,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-06-30T17:58:18.25902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.329585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:58:18.259051Z","caller":"traceutil/trace.go:171","msg":"trace[2038714868] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2691; }","duration":"246.392217ms","start":"2026-06-30T17:58:18.012651Z","end":"2026-06-30T17:58:18.259043Z","steps":["trace[2038714868] 'agreement among raft nodes before linearized reading' (duration: 246.337695ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:18.259118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.51488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-30T17:58:18.259166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.989587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:58:18.259168Z","caller":"traceutil/trace.go:171","msg":"trace[134345047] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:2691; }","duration":"134.608245ms","start":"2026-06-30T17:58:18.124547Z","end":"2026-06-30T17:58:18.259155Z","steps":["trace[134345047] 'agreement among raft nodes before linearized reading' (duration: 134.4853ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:58:18.259187Z","caller":"traceutil/trace.go:171","msg":"trace[1976982650] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:2691; }","duration":"232.011218ms","start":"2026-06-30T17:58:18.027168Z","end":"2026-06-30T17:58:18.259179Z","steps":["trace[1976982650] 'agreement among raft nodes before linearized reading' (duration: 231.980126ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:45.848582Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938292527558938734,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-30T17:58:46.311697Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.26301789s","expected-duration":"1s"} {"level":"info","ts":"2026-06-30T17:58:46.312047Z","caller":"traceutil/trace.go:171","msg":"trace[1146615594] transaction","detail":"{read_only:false; response_revision:2831; number_of_response:1; }","duration":"1.263479939s","start":"2026-06-30T17:58:45.048536Z","end":"2026-06-30T17:58:46.312016Z","steps":["trace[1146615594] 'process raft request' (duration: 1.263323472s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:46.31223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:45.048511Z","time spent":"1.263618414s","remote":"127.0.0.1:34272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":766,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:58:46.368952Z","caller":"traceutil/trace.go:171","msg":"trace[1699730602] transaction","detail":"{read_only:false; response_revision:2832; number_of_response:1; }","duration":"1.198488923s","start":"2026-06-30T17:58:45.170434Z","end":"2026-06-30T17:58:46.368923Z","steps":["trace[1699730602] 'process raft request' (duration: 1.198272834s)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:58:46.369286Z","caller":"traceutil/trace.go:171","msg":"trace[545752877] transaction","detail":"{read_only:false; response_revision:2833; number_of_response:1; }","duration":"1.192786382s","start":"2026-06-30T17:58:45.17646Z","end":"2026-06-30T17:58:46.369246Z","steps":["trace[545752877] 'process raft request' (duration: 1.192405976s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:46.369283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:45.170408Z","time spent":"1.198613998s","remote":"127.0.0.1:34486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:58:46.36939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:45.176425Z","time spent":"1.192910757s","remote":"127.0.0.1:34486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:58:46.369408Z","caller":"traceutil/trace.go:171","msg":"trace[1281587553] linearizableReadLoop","detail":"{readStateIndex:2944; appliedIndex:2941; }","duration":"1.021258075s","start":"2026-06-30T17:58:45.348118Z","end":"2026-06-30T17:58:46.369376Z","steps":["trace[1281587553] 'read index received' (duration: 963.905962ms)","trace[1281587553] 'applied index is now lower than readState.Index' (duration: 57.350413ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:58:46.369518Z","caller":"traceutil/trace.go:171","msg":"trace[1287908738] transaction","detail":"{read_only:false; response_revision:2834; number_of_response:1; }","duration":"1.191977416s","start":"2026-06-30T17:58:45.177517Z","end":"2026-06-30T17:58:46.369495Z","steps":["trace[1287908738] 'process raft request' (duration: 1.191604951s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:46.369597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:45.177498Z","time spent":"1.19206574s","remote":"127.0.0.1:34486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:58:46.369691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.021577739s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1988"} {"level":"warn","ts":"2026-06-30T17:58:46.369695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"933.308445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T17:58:46.36975Z","caller":"traceutil/trace.go:171","msg":"trace[1858389611] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:2834; }","duration":"1.021689553s","start":"2026-06-30T17:58:45.348045Z","end":"2026-06-30T17:58:46.369734Z","steps":["trace[1858389611] 'agreement among raft nodes before linearized reading' (duration: 1.021480435s)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:58:46.369774Z","caller":"traceutil/trace.go:171","msg":"trace[1946771285] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:2834; }","duration":"933.453311ms","start":"2026-06-30T17:58:45.436307Z","end":"2026-06-30T17:58:46.36976Z","steps":["trace[1946771285] 'agreement among raft nodes before linearized reading' (duration: 933.289515ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:46.369785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:45.348018Z","time spent":"1.021760006s","remote":"127.0.0.1:34426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":2010,"request content":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" "} {"level":"warn","ts":"2026-06-30T17:58:46.36983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:45.436287Z","time spent":"933.529915ms","remote":"127.0.0.1:34326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":10,"response size":29,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"warn","ts":"2026-06-30T17:58:46.37015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"556.620977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-06-30T17:58:46.370277Z","caller":"traceutil/trace.go:171","msg":"trace[1021234243] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2834; }","duration":"556.832688ms","start":"2026-06-30T17:58:45.813405Z","end":"2026-06-30T17:58:46.370238Z","steps":["trace[1021234243] 'agreement among raft nodes before linearized reading' (duration: 556.21044ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:46.37035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:45.813375Z","time spent":"556.959603ms","remote":"127.0.0.1:34486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":581,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-06-30T17:58:46.676429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.011371ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:58:46.67668Z","caller":"traceutil/trace.go:171","msg":"trace[752534714] transaction","detail":"{read_only:false; response_revision:2837; number_of_response:1; }","duration":"235.575577ms","start":"2026-06-30T17:58:46.441075Z","end":"2026-06-30T17:58:46.676651Z","steps":["trace[752534714] 'process raft request' (duration: 116.211951ms)","trace[752534714] 'compare' (duration: 118.74376ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:58:46.676921Z","caller":"traceutil/trace.go:171","msg":"trace[1287564054] transaction","detail":"{read_only:false; response_revision:2838; number_of_response:1; }","duration":"235.814477ms","start":"2026-06-30T17:58:46.441087Z","end":"2026-06-30T17:58:46.676902Z","steps":["trace[1287564054] 'process raft request' (duration: 235.442571ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:58:46.677193Z","caller":"traceutil/trace.go:171","msg":"trace[1937682916] transaction","detail":"{read_only:false; response_revision:2839; number_of_response:1; }","duration":"236.059827ms","start":"2026-06-30T17:58:46.441095Z","end":"2026-06-30T17:58:46.677155Z","steps":["trace[1937682916] 'process raft request' (duration: 235.746614ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:58:46.677219Z","caller":"traceutil/trace.go:171","msg":"trace[1539393817] transaction","detail":"{read_only:false; response_revision:2841; number_of_response:1; }","duration":"236.018785ms","start":"2026-06-30T17:58:46.441187Z","end":"2026-06-30T17:58:46.677206Z","steps":["trace[1539393817] 'process raft request' (duration: 235.970063ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:58:46.677232Z","caller":"traceutil/trace.go:171","msg":"trace[1960802961] transaction","detail":"{read_only:false; response_revision:2840; number_of_response:1; }","duration":"236.060438ms","start":"2026-06-30T17:58:46.441147Z","end":"2026-06-30T17:58:46.677207Z","steps":["trace[1960802961] 'process raft request' (duration: 235.853689ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:58:48.54183Z","caller":"traceutil/trace.go:171","msg":"trace[46550567] transaction","detail":"{read_only:false; response_revision:2844; number_of_response:1; }","duration":"163.85853ms","start":"2026-06-30T17:58:48.377929Z","end":"2026-06-30T17:58:48.541787Z","steps":["trace[46550567] 'process raft request' (duration: 163.734315ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:58:48.542125Z","caller":"traceutil/trace.go:171","msg":"trace[347159487] transaction","detail":"{read_only:false; response_revision:2843; number_of_response:1; }","duration":"165.455318ms","start":"2026-06-30T17:58:48.376604Z","end":"2026-06-30T17:58:48.54206Z","steps":["trace[347159487] 'process raft request' (duration: 164.882224ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:58:48.542074Z","caller":"traceutil/trace.go:171","msg":"trace[1771900743] transaction","detail":"{read_only:false; response_revision:2845; number_of_response:1; }","duration":"164.010267ms","start":"2026-06-30T17:58:48.378039Z","end":"2026-06-30T17:58:48.542049Z","steps":["trace[1771900743] 'process raft request' (duration: 163.675493ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:58:48.862792Z","caller":"traceutil/trace.go:171","msg":"trace[624577260] transaction","detail":"{read_only:false; response_revision:2847; number_of_response:1; }","duration":"175.686662ms","start":"2026-06-30T17:58:48.687067Z","end":"2026-06-30T17:58:48.862754Z","steps":["trace[624577260] 'process raft request' (duration: 86.394379ms)","trace[624577260] 'compare' (duration: 88.797262ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:58:48.862908Z","caller":"traceutil/trace.go:171","msg":"trace[872568596] transaction","detail":"{read_only:false; response_revision:2848; number_of_response:1; }","duration":"175.710863ms","start":"2026-06-30T17:58:48.687165Z","end":"2026-06-30T17:58:48.862876Z","steps":["trace[872568596] 'process raft request' (duration: 175.564617ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:58:48.863233Z","caller":"traceutil/trace.go:171","msg":"trace[32324751] transaction","detail":"{read_only:false; response_revision:2849; number_of_response:1; }","duration":"175.943243ms","start":"2026-06-30T17:58:48.687261Z","end":"2026-06-30T17:58:48.863205Z","steps":["trace[32324751] 'process raft request' (duration: 175.570097ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:58:48.863551Z","caller":"traceutil/trace.go:171","msg":"trace[1053342594] linearizableReadLoop","detail":"{readStateIndex:2962; appliedIndex:2957; }","duration":"114.990405ms","start":"2026-06-30T17:58:48.748545Z","end":"2026-06-30T17:58:48.863536Z","steps":["trace[1053342594] 'read index received' (duration: 24.835284ms)","trace[1053342594] 'applied index is now lower than readState.Index' (duration: 90.15376ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:58:48.863612Z","caller":"traceutil/trace.go:171","msg":"trace[397698354] transaction","detail":"{read_only:false; response_revision:2851; number_of_response:1; }","duration":"175.877321ms","start":"2026-06-30T17:58:48.687719Z","end":"2026-06-30T17:58:48.863596Z","steps":["trace[397698354] 'process raft request' (duration: 175.756566ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:58:48.863593Z","caller":"traceutil/trace.go:171","msg":"trace[334797015] transaction","detail":"{read_only:false; response_revision:2850; number_of_response:1; }","duration":"176.140483ms","start":"2026-06-30T17:58:48.687418Z","end":"2026-06-30T17:58:48.863559Z","steps":["trace[334797015] 'process raft request' (duration: 175.886781ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:48.863743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.176342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-06-30T17:58:48.863781Z","caller":"traceutil/trace.go:171","msg":"trace[736939425] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2851; }","duration":"115.259616ms","start":"2026-06-30T17:58:48.748511Z","end":"2026-06-30T17:58:48.86377Z","steps":["trace[736939425] 'agreement among raft nodes before linearized reading' (duration: 115.088139ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:49.128465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.792335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:58:49.128558Z","caller":"traceutil/trace.go:171","msg":"trace[1858838105] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2851; }","duration":"165.962032ms","start":"2026-06-30T17:58:48.962572Z","end":"2026-06-30T17:58:49.128534Z","steps":["trace[1858838105] 'range keys from in-memory index tree' (duration: 165.67037ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:49.128653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.369028ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:58:49.128898Z","caller":"traceutil/trace.go:171","msg":"trace[740513141] transaction","detail":"{read_only:false; response_revision:2852; number_of_response:1; }","duration":"142.639632ms","start":"2026-06-30T17:58:48.986229Z","end":"2026-06-30T17:58:49.128868Z","steps":["trace[740513141] 'process raft request' (duration: 40.92834ms)","trace[740513141] 'compare' (duration: 101.205241ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:58:50.651388Z","caller":"traceutil/trace.go:171","msg":"trace[1958806422] transaction","detail":"{read_only:false; response_revision:2855; number_of_response:1; }","duration":"102.876935ms","start":"2026-06-30T17:58:50.548487Z","end":"2026-06-30T17:58:50.651364Z","steps":["trace[1958806422] 'process raft request' (duration: 102.717398ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:58:50.751136Z","caller":"traceutil/trace.go:171","msg":"trace[1482377797] linearizableReadLoop","detail":"{readStateIndex:2968; appliedIndex:2965; }","duration":"127.603575ms","start":"2026-06-30T17:58:50.623515Z","end":"2026-06-30T17:58:50.751119Z","steps":["trace[1482377797] 'read index received' (duration: 27.748309ms)","trace[1482377797] 'applied index is now lower than readState.Index' (duration: 99.854246ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:58:50.751274Z","caller":"traceutil/trace.go:171","msg":"trace[579966617] transaction","detail":"{read_only:false; response_revision:2856; number_of_response:1; }","duration":"202.566783ms","start":"2026-06-30T17:58:50.548697Z","end":"2026-06-30T17:58:50.751264Z","steps":["trace[579966617] 'process raft request' (duration: 202.189007ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:58:50.751427Z","caller":"traceutil/trace.go:171","msg":"trace[1328449052] transaction","detail":"{read_only:false; response_revision:2857; number_of_response:1; }","duration":"199.464311ms","start":"2026-06-30T17:58:50.55195Z","end":"2026-06-30T17:58:50.751414Z","steps":["trace[1328449052] 'process raft request' (duration: 199.118486ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:50.751568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.005082ms","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-30T17:58:50.751673Z","caller":"traceutil/trace.go:171","msg":"trace[1939336775] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2857; }","duration":"128.203711ms","start":"2026-06-30T17:58:50.623451Z","end":"2026-06-30T17:58:50.751655Z","steps":["trace[1939336775] 'agreement among raft nodes before linearized reading' (duration: 127.912028ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:50.751677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.427928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:58:50.751765Z","caller":"traceutil/trace.go:171","msg":"trace[848078835] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:2857; }","duration":"103.554653ms","start":"2026-06-30T17:58:50.648188Z","end":"2026-06-30T17:58:50.751743Z","steps":["trace[848078835] 'agreement among raft nodes before linearized reading' (duration: 103.378745ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:51.103169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.699814ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:58:51.1034Z","caller":"traceutil/trace.go:171","msg":"trace[526762144] linearizableReadLoop","detail":"{readStateIndex:2969; appliedIndex:2968; }","duration":"344.428597ms","start":"2026-06-30T17:58:50.758947Z","end":"2026-06-30T17:58:51.103376Z","steps":["trace[526762144] 'read index received' (duration: 104.390939ms)","trace[526762144] 'applied index is now lower than readState.Index' (duration: 240.035347ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:58:51.103535Z","caller":"traceutil/trace.go:171","msg":"trace[1196339835] transaction","detail":"{read_only:false; response_revision:2858; number_of_response:1; }","duration":"345.713261ms","start":"2026-06-30T17:58:50.757807Z","end":"2026-06-30T17:58:51.10352Z","steps":["trace[1196339835] 'process raft request' (duration: 105.527097ms)","trace[1196339835] 'compare' (duration: 239.167181ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:58:51.103644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:50.75779Z","time spent":"345.812904ms","remote":"127.0.0.1:34486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:58:51.103762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.74843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T17:58:51.103895Z","caller":"traceutil/trace.go:171","msg":"trace[1537035543] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:2858; }","duration":"237.922227ms","start":"2026-06-30T17:58:50.865924Z","end":"2026-06-30T17:58:51.103846Z","steps":["trace[1537035543] 'agreement among raft nodes before linearized reading' (duration: 237.707888ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:51.104072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.033527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-30T17:58:51.104119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.198034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-30T17:58:51.104126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.016016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-06-30T17:58:51.104171Z","caller":"traceutil/trace.go:171","msg":"trace[742084324] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2858; }","duration":"236.297128ms","start":"2026-06-30T17:58:50.867859Z","end":"2026-06-30T17:58:51.104156Z","steps":["trace[742084324] 'agreement among raft nodes before linearized reading' (duration: 236.145372ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:58:51.104194Z","caller":"traceutil/trace.go:171","msg":"trace[1102260022] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2858; }","duration":"236.126921ms","start":"2026-06-30T17:58:50.86801Z","end":"2026-06-30T17:58:51.104137Z","steps":["trace[1102260022] 'agreement among raft nodes before linearized reading' (duration: 235.831658ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:58:51.104203Z","caller":"traceutil/trace.go:171","msg":"trace[1451150260] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2858; }","duration":"236.10525ms","start":"2026-06-30T17:58:50.868069Z","end":"2026-06-30T17:58:51.104174Z","steps":["trace[1451150260] 'agreement among raft nodes before linearized reading' (duration: 235.928733ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:51.104088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.133176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak\" ","response":"range_response_count:1 size:1317"} {"level":"info","ts":"2026-06-30T17:58:51.10443Z","caller":"traceutil/trace.go:171","msg":"trace[299343910] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak; range_end:; response_count:1; response_revision:2858; }","duration":"345.46769ms","start":"2026-06-30T17:58:50.758924Z","end":"2026-06-30T17:58:51.104392Z","steps":["trace[299343910] 'agreement among raft nodes before linearized reading' (duration: 344.909797ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:51.104512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:50.758909Z","time spent":"345.589705ms","remote":"127.0.0.1:34426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":1339,"request content":"key:\"/registry/services/specs/auth-system/keycloak\" "} {"level":"warn","ts":"2026-06-30T17:58:51.10406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.463743ms","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-30T17:58:51.104681Z","caller":"traceutil/trace.go:171","msg":"trace[108255360] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2858; }","duration":"236.092971ms","start":"2026-06-30T17:58:50.868545Z","end":"2026-06-30T17:58:51.104638Z","steps":["trace[108255360] 'agreement among raft nodes before linearized reading' (duration: 235.294816ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:51.104127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.682782ms","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-30T17:58:51.105094Z","caller":"traceutil/trace.go:171","msg":"trace[862720428] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2858; }","duration":"236.664985ms","start":"2026-06-30T17:58:50.868398Z","end":"2026-06-30T17:58:51.105063Z","steps":["trace[862720428] 'agreement among raft nodes before linearized reading' (duration: 235.432952ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:58:51.323727Z","caller":"traceutil/trace.go:171","msg":"trace[1378537105] transaction","detail":"{read_only:false; response_revision:2861; number_of_response:1; }","duration":"212.865795ms","start":"2026-06-30T17:58:51.110828Z","end":"2026-06-30T17:58:51.323693Z","steps":["trace[1378537105] 'process raft request' (duration: 189.291211ms)","trace[1378537105] 'compare' (duration: 23.148526ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:58:51.323906Z","caller":"traceutil/trace.go:171","msg":"trace[796042583] transaction","detail":"{read_only:false; response_revision:2862; number_of_response:1; }","duration":"212.693968ms","start":"2026-06-30T17:58:51.111187Z","end":"2026-06-30T17:58:51.323881Z","steps":["trace[796042583] 'process raft request' (duration: 212.350143ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:58:51.324066Z","caller":"traceutil/trace.go:171","msg":"trace[1441295584] transaction","detail":"{read_only:false; response_revision:2863; number_of_response:1; }","duration":"212.131804ms","start":"2026-06-30T17:58:51.111922Z","end":"2026-06-30T17:58:51.324054Z","steps":["trace[1441295584] 'process raft request' (duration: 211.722817ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:51.69474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.490307ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:58:51.694887Z","caller":"traceutil/trace.go:171","msg":"trace[345209669] transaction","detail":"{read_only:false; response_revision:2864; number_of_response:1; }","duration":"230.016564ms","start":"2026-06-30T17:58:51.464842Z","end":"2026-06-30T17:58:51.694859Z","steps":["trace[345209669] 'process raft request' (duration: 61.245796ms)","trace[345209669] 'compare' (duration: 167.724824ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:58:52.862726Z","caller":"traceutil/trace.go:171","msg":"trace[2082612519] linearizableReadLoop","detail":"{readStateIndex:2978; appliedIndex:2976; }","duration":"100.473516ms","start":"2026-06-30T17:58:52.762228Z","end":"2026-06-30T17:58:52.862702Z","steps":["trace[2082612519] 'read index received' (duration: 20.484002ms)","trace[2082612519] 'applied index is now lower than readState.Index' (duration: 79.988544ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:58:52.862914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.662664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/auth-system/keycloak\" ","response":"range_response_count:1 size:7341"} {"level":"info","ts":"2026-06-30T17:58:52.862958Z","caller":"traceutil/trace.go:171","msg":"trace[473341538] range","detail":"{range_begin:/registry/statefulsets/auth-system/keycloak; range_end:; response_count:1; response_revision:2867; }","duration":"100.745397ms","start":"2026-06-30T17:58:52.762202Z","end":"2026-06-30T17:58:52.862948Z","steps":["trace[473341538] 'agreement among raft nodes before linearized reading' (duration: 100.593081ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:58:52.862943Z","caller":"traceutil/trace.go:171","msg":"trace[416582512] transaction","detail":"{read_only:false; response_revision:2867; number_of_response:1; }","duration":"103.567847ms","start":"2026-06-30T17:58:52.759354Z","end":"2026-06-30T17:58:52.862922Z","steps":["trace[416582512] 'process raft request' (duration: 103.258434ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:00:45.520309Z","caller":"traceutil/trace.go:171","msg":"trace[604617105] transaction","detail":"{read_only:false; response_revision:3544; number_of_response:1; }","duration":"212.109238ms","start":"2026-06-30T18:00:45.308168Z","end":"2026-06-30T18:00:45.520277Z","steps":["trace[604617105] 'process raft request' (duration: 211.866324ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:00:45.52031Z","caller":"traceutil/trace.go:171","msg":"trace[1723985425] linearizableReadLoop","detail":"{readStateIndex:3683; appliedIndex:3682; }","duration":"172.484762ms","start":"2026-06-30T18:00:45.347759Z","end":"2026-06-30T18:00:45.520244Z","steps":["trace[1723985425] 'read index received' (duration: 172.30474ms)","trace[1723985425] 'applied index is now lower than readState.Index' (duration: 178.532µs)"],"step_count":2} {"level":"warn","ts":"2026-06-30T18:00:45.520716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.924608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1988"} {"level":"info","ts":"2026-06-30T18:00:45.520824Z","caller":"traceutil/trace.go:171","msg":"trace[814602370] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:3544; }","duration":"173.08699ms","start":"2026-06-30T18:00:45.347712Z","end":"2026-06-30T18:00:45.520799Z","steps":["trace[814602370] 'agreement among raft nodes before linearized reading' (duration: 172.606133ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:00:45.521037Z","caller":"traceutil/trace.go:171","msg":"trace[859097024] transaction","detail":"{read_only:false; response_revision:3545; number_of_response:1; }","duration":"134.53975ms","start":"2026-06-30T18:00:45.386464Z","end":"2026-06-30T18:00:45.521004Z","steps":["trace[859097024] 'process raft request' (duration: 134.265346ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:02:18.567895Z","caller":"traceutil/trace.go:171","msg":"trace[641697504] transaction","detail":"{read_only:false; response_revision:4647; number_of_response:1; }","duration":"104.067245ms","start":"2026-06-30T18:02:18.463796Z","end":"2026-06-30T18:02:18.567863Z","steps":["trace[641697504] 'process raft request' (duration: 74.026341ms)","trace[641697504] 'compare' (duration: 29.89273ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T18:02:18.754417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.236378ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"warn","ts":"2026-06-30T18:02:21.235325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.658192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-04233a60-df59-4b69-9258-68a4e487b486\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-06-30T18:02:21.235403Z","caller":"traceutil/trace.go:171","msg":"trace[180411780] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-04233a60-df59-4b69-9258-68a4e487b486; range_end:; response_count:1; response_revision:4720; }","duration":"105.784756ms","start":"2026-06-30T18:02:21.129602Z","end":"2026-06-30T18:02:21.235387Z","steps":["trace[180411780] 'range keys from in-memory index tree' (duration: 105.451697ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:02:34.521792Z","caller":"traceutil/trace.go:171","msg":"trace[363323401] transaction","detail":"{read_only:false; response_revision:4893; number_of_response:1; }","duration":"221.066024ms","start":"2026-06-30T18:02:34.300699Z","end":"2026-06-30T18:02:34.521765Z","steps":["trace[363323401] 'process raft request' (duration: 220.887909ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:02:34.522185Z","caller":"traceutil/trace.go:171","msg":"trace[2122288186] linearizableReadLoop","detail":"{readStateIndex:5082; appliedIndex:5082; }","duration":"219.82744ms","start":"2026-06-30T18:02:34.30234Z","end":"2026-06-30T18:02:34.522168Z","steps":["trace[2122288186] 'read index received' (duration: 219.82175ms)","trace[2122288186] 'applied index is now lower than readState.Index' (duration: 4.7µs)"],"step_count":2} {"level":"warn","ts":"2026-06-30T18:02:34.522779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.406406ms","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-30T18:02:34.522954Z","caller":"traceutil/trace.go:171","msg":"trace[795099322] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4893; }","duration":"220.595302ms","start":"2026-06-30T18:02:34.30233Z","end":"2026-06-30T18:02:34.522926Z","steps":["trace[795099322] 'agreement among raft nodes before linearized reading' (duration: 220.126678ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:02:34.570236Z","caller":"traceutil/trace.go:171","msg":"trace[513859031] transaction","detail":"{read_only:false; response_revision:4894; number_of_response:1; }","duration":"115.157254ms","start":"2026-06-30T18:02:34.455046Z","end":"2026-06-30T18:02:34.570203Z","steps":["trace[513859031] 'process raft request' (duration: 98.59019ms)","trace[513859031] 'compare' (duration: 16.398979ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T18:02:34.570667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.874942ms","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-30T18:02:34.57073Z","caller":"traceutil/trace.go:171","msg":"trace[1615578622] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4894; }","duration":"246.980435ms","start":"2026-06-30T18:02:34.323735Z","end":"2026-06-30T18:02:34.570716Z","steps":["trace[1615578622] 'agreement among raft nodes before linearized reading' (duration: 246.531442ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:03:50.377378Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2854} {"level":"info","ts":"2026-06-30T18:03:50.467339Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2854,"took":"88.092976ms","hash":3104401259,"current-db-size-bytes":53563392,"current-db-size":"54 MB","current-db-size-in-use-bytes":28823552,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-30T18:03:50.467442Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3104401259,"revision":2854,"compact-revision":-1} {"level":"info","ts":"2026-06-30T18:08:50.382911Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5525} {"level":"info","ts":"2026-06-30T18:08:50.45309Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5525,"took":"67.37603ms","hash":317077735,"current-db-size-bytes":53563392,"current-db-size":"54 MB","current-db-size-in-use-bytes":18243584,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-30T18:08:50.453164Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":317077735,"revision":5525,"compact-revision":2854}