{"level":"warn","ts":"2026-08-22T10:32:45.390013Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-22T10:32:45.390218Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.147:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.147:2380","--initial-cluster=instance=https://199.19.213.147:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.147:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.147:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-08-22T10:32:45.390386Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-22T10:32:45.390431Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.147:2380"]} {"level":"info","ts":"2026-08-22T10:32:45.390467Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-22T10:32:45.391109Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.147:2379"]} {"level":"info","ts":"2026-08-22T10:32:45.391213Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.147:2380"],"listen-peer-urls":["https://199.19.213.147:2380"],"advertise-client-urls":["https://199.19.213.147:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.147:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.147:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-08-22T10:32:45.395408Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.956074ms"} {"level":"info","ts":"2026-08-22T10:32:45.400559Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6244e483e416226f","cluster-id":"68a374eab3e2de92"} {"level":"info","ts":"2026-08-22T10:32:45.40075Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f switched to configuration voters=()"} {"level":"info","ts":"2026-08-22T10:32:45.400846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became follower at term 0"} {"level":"info","ts":"2026-08-22T10:32:45.400964Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6244e483e416226f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-22T10:32:45.401048Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became follower at term 1"} {"level":"info","ts":"2026-08-22T10:32:45.401175Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f switched to configuration voters=(7081035769251766895)"} {"level":"warn","ts":"2026-08-22T10:32:45.409129Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-22T10:32:45.410853Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-22T10:32:45.412038Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-08-22T10:32:45.415233Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6244e483e416226f","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-22T10:32:45.415838Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6244e483e416226f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-22T10:32:45.415935Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-22T10:32:45.415966Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-22T10:32:45.415976Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-22T10:32:45.416505Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f switched to configuration voters=(7081035769251766895)"} {"level":"info","ts":"2026-08-22T10:32:45.418087Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"68a374eab3e2de92","local-member-id":"6244e483e416226f","added-peer-id":"6244e483e416226f","added-peer-peer-urls":["https://199.19.213.147:2380"]} {"level":"info","ts":"2026-08-22T10:32:45.42173Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-22T10:32:45.421948Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.147:2380"} {"level":"info","ts":"2026-08-22T10:32:45.422003Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.147:2380"} {"level":"info","ts":"2026-08-22T10:32:45.422231Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6244e483e416226f","initial-advertise-peer-urls":["https://199.19.213.147:2380"],"listen-peer-urls":["https://199.19.213.147:2380"],"advertise-client-urls":["https://199.19.213.147:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.147:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-22T10:32:45.422342Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-22T10:32:46.203406Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f is starting a new election at term 1"} {"level":"info","ts":"2026-08-22T10:32:46.203456Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became pre-candidate at term 1"} {"level":"info","ts":"2026-08-22T10:32:46.203475Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f received MsgPreVoteResp from 6244e483e416226f at term 1"} {"level":"info","ts":"2026-08-22T10:32:46.203489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became candidate at term 2"} {"level":"info","ts":"2026-08-22T10:32:46.203497Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f received MsgVoteResp from 6244e483e416226f at term 2"} {"level":"info","ts":"2026-08-22T10:32:46.203508Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became leader at term 2"} {"level":"info","ts":"2026-08-22T10:32:46.203518Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6244e483e416226f elected leader 6244e483e416226f at term 2"} {"level":"info","ts":"2026-08-22T10:32:46.204287Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T10:32:46.204994Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6244e483e416226f","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.147:2379]}","request-path":"/0/members/6244e483e416226f/attributes","cluster-id":"68a374eab3e2de92","publish-timeout":"7s"} {"level":"info","ts":"2026-08-22T10:32:46.204999Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-22T10:32:46.205156Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-22T10:32:46.205346Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-22T10:32:46.205417Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-22T10:32:46.205868Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"68a374eab3e2de92","local-member-id":"6244e483e416226f","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T10:32:46.206183Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T10:32:46.206225Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T10:32:46.208115Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-22T10:32:46.20999Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.147:2379"} {"level":"warn","ts":"2026-08-22T10:32:47.80483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.946944ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-08-22T10:32:47.804955Z","caller":"traceutil/trace.go:171","msg":"trace[2071842593] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"282.026016ms","start":"2026-08-22T10:32:47.522915Z","end":"2026-08-22T10:32:47.804941Z","steps":["trace[2071842593] 'read index received' (duration: 26.957944ms)","trace[2071842593] 'applied index is now lower than readState.Index' (duration: 255.067032ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:32:47.805069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.14942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-22T10:32:47.80504Z","caller":"traceutil/trace.go:171","msg":"trace[642230224] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"283.191477ms","start":"2026-08-22T10:32:47.521807Z","end":"2026-08-22T10:32:47.804998Z","steps":["trace[642230224] 'process raft request' (duration: 163.550178ms)","trace[642230224] 'compare' (duration: 118.81629ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:32:47.805107Z","caller":"traceutil/trace.go:171","msg":"trace[566356695] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:0; response_revision:3; }","duration":"282.201403ms","start":"2026-08-22T10:32:47.522898Z","end":"2026-08-22T10:32:47.8051Z","steps":["trace[566356695] 'agreement among raft nodes before linearized reading' (duration: 282.11682ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:47.871025Z","caller":"traceutil/trace.go:171","msg":"trace[1158408408] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"276.621293ms","start":"2026-08-22T10:32:47.59438Z","end":"2026-08-22T10:32:47.871001Z","steps":["trace[1158408408] 'process raft request' (duration: 276.450627ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:47.871263Z","caller":"traceutil/trace.go:171","msg":"trace[1963389843] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"279.515047ms","start":"2026-08-22T10:32:47.59174Z","end":"2026-08-22T10:32:47.871255Z","steps":["trace[1963389843] 'process raft request' (duration: 278.968488ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:47.871137Z","caller":"traceutil/trace.go:171","msg":"trace[809684627] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"276.443977ms","start":"2026-08-22T10:32:47.594668Z","end":"2026-08-22T10:32:47.871112Z","steps":["trace[809684627] 'process raft request' (duration: 276.200408ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:32:47.871628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.621213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-22T10:32:47.871658Z","caller":"traceutil/trace.go:171","msg":"trace[849382469] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"276.711706ms","start":"2026-08-22T10:32:47.594936Z","end":"2026-08-22T10:32:47.871648Z","steps":["trace[849382469] 'agreement among raft nodes before linearized reading' (duration: 276.594502ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:32:47.871691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.61925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-22T10:32:47.87173Z","caller":"traceutil/trace.go:171","msg":"trace[1945531730] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"279.725924ms","start":"2026-08-22T10:32:47.591993Z","end":"2026-08-22T10:32:47.871719Z","steps":["trace[1945531730] 'agreement among raft nodes before linearized reading' (duration: 279.646962ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:47.871766Z","caller":"traceutil/trace.go:171","msg":"trace[369734604] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"276.753518ms","start":"2026-08-22T10:32:47.595004Z","end":"2026-08-22T10:32:47.871757Z","steps":["trace[369734604] 'process raft request' (duration: 275.901448ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:47.871854Z","caller":"traceutil/trace.go:171","msg":"trace[1759745068] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"276.662665ms","start":"2026-08-22T10:32:47.595185Z","end":"2026-08-22T10:32:47.871848Z","steps":["trace[1759745068] 'process raft request' (duration: 275.749673ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:32:47.871886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.045851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.147\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-22T10:32:47.871914Z","caller":"traceutil/trace.go:171","msg":"trace[1512766878] range","detail":"{range_begin:/registry/masterleases/199.19.213.147; range_end:; response_count:0; response_revision:11; }","duration":"281.097182ms","start":"2026-08-22T10:32:47.590808Z","end":"2026-08-22T10:32:47.871905Z","steps":["trace[1512766878] 'agreement among raft nodes before linearized reading' (duration: 281.05335ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:47.871929Z","caller":"traceutil/trace.go:171","msg":"trace[2132613133] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"276.25674ms","start":"2026-08-22T10:32:47.595664Z","end":"2026-08-22T10:32:47.871921Z","steps":["trace[2132613133] 'process raft request' (duration: 275.297397ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:32:47.872059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.015653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-22T10:32:47.872079Z","caller":"traceutil/trace.go:171","msg":"trace[1017762102] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"257.602303ms","start":"2026-08-22T10:32:47.614469Z","end":"2026-08-22T10:32:47.872071Z","steps":["trace[1017762102] 'process raft request' (duration: 256.522315ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:47.872086Z","caller":"traceutil/trace.go:171","msg":"trace[627970789] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"292.058344ms","start":"2026-08-22T10:32:47.580019Z","end":"2026-08-22T10:32:47.872078Z","steps":["trace[627970789] 'agreement among raft nodes before linearized reading' (duration: 292.018293ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:47.872214Z","caller":"traceutil/trace.go:171","msg":"trace[991263877] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"257.567792ms","start":"2026-08-22T10:32:47.614638Z","end":"2026-08-22T10:32:47.872206Z","steps":["trace[991263877] 'process raft request' (duration: 256.38749ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:32:47.872232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.22827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-22T10:32:47.87226Z","caller":"traceutil/trace.go:171","msg":"trace[125917392] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"292.281812ms","start":"2026-08-22T10:32:47.57997Z","end":"2026-08-22T10:32:47.872251Z","steps":["trace[125917392] 'agreement among raft nodes before linearized reading' (duration: 292.22758ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:32:47.872313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.178743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-22T10:32:47.872333Z","caller":"traceutil/trace.go:171","msg":"trace[123902702] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"225.225274ms","start":"2026-08-22T10:32:47.647102Z","end":"2026-08-22T10:32:47.872327Z","steps":["trace[123902702] 'agreement among raft nodes before linearized reading' (duration: 225.189893ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:32:47.872776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.292288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-22T10:32:47.872804Z","caller":"traceutil/trace.go:171","msg":"trace[975568878] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"298.359179ms","start":"2026-08-22T10:32:47.574432Z","end":"2026-08-22T10:32:47.872791Z","steps":["trace[975568878] 'agreement among raft nodes before linearized reading' (duration: 298.322928ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:48.069483Z","caller":"traceutil/trace.go:171","msg":"trace[107629870] linearizableReadLoop","detail":"{readStateIndex:15; appliedIndex:14; }","duration":"193.667373ms","start":"2026-08-22T10:32:47.875713Z","end":"2026-08-22T10:32:48.069381Z","steps":["trace[107629870] 'read index received' (duration: 188.127987ms)","trace[107629870] 'applied index is now lower than readState.Index' (duration: 5.536005ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:32:48.069713Z","caller":"traceutil/trace.go:171","msg":"trace[908120671] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"192.534842ms","start":"2026-08-22T10:32:47.877127Z","end":"2026-08-22T10:32:48.069662Z","steps":["trace[908120671] 'process raft request' (duration: 192.288103ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:32:48.069774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.038536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-22T10:32:48.06984Z","caller":"traceutil/trace.go:171","msg":"trace[1826278606] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18; }","duration":"194.148621ms","start":"2026-08-22T10:32:47.875675Z","end":"2026-08-22T10:32:48.069823Z","steps":["trace[1826278606] 'agreement among raft nodes before linearized reading' (duration: 193.961124ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:48.069814Z","caller":"traceutil/trace.go:171","msg":"trace[448866227] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"192.662766ms","start":"2026-08-22T10:32:47.877122Z","end":"2026-08-22T10:32:48.069785Z","steps":["trace[448866227] 'process raft request' (duration: 192.389357ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:48.069948Z","caller":"traceutil/trace.go:171","msg":"trace[99604867] transaction","detail":"{read_only:false; number_of_response:0; response_revision:13; }","duration":"192.921506ms","start":"2026-08-22T10:32:47.877021Z","end":"2026-08-22T10:32:48.069943Z","steps":["trace[99604867] 'process raft request' (duration: 192.352315ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:48.069646Z","caller":"traceutil/trace.go:171","msg":"trace[691937041] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"194.4146ms","start":"2026-08-22T10:32:47.875211Z","end":"2026-08-22T10:32:48.069625Z","steps":["trace[691937041] 'process raft request' (duration: 188.550531ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:48.070148Z","caller":"traceutil/trace.go:171","msg":"trace[1183636258] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"192.926076ms","start":"2026-08-22T10:32:47.877209Z","end":"2026-08-22T10:32:48.070135Z","steps":["trace[1183636258] 'process raft request' (duration: 192.348965ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:32:48.070229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.127039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-dnbnr\" ","response":"range_response_count:1 size:857"} {"level":"info","ts":"2026-08-22T10:32:48.07028Z","caller":"traceutil/trace.go:171","msg":"trace[1882570241] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-dnbnr; range_end:; response_count:1; response_revision:19; }","duration":"194.197562ms","start":"2026-08-22T10:32:47.87607Z","end":"2026-08-22T10:32:48.070267Z","steps":["trace[1882570241] 'agreement among raft nodes before linearized reading' (duration: 194.058387ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:48.070367Z","caller":"traceutil/trace.go:171","msg":"trace[1945873854] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"191.971983ms","start":"2026-08-22T10:32:47.878386Z","end":"2026-08-22T10:32:48.070357Z","steps":["trace[1945873854] 'process raft request' (duration: 191.237197ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:48.070457Z","caller":"traceutil/trace.go:171","msg":"trace[2050700255] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"193.171665ms","start":"2026-08-22T10:32:47.877279Z","end":"2026-08-22T10:32:48.07045Z","steps":["trace[2050700255] 'process raft request' (duration: 192.313995ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:48.069919Z","caller":"traceutil/trace.go:171","msg":"trace[1586123686] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"194.176322ms","start":"2026-08-22T10:32:47.875733Z","end":"2026-08-22T10:32:48.069909Z","steps":["trace[1586123686] 'process raft request' (duration: 193.59138ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:32:48.070702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.048265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3491"} {"level":"warn","ts":"2026-08-22T10:32:48.070723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.552555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-08-22T10:32:48.070762Z","caller":"traceutil/trace.go:171","msg":"trace[2113889413] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:19; }","duration":"192.128717ms","start":"2026-08-22T10:32:47.878619Z","end":"2026-08-22T10:32:48.070748Z","steps":["trace[2113889413] 'agreement among raft nodes before linearized reading' (duration: 192.030594ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:48.070835Z","caller":"traceutil/trace.go:171","msg":"trace[2084246251] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:19; }","duration":"137.716682ms","start":"2026-08-22T10:32:47.933098Z","end":"2026-08-22T10:32:48.070815Z","steps":["trace[2084246251] 'agreement among raft nodes before linearized reading' (duration: 137.500494ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:48.070885Z","caller":"traceutil/trace.go:171","msg":"trace[460987515] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"190.179677ms","start":"2026-08-22T10:32:47.880688Z","end":"2026-08-22T10:32:48.070867Z","steps":["trace[460987515] 'process raft request' (duration: 188.972045ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:33:22.485713Z","caller":"traceutil/trace.go:171","msg":"trace[1822328421] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"110.996323ms","start":"2026-08-22T10:33:22.374685Z","end":"2026-08-22T10:33:22.485681Z","steps":["trace[1822328421] 'process raft request' (duration: 101.09095ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:33:22.721571Z","caller":"traceutil/trace.go:171","msg":"trace[327356262] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"175.157453ms","start":"2026-08-22T10:33:22.546359Z","end":"2026-08-22T10:33:22.721516Z","steps":["trace[327356262] 'process raft request' (duration: 137.821993ms)","trace[327356262] 'compare' (duration: 37.129284ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:33:22.749328Z","caller":"traceutil/trace.go:171","msg":"trace[1569011328] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"158.333288ms","start":"2026-08-22T10:33:22.590967Z","end":"2026-08-22T10:33:22.7493Z","steps":["trace[1569011328] 'process raft request' (duration: 158.113202ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:33:22.749464Z","caller":"traceutil/trace.go:171","msg":"trace[499206666] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"148.689072ms","start":"2026-08-22T10:33:22.600755Z","end":"2026-08-22T10:33:22.749444Z","steps":["trace[499206666] 'process raft request' (duration: 148.540938ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:33:22.950004Z","caller":"traceutil/trace.go:171","msg":"trace[1035403194] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"171.667542ms","start":"2026-08-22T10:33:22.778319Z","end":"2026-08-22T10:33:22.949986Z","steps":["trace[1035403194] 'process raft request' (duration: 171.5943ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:33:22.950075Z","caller":"traceutil/trace.go:171","msg":"trace[1853846186] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"178.629216ms","start":"2026-08-22T10:33:22.771384Z","end":"2026-08-22T10:33:22.950014Z","steps":["trace[1853846186] 'process raft request' (duration: 152.444451ms)","trace[1853846186] 'compare' (duration: 25.917708ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:33:22.950538Z","caller":"traceutil/trace.go:171","msg":"trace[588852263] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"134.426584ms","start":"2026-08-22T10:33:22.81609Z","end":"2026-08-22T10:33:22.950517Z","steps":["trace[588852263] 'process raft request' (duration: 134.248049ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:33:24.730624Z","caller":"traceutil/trace.go:171","msg":"trace[747660901] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"365.900596ms","start":"2026-08-22T10:33:24.364696Z","end":"2026-08-22T10:33:24.730596Z","steps":["trace[747660901] 'process raft request' (duration: 365.786513ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:33:24.730657Z","caller":"traceutil/trace.go:171","msg":"trace[1335600909] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:623; }","duration":"310.996472ms","start":"2026-08-22T10:33:24.419638Z","end":"2026-08-22T10:33:24.730635Z","steps":["trace[1335600909] 'read index received' (duration: 310.926271ms)","trace[1335600909] 'applied index is now lower than readState.Index' (duration: 68.931µs)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:33:24.730788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:33:24.36468Z","time spent":"366.013539ms","remote":"127.0.0.1:49918","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-08-22T10:33:24.730888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.236338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-22T10:33:24.730921Z","caller":"traceutil/trace.go:171","msg":"trace[555443727] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:603; }","duration":"311.319861ms","start":"2026-08-22T10:33:24.41959Z","end":"2026-08-22T10:33:24.73091Z","steps":["trace[555443727] 'agreement among raft nodes before linearized reading' (duration: 311.156196ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:33:24.730949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:33:24.41957Z","time spent":"311.372092ms","remote":"127.0.0.1:49918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-22T10:33:24.746709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.751298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-22T10:33:24.746787Z","caller":"traceutil/trace.go:171","msg":"trace[1427855144] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:604; }","duration":"325.83514ms","start":"2026-08-22T10:33:24.420934Z","end":"2026-08-22T10:33:24.746769Z","steps":["trace[1427855144] 'agreement among raft nodes before linearized reading' (duration: 325.640635ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:33:24.749258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:33:24.420852Z","time spent":"328.390347ms","remote":"127.0.0.1:49918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-22T10:33:24.747153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.078804ms","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":"warn","ts":"2026-08-22T10:33:24.747037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.958141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:33:24.749395Z","caller":"traceutil/trace.go:171","msg":"trace[1040269042] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:604; }","duration":"195.340982ms","start":"2026-08-22T10:33:24.554034Z","end":"2026-08-22T10:33:24.749375Z","steps":["trace[1040269042] 'agreement among raft nodes before linearized reading' (duration: 193.089443ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:33:24.747107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.427287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:33:24.750623Z","caller":"traceutil/trace.go:171","msg":"trace[1122442518] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:604; }","duration":"195.954018ms","start":"2026-08-22T10:33:24.554652Z","end":"2026-08-22T10:33:24.750606Z","steps":["trace[1122442518] 'agreement among raft nodes before linearized reading' (duration: 192.435327ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:33:24.747366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.174988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:33:24.750869Z","caller":"traceutil/trace.go:171","msg":"trace[1464985408] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:604; }","duration":"226.66761ms","start":"2026-08-22T10:33:24.524173Z","end":"2026-08-22T10:33:24.750841Z","steps":["trace[1464985408] 'agreement among raft nodes before linearized reading' (duration: 223.173058ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:33:24.747447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.733839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-22T10:33:24.750988Z","caller":"traceutil/trace.go:171","msg":"trace[1854688209] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:604; }","duration":"223.288192ms","start":"2026-08-22T10:33:24.52769Z","end":"2026-08-22T10:33:24.750978Z","steps":["trace[1854688209] 'agreement among raft nodes before linearized reading' (duration: 219.692467ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:33:24.747572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.570589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:33:24.751138Z","caller":"traceutil/trace.go:171","msg":"trace[531768602] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:604; }","duration":"227.165754ms","start":"2026-08-22T10:33:24.523965Z","end":"2026-08-22T10:33:24.75113Z","steps":["trace[531768602] 'agreement among raft nodes before linearized reading' (duration: 223.575189ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:33:24.751764Z","caller":"traceutil/trace.go:171","msg":"trace[10793311] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:604; }","duration":"196.191825ms","start":"2026-08-22T10:33:24.554015Z","end":"2026-08-22T10:33:24.750207Z","steps":["trace[10793311] 'agreement among raft nodes before linearized reading' (duration: 192.968341ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:33:30.195448Z","caller":"traceutil/trace.go:171","msg":"trace[889715978] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"435.885869ms","start":"2026-08-22T10:33:29.759545Z","end":"2026-08-22T10:33:30.195431Z","steps":["trace[889715978] 'process raft request' (duration: 428.950926ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:33:30.195528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.170673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-htztv\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-08-22T10:33:30.195551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:33:29.759518Z","time spent":"435.977511ms","remote":"127.0.0.1:49748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T10:33:30.195561Z","caller":"traceutil/trace.go:171","msg":"trace[1840623909] range","detail":"{range_begin:/registry/pods/kube-system/cilium-htztv; range_end:; response_count:1; response_revision:636; }","duration":"179.242865ms","start":"2026-08-22T10:33:30.016308Z","end":"2026-08-22T10:33:30.195551Z","steps":["trace[1840623909] 'agreement among raft nodes before linearized reading' (duration: 179.168023ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:33:30.195433Z","caller":"traceutil/trace.go:171","msg":"trace[1238985097] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:658; }","duration":"179.026589ms","start":"2026-08-22T10:33:30.016348Z","end":"2026-08-22T10:33:30.195374Z","steps":["trace[1238985097] 'read index received' (duration: 171.894711ms)","trace[1238985097] 'applied index is now lower than readState.Index' (duration: 7.131098ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:33:53.783172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.782242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-22T10:33:53.783424Z","caller":"traceutil/trace.go:171","msg":"trace[1262202176] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:817; }","duration":"223.088379ms","start":"2026-08-22T10:33:53.560322Z","end":"2026-08-22T10:33:53.783411Z","steps":["trace[1262202176] 'range keys from in-memory index tree' (duration: 222.618448ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:34:45.549372Z","caller":"traceutil/trace.go:171","msg":"trace[1131241422] transaction","detail":"{read_only:false; response_revision:1482; number_of_response:1; }","duration":"164.289538ms","start":"2026-08-22T10:34:45.385058Z","end":"2026-08-22T10:34:45.549347Z","steps":["trace[1131241422] 'process raft request' (duration: 164.110405ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:35:12.767811Z","caller":"traceutil/trace.go:171","msg":"trace[506727336] transaction","detail":"{read_only:false; response_revision:1902; number_of_response:1; }","duration":"251.504762ms","start":"2026-08-22T10:35:12.516276Z","end":"2026-08-22T10:35:12.76778Z","steps":["trace[506727336] 'process raft request' (duration: 251.37595ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:35:12.774608Z","caller":"traceutil/trace.go:171","msg":"trace[633775910] transaction","detail":"{read_only:false; response_revision:1903; number_of_response:1; }","duration":"167.233451ms","start":"2026-08-22T10:35:12.607354Z","end":"2026-08-22T10:35:12.774587Z","steps":["trace[633775910] 'process raft request' (duration: 167.093109ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:35:13.160037Z","caller":"traceutil/trace.go:171","msg":"trace[417738603] transaction","detail":"{read_only:false; response_revision:1904; number_of_response:1; }","duration":"182.38912ms","start":"2026-08-22T10:35:12.977623Z","end":"2026-08-22T10:35:13.160012Z","steps":["trace[417738603] 'process raft request' (duration: 182.206007ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:35:13.216128Z","caller":"traceutil/trace.go:171","msg":"trace[1024547125] transaction","detail":"{read_only:false; response_revision:1905; number_of_response:1; }","duration":"181.545616ms","start":"2026-08-22T10:35:13.034558Z","end":"2026-08-22T10:35:13.216103Z","steps":["trace[1024547125] 'process raft request' (duration: 177.887787ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:35:47.117953Z","caller":"traceutil/trace.go:171","msg":"trace[1774277042] transaction","detail":"{read_only:false; response_revision:2138; number_of_response:1; }","duration":"133.212926ms","start":"2026-08-22T10:35:46.9847Z","end":"2026-08-22T10:35:47.117913Z","steps":["trace[1774277042] 'process raft request' (duration: 132.972902ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:35:47.681075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.684046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-08-22T10:35:47.681251Z","caller":"traceutil/trace.go:171","msg":"trace[1902115215] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:2140; }","duration":"128.89965ms","start":"2026-08-22T10:35:47.552329Z","end":"2026-08-22T10:35:47.681229Z","steps":["trace[1902115215] 'range keys from in-memory index tree' (duration: 128.585535ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:35:47.681277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.783861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-22T10:35:47.681544Z","caller":"traceutil/trace.go:171","msg":"trace[468572834] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2140; }","duration":"164.081344ms","start":"2026-08-22T10:35:47.517437Z","end":"2026-08-22T10:35:47.681518Z","steps":["trace[468572834] 'range keys from in-memory index tree' (duration: 163.608918ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:35:47.681173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.113429ms","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-08-22T10:35:47.681837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.3323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-22T10:35:47.682459Z","caller":"traceutil/trace.go:171","msg":"trace[88045489] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2140; }","duration":"150.986506ms","start":"2026-08-22T10:35:47.531447Z","end":"2026-08-22T10:35:47.682434Z","steps":["trace[88045489] 'range keys from in-memory index tree' (duration: 149.110388ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:35:47.682521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.056933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-22T10:35:47.682639Z","caller":"traceutil/trace.go:171","msg":"trace[1426088991] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2140; }","duration":"152.201626ms","start":"2026-08-22T10:35:47.530411Z","end":"2026-08-22T10:35:47.682613Z","steps":["trace[1426088991] 'range keys from in-memory index tree' (duration: 150.607261ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:35:47.682413Z","caller":"traceutil/trace.go:171","msg":"trace[211072226] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2140; }","duration":"158.390489ms","start":"2026-08-22T10:35:47.524005Z","end":"2026-08-22T10:35:47.682395Z","steps":["trace[211072226] 'range keys from in-memory index tree' (duration: 156.958276ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:35:47.795934Z","caller":"traceutil/trace.go:171","msg":"trace[1593597344] transaction","detail":"{read_only:false; response_revision:2141; number_of_response:1; }","duration":"109.280682ms","start":"2026-08-22T10:35:47.686624Z","end":"2026-08-22T10:35:47.795905Z","steps":["trace[1593597344] 'process raft request' (duration: 109.09999ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:35:47.994691Z","caller":"traceutil/trace.go:171","msg":"trace[553016594] transaction","detail":"{read_only:false; response_revision:2142; number_of_response:1; }","duration":"307.72136ms","start":"2026-08-22T10:35:47.686941Z","end":"2026-08-22T10:35:47.994662Z","steps":["trace[553016594] 'process raft request' (duration: 298.330817ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:35:47.99485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:35:47.686919Z","time spent":"307.846991ms","remote":"127.0.0.1:49918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T10:35:47.99521Z","caller":"traceutil/trace.go:171","msg":"trace[408235408] transaction","detail":"{read_only:false; response_revision:2143; number_of_response:1; }","duration":"308.023264ms","start":"2026-08-22T10:35:47.687148Z","end":"2026-08-22T10:35:47.995171Z","steps":["trace[408235408] 'process raft request' (duration: 307.390625ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:35:47.995471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:35:47.687142Z","time spent":"308.154536ms","remote":"127.0.0.1:49918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T10:35:47.995512Z","caller":"traceutil/trace.go:171","msg":"trace[899904169] transaction","detail":"{read_only:false; response_revision:2144; number_of_response:1; }","duration":"307.246722ms","start":"2026-08-22T10:35:47.688247Z","end":"2026-08-22T10:35:47.995494Z","steps":["trace[899904169] 'process raft request' (duration: 306.836326ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:35:47.995635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:35:47.688232Z","time spent":"307.327053ms","remote":"127.0.0.1:49918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T10:35:47.995784Z","caller":"traceutil/trace.go:171","msg":"trace[266236599] transaction","detail":"{read_only:false; response_revision:2145; number_of_response:1; }","duration":"306.474552ms","start":"2026-08-22T10:35:47.689258Z","end":"2026-08-22T10:35:47.995732Z","steps":["trace[266236599] 'process raft request' (duration: 306.114565ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:35:47.995856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:35:47.689249Z","time spent":"306.573663ms","remote":"127.0.0.1:49918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T10:35:47.996995Z","caller":"traceutil/trace.go:171","msg":"trace[534671947] linearizableReadLoop","detail":"{readStateIndex:2224; appliedIndex:2221; }","duration":"308.887967ms","start":"2026-08-22T10:35:47.688071Z","end":"2026-08-22T10:35:47.996959Z","steps":["trace[534671947] 'read index received' (duration: 107.653287ms)","trace[534671947] 'applied index is now lower than readState.Index' (duration: 201.23349ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:35:47.997195Z","caller":"traceutil/trace.go:171","msg":"trace[992263595] transaction","detail":"{read_only:false; response_revision:2146; number_of_response:1; }","duration":"256.267686ms","start":"2026-08-22T10:35:47.740916Z","end":"2026-08-22T10:35:47.997184Z","steps":["trace[992263595] 'process raft request' (duration: 254.57294ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:35:47.997397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.653164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:127539"} {"level":"info","ts":"2026-08-22T10:35:47.997445Z","caller":"traceutil/trace.go:171","msg":"trace[1611495973] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:2146; }","duration":"189.733406ms","start":"2026-08-22T10:35:47.8077Z","end":"2026-08-22T10:35:47.997433Z","steps":["trace[1611495973] 'agreement among raft nodes before linearized reading' (duration: 189.533123ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:35:47.997525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.441645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-08-22T10:35:47.997915Z","caller":"traceutil/trace.go:171","msg":"trace[336866093] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:2146; }","duration":"309.571617ms","start":"2026-08-22T10:35:47.688043Z","end":"2026-08-22T10:35:47.997615Z","steps":["trace[336866093] 'agreement among raft nodes before linearized reading' (duration: 309.376095ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:35:47.998023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:35:47.68803Z","time spent":"309.930533ms","remote":"127.0.0.1:49712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":1,"response size":140,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"warn","ts":"2026-08-22T10:36:42.312752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.215712ms","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-08-22T10:36:42.312863Z","caller":"traceutil/trace.go:171","msg":"trace[648234985] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2539; }","duration":"180.370297ms","start":"2026-08-22T10:36:42.13247Z","end":"2026-08-22T10:36:42.31284Z","steps":["trace[648234985] 'range keys from in-memory index tree' (duration: 180.016165ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:36:42.313822Z","caller":"traceutil/trace.go:171","msg":"trace[1929001648] transaction","detail":"{read_only:false; response_revision:2540; number_of_response:1; }","duration":"134.655661ms","start":"2026-08-22T10:36:42.179141Z","end":"2026-08-22T10:36:42.313796Z","steps":["trace[1929001648] 'process raft request' (duration: 132.83141ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:37:15.204178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.877253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:37:15.204262Z","caller":"traceutil/trace.go:171","msg":"trace[1162608309] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2723; }","duration":"148.989937ms","start":"2026-08-22T10:37:15.055256Z","end":"2026-08-22T10:37:15.204246Z","steps":["trace[1162608309] 'range keys from in-memory index tree' (duration: 148.79919ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:37:15.204178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.631545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:37:15.2045Z","caller":"traceutil/trace.go:171","msg":"trace[2038917883] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:2723; }","duration":"160.064538ms","start":"2026-08-22T10:37:15.044421Z","end":"2026-08-22T10:37:15.204486Z","steps":["trace[2038917883] 'count revisions from in-memory index tree' (duration: 159.530913ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:40:55.742967Z","caller":"traceutil/trace.go:171","msg":"trace[1905263512] linearizableReadLoop","detail":"{readStateIndex:4759; appliedIndex:4758; }","duration":"145.555163ms","start":"2026-08-22T10:40:55.597383Z","end":"2026-08-22T10:40:55.742938Z","steps":["trace[1905263512] 'read index received' (duration: 140.125811ms)","trace[1905263512] 'applied index is now lower than readState.Index' (duration: 5.428212ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:40:55.743038Z","caller":"traceutil/trace.go:171","msg":"trace[1569005614] transaction","detail":"{read_only:false; response_revision:4584; number_of_response:1; }","duration":"164.579108ms","start":"2026-08-22T10:40:55.578425Z","end":"2026-08-22T10:40:55.743004Z","steps":["trace[1569005614] 'process raft request' (duration: 159.076775ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:40:55.743256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.848518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-22T10:40:55.743319Z","caller":"traceutil/trace.go:171","msg":"trace[333018871] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4584; }","duration":"145.960051ms","start":"2026-08-22T10:40:55.597346Z","end":"2026-08-22T10:40:55.743306Z","steps":["trace[333018871] 'agreement among raft nodes before linearized reading' (duration: 145.766947ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:40:55.743321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.92138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-22T10:40:55.743357Z","caller":"traceutil/trace.go:171","msg":"trace[1558102096] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4584; }","duration":"145.991033ms","start":"2026-08-22T10:40:55.597355Z","end":"2026-08-22T10:40:55.743346Z","steps":["trace[1558102096] 'agreement among raft nodes before linearized reading' (duration: 145.841049ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:41:01.755283Z","caller":"traceutil/trace.go:171","msg":"trace[869872472] linearizableReadLoop","detail":"{readStateIndex:4861; appliedIndex:4860; }","duration":"123.737652ms","start":"2026-08-22T10:41:01.631519Z","end":"2026-08-22T10:41:01.755257Z","steps":["trace[869872472] 'read index received' (duration: 123.451606ms)","trace[869872472] 'applied index is now lower than readState.Index' (duration: 284.956µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:41:01.755393Z","caller":"traceutil/trace.go:171","msg":"trace[1856983065] transaction","detail":"{read_only:false; response_revision:4684; number_of_response:1; }","duration":"141.552593ms","start":"2026-08-22T10:41:01.613817Z","end":"2026-08-22T10:41:01.755369Z","steps":["trace[1856983065] 'process raft request' (duration: 141.259138ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:41:01.755547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.006247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-08-22T10:41:01.755657Z","caller":"traceutil/trace.go:171","msg":"trace[1541139766] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4684; }","duration":"124.123409ms","start":"2026-08-22T10:41:01.631513Z","end":"2026-08-22T10:41:01.755637Z","steps":["trace[1541139766] 'agreement among raft nodes before linearized reading' (duration: 123.862424ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:41:02.375757Z","caller":"traceutil/trace.go:171","msg":"trace[851106801] transaction","detail":"{read_only:false; response_revision:4693; number_of_response:1; }","duration":"100.155431ms","start":"2026-08-22T10:41:02.275572Z","end":"2026-08-22T10:41:02.375728Z","steps":["trace[851106801] 'process raft request' (duration: 34.579823ms)","trace[851106801] 'compare' (duration: 65.455176ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:42:30.268973Z","caller":"traceutil/trace.go:171","msg":"trace[140776899] transaction","detail":"{read_only:false; response_revision:5477; number_of_response:1; }","duration":"112.529371ms","start":"2026-08-22T10:42:30.156394Z","end":"2026-08-22T10:42:30.268923Z","steps":["trace[140776899] 'process raft request' (duration: 112.332197ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:42:46.234173Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2886} {"level":"info","ts":"2026-08-22T10:42:46.347959Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2886,"took":"112.17176ms","hash":2878122436,"current-db-size-bytes":54624256,"current-db-size":"55 MB","current-db-size-in-use-bytes":29630464,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-22T10:42:46.348025Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2878122436,"revision":2886,"compact-revision":-1} {"level":"info","ts":"2026-08-22T10:47:46.240556Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5609} {"level":"info","ts":"2026-08-22T10:47:46.314541Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5609,"took":"72.776817ms","hash":420896415,"current-db-size-bytes":54624256,"current-db-size":"55 MB","current-db-size-in-use-bytes":18247680,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-08-22T10:47:46.314595Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":420896415,"revision":5609,"compact-revision":2886}