{"level":"warn","ts":"2026-07-01T10:36:03.099806Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-01T10:36:03.099936Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.240: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.240:2380","--initial-cluster=instance=https://199.204.45.240:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.240:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.240: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-07-01T10:36:03.100034Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-01T10:36:03.100051Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.240:2380"]} {"level":"info","ts":"2026-07-01T10:36:03.100075Z","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-07-01T10:36:03.100959Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"]} {"level":"info","ts":"2026-07-01T10:36:03.10106Z","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.240:2380"],"listen-peer-urls":["https://199.204.45.240:2380"],"advertise-client-urls":["https://199.204.45.240:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.240: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-07-01T10:36:03.106794Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.471325ms"} {"level":"info","ts":"2026-07-01T10:36:03.112313Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4e46287fb5aa4785","cluster-id":"cae704afa9813e87"} {"level":"info","ts":"2026-07-01T10:36:03.112438Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=()"} {"level":"info","ts":"2026-07-01T10:36:03.112474Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became follower at term 0"} {"level":"info","ts":"2026-07-01T10:36:03.112488Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4e46287fb5aa4785 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-01T10:36:03.112499Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became follower at term 1"} {"level":"info","ts":"2026-07-01T10:36:03.11256Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=(5640240112301918085)"} {"level":"warn","ts":"2026-07-01T10:36:03.120632Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-01T10:36:03.122276Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-01T10:36:03.126403Z","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-07-01T10:36:03.131715Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4e46287fb5aa4785","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-01T10:36:03.131965Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4e46287fb5aa4785","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-01T10:36:03.132139Z","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-07-01T10:36:03.132318Z","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-07-01T10:36:03.132337Z","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-07-01T10:36:03.133262Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=(5640240112301918085)"} {"level":"info","ts":"2026-07-01T10:36:03.133944Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cae704afa9813e87","local-member-id":"4e46287fb5aa4785","added-peer-id":"4e46287fb5aa4785","added-peer-peer-urls":["https://199.204.45.240:2380"]} {"level":"info","ts":"2026-07-01T10:36:03.135935Z","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-07-01T10:36:03.136071Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.240:2380"} {"level":"info","ts":"2026-07-01T10:36:03.137153Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.240:2380"} {"level":"info","ts":"2026-07-01T10:36:03.137146Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4e46287fb5aa4785","initial-advertise-peer-urls":["https://199.204.45.240:2380"],"listen-peer-urls":["https://199.204.45.240:2380"],"advertise-client-urls":["https://199.204.45.240:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-01T10:36:03.137225Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-01T10:36:03.612952Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 is starting a new election at term 1"} {"level":"info","ts":"2026-07-01T10:36:03.61301Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-01T10:36:03.613035Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 received MsgPreVoteResp from 4e46287fb5aa4785 at term 1"} {"level":"info","ts":"2026-07-01T10:36:03.613048Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became candidate at term 2"} {"level":"info","ts":"2026-07-01T10:36:03.613054Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 received MsgVoteResp from 4e46287fb5aa4785 at term 2"} {"level":"info","ts":"2026-07-01T10:36:03.613064Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became leader at term 2"} {"level":"info","ts":"2026-07-01T10:36:03.613076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4e46287fb5aa4785 elected leader 4e46287fb5aa4785 at term 2"} {"level":"info","ts":"2026-07-01T10:36:03.6152Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T10:36:03.617581Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-01T10:36:03.617586Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4e46287fb5aa4785","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.240:2379]}","request-path":"/0/members/4e46287fb5aa4785/attributes","cluster-id":"cae704afa9813e87","publish-timeout":"7s"} {"level":"info","ts":"2026-07-01T10:36:03.618644Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-01T10:36:03.61876Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cae704afa9813e87","local-member-id":"4e46287fb5aa4785","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T10:36:03.618833Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T10:36:03.618848Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T10:36:03.620355Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-01T10:36:03.620372Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-01T10:36:03.620919Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-01T10:36:03.623059Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.240:2379"} {"level":"info","ts":"2026-07-01T10:36:41.827321Z","caller":"traceutil/trace.go:171","msg":"trace[1582165536] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"109.043547ms","start":"2026-07-01T10:36:41.718259Z","end":"2026-07-01T10:36:41.827302Z","steps":["trace[1582165536] 'process raft request' (duration: 108.41435ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:36:41.829543Z","caller":"traceutil/trace.go:171","msg":"trace[993659118] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"100.736472ms","start":"2026-07-01T10:36:41.728789Z","end":"2026-07-01T10:36:41.829525Z","steps":["trace[993659118] 'process raft request' (duration: 97.998994ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:36:42.010322Z","caller":"traceutil/trace.go:171","msg":"trace[1529461167] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"101.070641ms","start":"2026-07-01T10:36:41.90804Z","end":"2026-07-01T10:36:42.009111Z","steps":["trace[1529461167] 'process raft request' (duration: 91.973042ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:36:48.018926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.77158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T10:36:48.019069Z","caller":"traceutil/trace.go:171","msg":"trace[469244046] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"171.225836ms","start":"2026-07-01T10:36:47.847815Z","end":"2026-07-01T10:36:48.019041Z","steps":["trace[469244046] 'process raft request' (duration: 164.809374ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:36:48.019136Z","caller":"traceutil/trace.go:171","msg":"trace[1263731270] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:586; }","duration":"173.044748ms","start":"2026-07-01T10:36:47.846058Z","end":"2026-07-01T10:36:48.019103Z","steps":["trace[1263731270] 'range keys from in-memory index tree' (duration: 172.680567ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:36:48.028602Z","caller":"traceutil/trace.go:171","msg":"trace[1978933990] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:610; }","duration":"140.190204ms","start":"2026-07-01T10:36:47.888382Z","end":"2026-07-01T10:36:48.028572Z","steps":["trace[1978933990] 'read index received' (duration: 124.255621ms)","trace[1978933990] 'applied index is now lower than readState.Index' (duration: 15.933373ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:36:48.028678Z","caller":"traceutil/trace.go:171","msg":"trace[647311435] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"146.834662ms","start":"2026-07-01T10:36:47.881823Z","end":"2026-07-01T10:36:48.028657Z","steps":["trace[647311435] 'process raft request' (duration: 146.620146ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:36:48.029207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.804402ms","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-07-01T10:36:48.029257Z","caller":"traceutil/trace.go:171","msg":"trace[1280473477] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:588; }","duration":"140.904114ms","start":"2026-07-01T10:36:47.88834Z","end":"2026-07-01T10:36:48.029244Z","steps":["trace[1280473477] 'agreement among raft nodes before linearized reading' (duration: 140.340718ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:36:48.41467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.138244ms","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-07-01T10:36:48.41479Z","caller":"traceutil/trace.go:171","msg":"trace[1965801485] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:589; }","duration":"114.32623ms","start":"2026-07-01T10:36:48.300434Z","end":"2026-07-01T10:36:48.41476Z","steps":["trace[1965801485] 'range keys from in-memory index tree' (duration: 113.992379ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:36:48.558061Z","caller":"traceutil/trace.go:171","msg":"trace[637601572] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"139.077202ms","start":"2026-07-01T10:36:48.418961Z","end":"2026-07-01T10:36:48.558038Z","steps":["trace[637601572] 'process raft request' (duration: 138.906647ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:36:48.582258Z","caller":"traceutil/trace.go:171","msg":"trace[2130866462] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"162.794366ms","start":"2026-07-01T10:36:48.419412Z","end":"2026-07-01T10:36:48.582206Z","steps":["trace[2130866462] 'process raft request' (duration: 162.184549ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:38:25.6046Z","caller":"traceutil/trace.go:171","msg":"trace[723820616] linearizableReadLoop","detail":"{readStateIndex:1933; appliedIndex:1932; }","duration":"201.463208ms","start":"2026-07-01T10:38:25.403115Z","end":"2026-07-01T10:38:25.604578Z","steps":["trace[723820616] 'read index received' (duration: 201.391476ms)","trace[723820616] 'applied index is now lower than readState.Index' (duration: 70.832µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:38:25.604645Z","caller":"traceutil/trace.go:171","msg":"trace[1850816635] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"295.507808ms","start":"2026-07-01T10:38:25.309108Z","end":"2026-07-01T10:38:25.604616Z","steps":["trace[1850816635] 'process raft request' (duration: 295.315502ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:38:25.604802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.675354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-78c4f31b-85a1-490e-8a39-7dfdf0346c8c\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-07-01T10:38:25.604792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.564344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T10:38:25.60483Z","caller":"traceutil/trace.go:171","msg":"trace[1622992955] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-78c4f31b-85a1-490e-8a39-7dfdf0346c8c; range_end:; response_count:1; response_revision:1861; }","duration":"201.760146ms","start":"2026-07-01T10:38:25.403062Z","end":"2026-07-01T10:38:25.604822Z","steps":["trace[1622992955] 'agreement among raft nodes before linearized reading' (duration: 201.640343ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:38:25.604851Z","caller":"traceutil/trace.go:171","msg":"trace[2073369664] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1861; }","duration":"104.700408ms","start":"2026-07-01T10:38:25.500136Z","end":"2026-07-01T10:38:25.604837Z","steps":["trace[2073369664] 'agreement among raft nodes before linearized reading' (duration: 104.580934ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:38:25.968049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.257545ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T10:38:25.96827Z","caller":"traceutil/trace.go:171","msg":"trace[674688486] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"356.286086ms","start":"2026-07-01T10:38:25.611948Z","end":"2026-07-01T10:38:25.968234Z","steps":["trace[674688486] 'process raft request' (duration: 170.345161ms)","trace[674688486] 'compare' (duration: 185.114801ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:38:25.968319Z","caller":"traceutil/trace.go:171","msg":"trace[1840404605] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"355.74981ms","start":"2026-07-01T10:38:25.612558Z","end":"2026-07-01T10:38:25.968308Z","steps":["trace[1840404605] 'process raft request' (duration: 355.585865ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:38:25.968385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T10:38:25.612533Z","time spent":"355.812762ms","remote":"127.0.0.1:40414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1530,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T10:38:25.96836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T10:38:25.611906Z","time spent":"356.416151ms","remote":"127.0.0.1:40316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":978,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T10:38:26.003532Z","caller":"traceutil/trace.go:171","msg":"trace[59038379] transaction","detail":"{read_only:false; response_revision:1865; number_of_response:1; }","duration":"388.740613ms","start":"2026-07-01T10:38:25.614726Z","end":"2026-07-01T10:38:26.003466Z","steps":["trace[59038379] 'process raft request' (duration: 388.495626ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:38:26.003568Z","caller":"traceutil/trace.go:171","msg":"trace[184389863] linearizableReadLoop","detail":"{readStateIndex:1939; appliedIndex:1934; }","duration":"282.47357ms","start":"2026-07-01T10:38:25.721069Z","end":"2026-07-01T10:38:26.003543Z","steps":["trace[184389863] 'read index received' (duration: 61.223943ms)","trace[184389863] 'applied index is now lower than readState.Index' (duration: 221.248107ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:38:26.003628Z","caller":"traceutil/trace.go:171","msg":"trace[1467141412] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"353.934307ms","start":"2026-07-01T10:38:25.649673Z","end":"2026-07-01T10:38:26.003608Z","steps":["trace[1467141412] 'process raft request' (duration: 353.762682ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:38:26.003658Z","caller":"traceutil/trace.go:171","msg":"trace[1144750502] transaction","detail":"{read_only:false; response_revision:1866; number_of_response:1; }","duration":"384.716852ms","start":"2026-07-01T10:38:25.618848Z","end":"2026-07-01T10:38:26.003565Z","steps":["trace[1144750502] 'process raft request' (duration: 384.510646ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:38:26.003695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.617693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-01T10:38:26.003715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T10:38:25.61471Z","time spent":"388.904718ms","remote":"127.0.0.1:40414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1472,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T10:38:26.003749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T10:38:25.649643Z","time spent":"354.038659ms","remote":"127.0.0.1:40400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T10:38:26.003823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T10:38:25.618833Z","time spent":"384.900858ms","remote":"127.0.0.1:40326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T10:38:26.003864Z","caller":"traceutil/trace.go:171","msg":"trace[1308550963] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1867; }","duration":"282.834051ms","start":"2026-07-01T10:38:25.72101Z","end":"2026-07-01T10:38:26.003845Z","steps":["trace[1308550963] 'agreement among raft nodes before linearized reading' (duration: 282.622254ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:38:26.065122Z","caller":"traceutil/trace.go:171","msg":"trace[1947988209] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"265.026389ms","start":"2026-07-01T10:38:25.800066Z","end":"2026-07-01T10:38:26.065092Z","steps":["trace[1947988209] 'process raft request' (duration: 264.906886ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:39:00.25894Z","caller":"traceutil/trace.go:171","msg":"trace[770938569] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"133.847682ms","start":"2026-07-01T10:39:00.125065Z","end":"2026-07-01T10:39:00.258912Z","steps":["trace[770938569] 'process raft request' (duration: 133.687387ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:39:00.870612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.288708ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T10:39:00.87088Z","caller":"traceutil/trace.go:171","msg":"trace[1989988769] transaction","detail":"{read_only:false; response_revision:2109; number_of_response:1; }","duration":"355.624738ms","start":"2026-07-01T10:39:00.515236Z","end":"2026-07-01T10:39:00.870861Z","steps":["trace[1989988769] 'process raft request' (duration: 94.99019ms)","trace[1989988769] 'compare' (duration: 260.091092ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T10:39:00.870959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T10:39:00.515215Z","time spent":"355.700612ms","remote":"127.0.0.1:40400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T10:39:00.871182Z","caller":"traceutil/trace.go:171","msg":"trace[2111476044] transaction","detail":"{read_only:false; response_revision:2110; number_of_response:1; }","duration":"146.817465ms","start":"2026-07-01T10:39:00.72434Z","end":"2026-07-01T10:39:00.871157Z","steps":["trace[2111476044] 'process raft request' (duration: 146.384021ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:40:09.294716Z","caller":"traceutil/trace.go:171","msg":"trace[807705275] transaction","detail":"{read_only:false; response_revision:2580; number_of_response:1; }","duration":"100.519287ms","start":"2026-07-01T10:40:09.194171Z","end":"2026-07-01T10:40:09.29469Z","steps":["trace[807705275] 'process raft request' (duration: 100.227269ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:40:09.294779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.127966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-07-01T10:40:09.294871Z","caller":"traceutil/trace.go:171","msg":"trace[823764764] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2580; }","duration":"100.275961ms","start":"2026-07-01T10:40:09.194574Z","end":"2026-07-01T10:40:09.29485Z","steps":["trace[823764764] 'agreement among raft nodes before linearized reading' (duration: 100.021613ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:44:35.284216Z","caller":"traceutil/trace.go:171","msg":"trace[1946861818] linearizableReadLoop","detail":"{readStateIndex:4906; appliedIndex:4904; }","duration":"247.062956ms","start":"2026-07-01T10:44:35.037134Z","end":"2026-07-01T10:44:35.284197Z","steps":["trace[1946861818] 'read index received' (duration: 15.380227ms)","trace[1946861818] 'applied index is now lower than readState.Index' (duration: 231.681999ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:44:35.284299Z","caller":"traceutil/trace.go:171","msg":"trace[793731826] transaction","detail":"{read_only:false; response_revision:4728; number_of_response:1; }","duration":"282.343612ms","start":"2026-07-01T10:44:35.001918Z","end":"2026-07-01T10:44:35.284261Z","steps":["trace[793731826] 'process raft request' (duration: 282.137696ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:44:35.284385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.237781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-7x6qr\" ","response":"range_response_count:1 size:9352"} {"level":"info","ts":"2026-07-01T10:44:35.284342Z","caller":"traceutil/trace.go:171","msg":"trace[339793216] transaction","detail":"{read_only:false; response_revision:4729; number_of_response:1; }","duration":"244.226301ms","start":"2026-07-01T10:44:35.04009Z","end":"2026-07-01T10:44:35.284317Z","steps":["trace[339793216] 'process raft request' (duration: 244.063297ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:44:35.28442Z","caller":"traceutil/trace.go:171","msg":"trace[1754335936] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-7x6qr; range_end:; response_count:1; response_revision:4729; }","duration":"247.324474ms","start":"2026-07-01T10:44:35.037087Z","end":"2026-07-01T10:44:35.284412Z","steps":["trace[1754335936] 'agreement among raft nodes before linearized reading' (duration: 247.18813ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:44:35.658016Z","caller":"traceutil/trace.go:171","msg":"trace[1045324143] transaction","detail":"{read_only:false; response_revision:4740; number_of_response:1; }","duration":"120.78363ms","start":"2026-07-01T10:44:35.537211Z","end":"2026-07-01T10:44:35.657995Z","steps":["trace[1045324143] 'process raft request' (duration: 120.679818ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:44:35.658146Z","caller":"traceutil/trace.go:171","msg":"trace[697945849] transaction","detail":"{read_only:false; response_revision:4738; number_of_response:1; }","duration":"121.193521ms","start":"2026-07-01T10:44:35.53687Z","end":"2026-07-01T10:44:35.658063Z","steps":["trace[697945849] 'process raft request' (duration: 103.095482ms)","trace[697945849] 'compare' (duration: 17.791251ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:44:35.658009Z","caller":"traceutil/trace.go:171","msg":"trace[1620549192] transaction","detail":"{read_only:false; response_revision:4739; number_of_response:1; }","duration":"120.963405ms","start":"2026-07-01T10:44:35.537011Z","end":"2026-07-01T10:44:35.657974Z","steps":["trace[1620549192] 'process raft request' (duration: 120.851572ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:44:35.658551Z","caller":"traceutil/trace.go:171","msg":"trace[52087825] transaction","detail":"{read_only:false; response_revision:4743; number_of_response:1; }","duration":"111.688908ms","start":"2026-07-01T10:44:35.546607Z","end":"2026-07-01T10:44:35.658296Z","steps":["trace[52087825] 'process raft request' (duration: 111.3666ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:44:35.658309Z","caller":"traceutil/trace.go:171","msg":"trace[1455640340] transaction","detail":"{read_only:false; response_revision:4741; number_of_response:1; }","duration":"121.019717ms","start":"2026-07-01T10:44:35.537272Z","end":"2026-07-01T10:44:35.658292Z","steps":["trace[1455640340] 'process raft request' (duration: 120.638037ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:44:35.658746Z","caller":"traceutil/trace.go:171","msg":"trace[1946428064] transaction","detail":"{read_only:false; response_revision:4742; number_of_response:1; }","duration":"120.964106ms","start":"2026-07-01T10:44:35.537773Z","end":"2026-07-01T10:44:35.658737Z","steps":["trace[1946428064] 'process raft request' (duration: 120.159174ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:44:35.658913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.631398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0d83c2dc-da7b-44ba-8689-92328e1bb6b6\" ","response":"range_response_count:1 size:3763"} {"level":"warn","ts":"2026-07-01T10:44:35.659203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.471925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" ","response":"range_response_count:1 size:1321"} {"level":"info","ts":"2026-07-01T10:44:35.65924Z","caller":"traceutil/trace.go:171","msg":"trace[492187303] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-keystone-default-user; range_end:; response_count:1; response_revision:4744; }","duration":"122.539308ms","start":"2026-07-01T10:44:35.536693Z","end":"2026-07-01T10:44:35.659232Z","steps":["trace[492187303] 'agreement among raft nodes before linearized reading' (duration: 122.416084ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:44:35.661287Z","caller":"traceutil/trace.go:171","msg":"trace[2135849810] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0d83c2dc-da7b-44ba-8689-92328e1bb6b6; range_end:; response_count:1; response_revision:4744; }","duration":"111.70339ms","start":"2026-07-01T10:44:35.547234Z","end":"2026-07-01T10:44:35.658937Z","steps":["trace[2135849810] 'agreement among raft nodes before linearized reading' (duration: 111.575167ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:44:49.461965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.166443ms","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-07-01T10:44:49.462062Z","caller":"traceutil/trace.go:171","msg":"trace[1690340765] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4945; }","duration":"120.290327ms","start":"2026-07-01T10:44:49.341742Z","end":"2026-07-01T10:44:49.462032Z","steps":["trace[1690340765] 'range keys from in-memory index tree' (duration: 119.998699ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:44:49.738208Z","caller":"traceutil/trace.go:171","msg":"trace[144541212] linearizableReadLoop","detail":"{readStateIndex:5131; appliedIndex:5130; }","duration":"123.260286ms","start":"2026-07-01T10:44:49.614926Z","end":"2026-07-01T10:44:49.738186Z","steps":["trace[144541212] 'read index received' (duration: 123.02594ms)","trace[144541212] 'applied index is now lower than readState.Index' (duration: 233.406µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:44:49.738443Z","caller":"traceutil/trace.go:171","msg":"trace[1663630639] transaction","detail":"{read_only:false; response_revision:4946; number_of_response:1; }","duration":"271.990231ms","start":"2026-07-01T10:44:49.466437Z","end":"2026-07-01T10:44:49.738428Z","steps":["trace[1663630639] 'process raft request' (duration: 271.58398ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:44:49.738685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.742209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T10:44:49.739059Z","caller":"traceutil/trace.go:171","msg":"trace[440802107] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:4946; }","duration":"124.072838ms","start":"2026-07-01T10:44:49.614895Z","end":"2026-07-01T10:44:49.738968Z","steps":["trace[440802107] 'agreement among raft nodes before linearized reading' (duration: 123.738819ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:44:49.738875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.353159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-01T10:44:49.739385Z","caller":"traceutil/trace.go:171","msg":"trace[1408028099] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:4946; }","duration":"105.883222ms","start":"2026-07-01T10:44:49.63346Z","end":"2026-07-01T10:44:49.739343Z","steps":["trace[1408028099] 'agreement among raft nodes before linearized reading' (duration: 105.180874ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:44:50.332713Z","caller":"traceutil/trace.go:171","msg":"trace[1658806847] linearizableReadLoop","detail":"{readStateIndex:5135; appliedIndex:5133; }","duration":"149.391874ms","start":"2026-07-01T10:44:50.183293Z","end":"2026-07-01T10:44:50.332685Z","steps":["trace[1658806847] 'read index received' (duration: 27.677168ms)","trace[1658806847] 'applied index is now lower than readState.Index' (duration: 121.700506ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:44:50.333064Z","caller":"traceutil/trace.go:171","msg":"trace[421226945] transaction","detail":"{read_only:false; response_revision:4950; number_of_response:1; }","duration":"155.921588ms","start":"2026-07-01T10:44:50.177125Z","end":"2026-07-01T10:44:50.333047Z","steps":["trace[421226945] 'process raft request' (duration: 62.328232ms)","trace[421226945] 'compare' (duration: 93.063362ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T10:44:50.333301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.989219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:17232"} {"level":"info","ts":"2026-07-01T10:44:50.333407Z","caller":"traceutil/trace.go:171","msg":"trace[510164032] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4950; }","duration":"150.144633ms","start":"2026-07-01T10:44:50.183241Z","end":"2026-07-01T10:44:50.333385Z","steps":["trace[510164032] 'agreement among raft nodes before linearized reading' (duration: 149.765053ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:45:36.229125Z","caller":"traceutil/trace.go:171","msg":"trace[397758496] transaction","detail":"{read_only:false; response_revision:5327; number_of_response:1; }","duration":"134.251194ms","start":"2026-07-01T10:45:36.094825Z","end":"2026-07-01T10:45:36.229076Z","steps":["trace[397758496] 'process raft request' (duration: 90.325685ms)","trace[397758496] 'compare' (duration: 43.779926ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:46:03.865758Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2877} {"level":"info","ts":"2026-07-01T10:46:03.943611Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2877,"took":"76.128164ms","hash":1836125292,"current-db-size-bytes":52994048,"current-db-size":"53 MB","current-db-size-in-use-bytes":29253632,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-07-01T10:46:03.943757Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1836125292,"revision":2877,"compact-revision":-1} {"level":"info","ts":"2026-07-01T10:46:07.52311Z","caller":"traceutil/trace.go:171","msg":"trace[1198839299] transaction","detail":"{read_only:false; response_revision:5573; number_of_response:1; }","duration":"319.239358ms","start":"2026-07-01T10:46:07.203839Z","end":"2026-07-01T10:46:07.523078Z","steps":["trace[1198839299] 'process raft request' (duration: 318.637371ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:46:07.523409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T10:46:07.203811Z","time spent":"319.476943ms","remote":"127.0.0.1:40400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T10:51:03.872393Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5552} {"level":"info","ts":"2026-07-01T10:51:03.986074Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5552,"took":"112.331959ms","hash":3394327883,"current-db-size-bytes":52994048,"current-db-size":"53 MB","current-db-size-in-use-bytes":18333696,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-01T10:51:03.986132Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3394327883,"revision":5552,"compact-revision":2877}