{"level":"warn","ts":"2026-07-01T07:20:25.806073Z","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-01T07:20:25.806145Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.4: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.4:2380","--initial-cluster=instance=https://199.204.45.4:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.4:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.4: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-01T07:20:25.806205Z","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-01T07:20:25.806219Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-07-01T07:20:25.806237Z","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-01T07:20:25.806868Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"]} {"level":"info","ts":"2026-07-01T07:20:25.806938Z","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.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.4: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-01T07:20:25.812316Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.181698ms"} {"level":"info","ts":"2026-07-01T07:20:25.83951Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"66f7b57d56ad567d","cluster-id":"ec267dcaac715770"} {"level":"info","ts":"2026-07-01T07:20:25.839602Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=()"} {"level":"info","ts":"2026-07-01T07:20:25.839622Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 0"} {"level":"info","ts":"2026-07-01T07:20:25.839633Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 66f7b57d56ad567d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-01T07:20:25.839644Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 1"} {"level":"info","ts":"2026-07-01T07:20:25.839681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"warn","ts":"2026-07-01T07:20:25.875931Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-01T07:20:25.884009Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-01T07:20:25.885486Z","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-01T07:20:25.888886Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"66f7b57d56ad567d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-01T07:20:25.889194Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"66f7b57d56ad567d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-01T07:20:25.889268Z","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-01T07:20:25.889445Z","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-01T07:20:25.889467Z","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-01T07:20:25.892815Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"info","ts":"2026-07-01T07:20:25.892954Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","added-peer-id":"66f7b57d56ad567d","added-peer-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-07-01T07:20:25.894128Z","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-01T07:20:25.894521Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"66f7b57d56ad567d","initial-advertise-peer-urls":["https://199.204.45.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-01T07:20:25.894228Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-07-01T07:20:25.896598Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-07-01T07:20:25.894742Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-01T07:20:26.240668Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d is starting a new election at term 1"} {"level":"info","ts":"2026-07-01T07:20:26.24073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became pre-candidate at term 1"} {"level":"info","ts":"2026-07-01T07:20:26.240818Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgPreVoteResp from 66f7b57d56ad567d at term 1"} {"level":"info","ts":"2026-07-01T07:20:26.240878Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became candidate at term 2"} {"level":"info","ts":"2026-07-01T07:20:26.240901Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgVoteResp from 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-07-01T07:20:26.240951Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became leader at term 2"} {"level":"info","ts":"2026-07-01T07:20:26.240978Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 66f7b57d56ad567d elected leader 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-07-01T07:20:26.242995Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T07:20:26.256873Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"66f7b57d56ad567d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.4:2379]}","request-path":"/0/members/66f7b57d56ad567d/attributes","cluster-id":"ec267dcaac715770","publish-timeout":"7s"} {"level":"info","ts":"2026-07-01T07:20:26.256921Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-01T07:20:26.257086Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-01T07:20:26.2571Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-01T07:20:26.257265Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-01T07:20:26.260008Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.4:2379"} {"level":"info","ts":"2026-07-01T07:20:26.260527Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-01T07:20:26.264308Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T07:20:26.264429Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T07:20:26.264479Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T07:20:30.037721Z","caller":"traceutil/trace.go:171","msg":"trace[465206344] transaction","detail":"{read_only:false; response_revision:206; number_of_response:1; }","duration":"165.02117ms","start":"2026-07-01T07:20:29.872659Z","end":"2026-07-01T07:20:30.03768Z","steps":["trace[465206344] 'process raft request' (duration: 164.547986ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:21:08.212848Z","caller":"traceutil/trace.go:171","msg":"trace[544918464] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"124.475222ms","start":"2026-07-01T07:21:08.088338Z","end":"2026-07-01T07:21:08.212814Z","steps":["trace[544918464] 'process raft request' (duration: 123.568696ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:21:08.430621Z","caller":"traceutil/trace.go:171","msg":"trace[884635096] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"208.735458ms","start":"2026-07-01T07:21:08.221813Z","end":"2026-07-01T07:21:08.430548Z","steps":["trace[884635096] 'process raft request' (duration: 152.476198ms)","trace[884635096] 'compare' (duration: 56.152897ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:21:08.500712Z","caller":"traceutil/trace.go:171","msg":"trace[1705879374] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"270.884441ms","start":"2026-07-01T07:21:08.2298Z","end":"2026-07-01T07:21:08.500685Z","steps":["trace[1705879374] 'process raft request' (duration: 270.365946ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:21:08.50074Z","caller":"traceutil/trace.go:171","msg":"trace[1725057169] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"227.960071ms","start":"2026-07-01T07:21:08.272749Z","end":"2026-07-01T07:21:08.500709Z","steps":["trace[1725057169] 'process raft request' (duration: 227.628092ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:21:08.500777Z","caller":"traceutil/trace.go:171","msg":"trace[1700797961] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:611; }","duration":"191.236443ms","start":"2026-07-01T07:21:08.309496Z","end":"2026-07-01T07:21:08.500732Z","steps":["trace[1700797961] 'read index received' (duration: 64.841208ms)","trace[1700797961] 'applied index is now lower than readState.Index' (duration: 126.392425ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:21:08.500907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.392377ms","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-01T07:21:08.500999Z","caller":"traceutil/trace.go:171","msg":"trace[356920069] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:588; }","duration":"191.523221ms","start":"2026-07-01T07:21:08.30946Z","end":"2026-07-01T07:21:08.500984Z","steps":["trace[356920069] 'agreement among raft nodes before linearized reading' (duration: 191.337476ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:21:08.559284Z","caller":"traceutil/trace.go:171","msg":"trace[1924290772] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"160.504171ms","start":"2026-07-01T07:21:08.398756Z","end":"2026-07-01T07:21:08.55926Z","steps":["trace[1924290772] 'process raft request' (duration: 134.983653ms)","trace[1924290772] 'compare' (duration: 25.317752ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:21:09.330143Z","caller":"traceutil/trace.go:171","msg":"trace[1391952520] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"373.494302ms","start":"2026-07-01T07:21:08.956614Z","end":"2026-07-01T07:21:09.330109Z","steps":["trace[1391952520] 'process raft request' (duration: 372.576006ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:21:09.331624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:21:08.956577Z","time spent":"374.110019ms","remote":"127.0.0.1:55718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T07:21:24.135636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.160398ms","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-01T07:21:24.135763Z","caller":"traceutil/trace.go:171","msg":"trace[46937581] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:749; }","duration":"123.325552ms","start":"2026-07-01T07:21:24.01242Z","end":"2026-07-01T07:21:24.135746Z","steps":["trace[46937581] 'range keys from in-memory index tree' (duration: 122.989662ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:22:12.164564Z","caller":"traceutil/trace.go:171","msg":"trace[624817866] transaction","detail":"{read_only:false; response_revision:1370; number_of_response:1; }","duration":"107.582033ms","start":"2026-07-01T07:22:12.056955Z","end":"2026-07-01T07:22:12.164537Z","steps":["trace[624817866] 'process raft request' (duration: 107.386617ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:22:12.480177Z","caller":"traceutil/trace.go:171","msg":"trace[895776300] transaction","detail":"{read_only:false; response_revision:1372; number_of_response:1; }","duration":"260.337793ms","start":"2026-07-01T07:22:12.219808Z","end":"2026-07-01T07:22:12.480146Z","steps":["trace[895776300] 'process raft request' (duration: 179.244674ms)","trace[895776300] 'compare' (duration: 80.933914ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:22:12.493715Z","caller":"traceutil/trace.go:171","msg":"trace[25564006] linearizableReadLoop","detail":"{readStateIndex:1419; appliedIndex:1417; }","duration":"236.0373ms","start":"2026-07-01T07:22:12.257665Z","end":"2026-07-01T07:22:12.493702Z","steps":["trace[25564006] 'read index received' (duration: 141.289572ms)","trace[25564006] 'applied index is now lower than readState.Index' (duration: 94.747128ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:22:12.4939Z","caller":"traceutil/trace.go:171","msg":"trace[1555747235] transaction","detail":"{read_only:false; response_revision:1373; number_of_response:1; }","duration":"249.539765ms","start":"2026-07-01T07:22:12.244353Z","end":"2026-07-01T07:22:12.493893Z","steps":["trace[1555747235] 'process raft request' (duration: 249.274448ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:22:12.494035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.35154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:22:12.494159Z","caller":"traceutil/trace.go:171","msg":"trace[394906370] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1373; }","duration":"236.464042ms","start":"2026-07-01T07:22:12.257634Z","end":"2026-07-01T07:22:12.494098Z","steps":["trace[394906370] 'agreement among raft nodes before linearized reading' (duration: 236.262627ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:22:40.881374Z","caller":"traceutil/trace.go:171","msg":"trace[1672361837] transaction","detail":"{read_only:false; response_revision:1813; number_of_response:1; }","duration":"282.733193ms","start":"2026-07-01T07:22:40.598618Z","end":"2026-07-01T07:22:40.881351Z","steps":["trace[1672361837] 'process raft request' (duration: 282.571568ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:22:40.940985Z","caller":"traceutil/trace.go:171","msg":"trace[1274986050] linearizableReadLoop","detail":"{readStateIndex:1890; appliedIndex:1888; }","duration":"323.16721ms","start":"2026-07-01T07:22:40.617796Z","end":"2026-07-01T07:22:40.940964Z","steps":["trace[1274986050] 'read index received' (duration: 263.658977ms)","trace[1274986050] 'applied index is now lower than readState.Index' (duration: 59.507223ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:22:40.941253Z","caller":"traceutil/trace.go:171","msg":"trace[599193803] transaction","detail":"{read_only:false; response_revision:1815; number_of_response:1; }","duration":"328.000229ms","start":"2026-07-01T07:22:40.613206Z","end":"2026-07-01T07:22:40.941206Z","steps":["trace[599193803] 'process raft request' (duration: 327.68084ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:22:40.941251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.437758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:22:40.941286Z","caller":"traceutil/trace.go:171","msg":"trace[655976315] transaction","detail":"{read_only:false; response_revision:1816; number_of_response:1; }","duration":"285.926784ms","start":"2026-07-01T07:22:40.655322Z","end":"2026-07-01T07:22:40.941249Z","steps":["trace[655976315] 'process raft request' (duration: 285.607255ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:22:40.941384Z","caller":"traceutil/trace.go:171","msg":"trace[1181136984] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:1816; }","duration":"323.591323ms","start":"2026-07-01T07:22:40.617747Z","end":"2026-07-01T07:22:40.941339Z","steps":["trace[1181136984] 'agreement among raft nodes before linearized reading' (duration: 323.437558ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:22:40.941456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:22:40.617724Z","time spent":"323.707625ms","remote":"127.0.0.1:58316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "} {"level":"warn","ts":"2026-07-01T07:22:40.941457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:22:40.613175Z","time spent":"328.171163ms","remote":"127.0.0.1:55886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T07:22:40.941888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.219209ms","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-01T07:22:40.942026Z","caller":"traceutil/trace.go:171","msg":"trace[2131430646] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1816; }","duration":"281.389934ms","start":"2026-07-01T07:22:40.660628Z","end":"2026-07-01T07:22:40.942018Z","steps":["trace[2131430646] 'agreement among raft nodes before linearized reading' (duration: 280.772377ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:22:40.941677Z","caller":"traceutil/trace.go:171","msg":"trace[307193490] transaction","detail":"{read_only:false; response_revision:1814; number_of_response:1; }","duration":"340.105165ms","start":"2026-07-01T07:22:40.601555Z","end":"2026-07-01T07:22:40.94166Z","steps":["trace[307193490] 'process raft request' (duration: 339.187329ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:22:40.942708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:22:40.601539Z","time spent":"341.117785ms","remote":"127.0.0.1:55780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3730,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T07:23:09.234682Z","caller":"traceutil/trace.go:171","msg":"trace[424000269] transaction","detail":"{read_only:false; response_revision:2027; number_of_response:1; }","duration":"130.350784ms","start":"2026-07-01T07:23:09.104305Z","end":"2026-07-01T07:23:09.234656Z","steps":["trace[424000269] 'process raft request' (duration: 130.045826ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:14.772951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.50406ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-01T07:23:14.773068Z","caller":"traceutil/trace.go:171","msg":"trace[1741081557] linearizableReadLoop","detail":"{readStateIndex:2136; appliedIndex:2135; }","duration":"178.51478ms","start":"2026-07-01T07:23:14.594532Z","end":"2026-07-01T07:23:14.773047Z","steps":["trace[1741081557] 'read index received' (duration: 70.602669ms)","trace[1741081557] 'applied index is now lower than readState.Index' (duration: 107.910441ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:23:14.77347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.910361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-07-01T07:23:14.773662Z","caller":"traceutil/trace.go:171","msg":"trace[1120277983] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2054; }","duration":"179.090957ms","start":"2026-07-01T07:23:14.594491Z","end":"2026-07-01T07:23:14.773582Z","steps":["trace[1120277983] 'agreement among raft nodes before linearized reading' (duration: 178.773377ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:14.774545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.408883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18be198b8a3487d6\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-07-01T07:23:14.774599Z","caller":"traceutil/trace.go:171","msg":"trace[1554101677] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18be198b8a3487d6; range_end:; response_count:1; response_revision:2054; }","duration":"174.528475ms","start":"2026-07-01T07:23:14.600054Z","end":"2026-07-01T07:23:14.774583Z","steps":["trace[1554101677] 'agreement among raft nodes before linearized reading' (duration: 173.31165ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:15.399601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.208605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12381"} {"level":"warn","ts":"2026-07-01T07:23:15.399659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.529907ms","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-01T07:23:15.400197Z","caller":"traceutil/trace.go:171","msg":"trace[1253006064] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2058; }","duration":"293.112634ms","start":"2026-07-01T07:23:15.107067Z","end":"2026-07-01T07:23:15.400179Z","steps":["trace[1253006064] 'range keys from in-memory index tree' (duration: 292.375883ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:15.399725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.771238ms","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-07-01T07:23:15.400355Z","caller":"traceutil/trace.go:171","msg":"trace[1307557525] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2058; }","duration":"139.452079ms","start":"2026-07-01T07:23:15.260874Z","end":"2026-07-01T07:23:15.400326Z","steps":["trace[1307557525] 'range keys from in-memory index tree' (duration: 138.519072ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:15.399833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.962845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-07-01T07:23:15.400589Z","caller":"traceutil/trace.go:171","msg":"trace[1534998343] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2058; }","duration":"138.773358ms","start":"2026-07-01T07:23:15.261784Z","end":"2026-07-01T07:23:15.400557Z","steps":["trace[1534998343] 'range keys from in-memory index tree' (duration: 137.783891ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:15.399836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.951977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:23:15.400126Z","caller":"traceutil/trace.go:171","msg":"trace[1432477311] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2058; }","duration":"239.780401ms","start":"2026-07-01T07:23:15.160325Z","end":"2026-07-01T07:23:15.400106Z","steps":["trace[1432477311] 'range keys from in-memory index tree' (duration: 239.054431ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:23:15.400746Z","caller":"traceutil/trace.go:171","msg":"trace[278469507] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:2058; }","duration":"231.932336ms","start":"2026-07-01T07:23:15.168798Z","end":"2026-07-01T07:23:15.40073Z","steps":["trace[278469507] 'count revisions from in-memory index tree' (duration: 230.798124ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:15.40002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.330648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-01T07:23:15.400799Z","caller":"traceutil/trace.go:171","msg":"trace[1649427295] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2058; }","duration":"272.114171ms","start":"2026-07-01T07:23:15.128669Z","end":"2026-07-01T07:23:15.400783Z","steps":["trace[1649427295] 'range keys from in-memory index tree' (duration: 270.963628ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:23:15.603601Z","caller":"traceutil/trace.go:171","msg":"trace[1366842760] transaction","detail":"{read_only:false; response_revision:2059; number_of_response:1; }","duration":"195.641233ms","start":"2026-07-01T07:23:15.407935Z","end":"2026-07-01T07:23:15.603576Z","steps":["trace[1366842760] 'process raft request' (duration: 195.488759ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:23:15.606821Z","caller":"traceutil/trace.go:171","msg":"trace[815721925] transaction","detail":"{read_only:false; response_revision:2060; number_of_response:1; }","duration":"198.790954ms","start":"2026-07-01T07:23:15.408009Z","end":"2026-07-01T07:23:15.6068Z","steps":["trace[815721925] 'process raft request' (duration: 198.509186ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:23:15.607184Z","caller":"traceutil/trace.go:171","msg":"trace[1809971638] transaction","detail":"{read_only:false; response_revision:2062; number_of_response:1; }","duration":"199.02468ms","start":"2026-07-01T07:23:15.408133Z","end":"2026-07-01T07:23:15.607157Z","steps":["trace[1809971638] 'process raft request' (duration: 198.791333ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:23:15.607218Z","caller":"traceutil/trace.go:171","msg":"trace[183566949] transaction","detail":"{read_only:false; response_revision:2061; number_of_response:1; }","duration":"199.200166ms","start":"2026-07-01T07:23:15.408005Z","end":"2026-07-01T07:23:15.607205Z","steps":["trace[183566949] 'process raft request' (duration: 198.66203ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:23:15.607463Z","caller":"traceutil/trace.go:171","msg":"trace[1658451201] linearizableReadLoop","detail":"{readStateIndex:2144; appliedIndex:2140; }","duration":"195.544671ms","start":"2026-07-01T07:23:15.411485Z","end":"2026-07-01T07:23:15.60703Z","steps":["trace[1658451201] 'read index received' (duration: 190.883956ms)","trace[1658451201] 'applied index is now lower than readState.Index' (duration: 4.660085ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:23:15.607726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.067315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:23:15.607769Z","caller":"traceutil/trace.go:171","msg":"trace[30164149] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2063; }","duration":"196.310303ms","start":"2026-07-01T07:23:15.411449Z","end":"2026-07-01T07:23:15.607759Z","steps":["trace[30164149] 'agreement among raft nodes before linearized reading' (duration: 196.039745ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:15.607908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.192042ms","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-07-01T07:23:15.607957Z","caller":"traceutil/trace.go:171","msg":"trace[666718420] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2063; }","duration":"162.291345ms","start":"2026-07-01T07:23:15.445653Z","end":"2026-07-01T07:23:15.607944Z","steps":["trace[666718420] 'agreement among raft nodes before linearized reading' (duration: 162.038428ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:15.862018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.17523ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T07:23:15.862129Z","caller":"traceutil/trace.go:171","msg":"trace[1026116397] linearizableReadLoop","detail":"{readStateIndex:2146; appliedIndex:2145; }","duration":"244.298421ms","start":"2026-07-01T07:23:15.617814Z","end":"2026-07-01T07:23:15.862112Z","steps":["trace[1026116397] 'read index received' (duration: 128.951506ms)","trace[1026116397] 'applied index is now lower than readState.Index' (duration: 115.345825ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:23:15.86229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.480768ms","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-07-01T07:23:15.862266Z","caller":"traceutil/trace.go:171","msg":"trace[1016524306] transaction","detail":"{read_only:false; response_revision:2064; number_of_response:1; }","duration":"248.967606ms","start":"2026-07-01T07:23:15.613245Z","end":"2026-07-01T07:23:15.862213Z","steps":["trace[1016524306] 'process raft request' (duration: 133.467416ms)","trace[1016524306] 'compare' (duration: 115.058887ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:23:15.862326Z","caller":"traceutil/trace.go:171","msg":"trace[1426052315] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2064; }","duration":"148.55076ms","start":"2026-07-01T07:23:15.713765Z","end":"2026-07-01T07:23:15.862316Z","steps":["trace[1426052315] 'agreement among raft nodes before linearized reading' (duration: 148.437686ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:15.862379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.536418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-07-01T07:23:15.862452Z","caller":"traceutil/trace.go:171","msg":"trace[588728010] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2064; }","duration":"244.655671ms","start":"2026-07-01T07:23:15.617779Z","end":"2026-07-01T07:23:15.862435Z","steps":["trace[588728010] 'agreement among raft nodes before linearized reading' (duration: 244.419434ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:24:16.314968Z","caller":"traceutil/trace.go:171","msg":"trace[495948802] transaction","detail":"{read_only:false; response_revision:2493; number_of_response:1; }","duration":"148.167953ms","start":"2026-07-01T07:24:16.166777Z","end":"2026-07-01T07:24:16.314945Z","steps":["trace[495948802] 'process raft request' (duration: 147.954477ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:24:16.315305Z","caller":"traceutil/trace.go:171","msg":"trace[1071297460] linearizableReadLoop","detail":"{readStateIndex:2590; appliedIndex:2588; }","duration":"131.754499ms","start":"2026-07-01T07:24:16.183526Z","end":"2026-07-01T07:24:16.31528Z","steps":["trace[1071297460] 'read index received' (duration: 131.257255ms)","trace[1071297460] 'applied index is now lower than readState.Index' (duration: 496.144µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:24:16.315346Z","caller":"traceutil/trace.go:171","msg":"trace[1961652245] transaction","detail":"{read_only:false; response_revision:2494; number_of_response:1; }","duration":"147.933877ms","start":"2026-07-01T07:24:16.16739Z","end":"2026-07-01T07:24:16.315324Z","steps":["trace[1961652245] 'process raft request' (duration: 147.795493ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:24:16.315514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.974026ms","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-07-01T07:24:16.315557Z","caller":"traceutil/trace.go:171","msg":"trace[1619714629] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2494; }","duration":"132.076829ms","start":"2026-07-01T07:24:16.183471Z","end":"2026-07-01T07:24:16.315547Z","steps":["trace[1619714629] 'agreement among raft nodes before linearized reading' (duration: 131.899704ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:24:49.512399Z","caller":"traceutil/trace.go:171","msg":"trace[1574739868] transaction","detail":"{read_only:false; response_revision:2673; number_of_response:1; }","duration":"176.088632ms","start":"2026-07-01T07:24:49.336294Z","end":"2026-07-01T07:24:49.512383Z","steps":["trace[1574739868] 'process raft request' (duration: 175.948968ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:24:49.51262Z","caller":"traceutil/trace.go:171","msg":"trace[1291149276] linearizableReadLoop","detail":"{readStateIndex:2777; appliedIndex:2775; }","duration":"158.954247ms","start":"2026-07-01T07:24:49.353643Z","end":"2026-07-01T07:24:49.512597Z","steps":["trace[1291149276] 'read index received' (duration: 48.87006ms)","trace[1291149276] 'applied index is now lower than readState.Index' (duration: 110.082347ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:24:49.512685Z","caller":"traceutil/trace.go:171","msg":"trace[590329661] transaction","detail":"{read_only:false; response_revision:2674; number_of_response:1; }","duration":"121.59242ms","start":"2026-07-01T07:24:49.391082Z","end":"2026-07-01T07:24:49.512674Z","steps":["trace[590329661] 'process raft request' (duration: 121.26515ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:24:49.512941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.272517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-07-01T07:24:49.512985Z","caller":"traceutil/trace.go:171","msg":"trace[530532083] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2674; }","duration":"159.38605ms","start":"2026-07-01T07:24:49.353586Z","end":"2026-07-01T07:24:49.512973Z","steps":["trace[530532083] 'agreement among raft nodes before linearized reading' (duration: 159.119123ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:24:49.516004Z","caller":"traceutil/trace.go:171","msg":"trace[1423281019] transaction","detail":"{read_only:false; response_revision:2675; number_of_response:1; }","duration":"112.25135ms","start":"2026-07-01T07:24:49.403728Z","end":"2026-07-01T07:24:49.515979Z","steps":["trace[1423281019] 'process raft request' (duration: 112.139547ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:28:36.465124Z","caller":"traceutil/trace.go:171","msg":"trace[1806975368] transaction","detail":"{read_only:false; response_revision:4641; number_of_response:1; }","duration":"129.448111ms","start":"2026-07-01T07:28:36.335659Z","end":"2026-07-01T07:28:36.465107Z","steps":["trace[1806975368] 'process raft request' (duration: 129.351459ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:28:36.486464Z","caller":"traceutil/trace.go:171","msg":"trace[1590661721] transaction","detail":"{read_only:false; response_revision:4642; number_of_response:1; }","duration":"136.371349ms","start":"2026-07-01T07:28:36.35006Z","end":"2026-07-01T07:28:36.486431Z","steps":["trace[1590661721] 'process raft request' (duration: 135.447133ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:28:47.985511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.487181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-07-01T07:28:47.985623Z","caller":"traceutil/trace.go:171","msg":"trace[86802911] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4815; }","duration":"315.657466ms","start":"2026-07-01T07:28:47.669948Z","end":"2026-07-01T07:28:47.985605Z","steps":["trace[86802911] 'range keys from in-memory index tree' (duration: 315.308826ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:28:47.985663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:28:47.669906Z","time spent":"315.748068ms","remote":"127.0.0.1:55886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-01T07:28:47.985781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.826514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-07-01T07:28:47.985879Z","caller":"traceutil/trace.go:171","msg":"trace[117992530] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4815; }","duration":"307.971308ms","start":"2026-07-01T07:28:47.677884Z","end":"2026-07-01T07:28:47.985856Z","steps":["trace[117992530] 'range keys from in-memory index tree' (duration: 307.584366ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:28:47.985934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:28:47.677865Z","time spent":"308.05498ms","remote":"127.0.0.1:55886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-01T07:28:49.471524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.639053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.4\" ","response":"range_response_count:1 size:131"} {"level":"info","ts":"2026-07-01T07:28:49.471624Z","caller":"traceutil/trace.go:171","msg":"trace[2136847097] range","detail":"{range_begin:/registry/masterleases/199.204.45.4; range_end:; response_count:1; response_revision:4832; }","duration":"148.787137ms","start":"2026-07-01T07:28:49.322813Z","end":"2026-07-01T07:28:49.4716Z","steps":["trace[2136847097] 'range keys from in-memory index tree' (duration: 148.409655ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:29:27.516039Z","caller":"traceutil/trace.go:171","msg":"trace[1114002566] linearizableReadLoop","detail":"{readStateIndex:5358; appliedIndex:5356; }","duration":"106.123929ms","start":"2026-07-01T07:29:27.409897Z","end":"2026-07-01T07:29:27.516021Z","steps":["trace[1114002566] 'read index received' (duration: 34.241368ms)","trace[1114002566] 'applied index is now lower than readState.Index' (duration: 71.881711ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:29:27.516382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.455088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-07-01T07:29:27.51642Z","caller":"traceutil/trace.go:171","msg":"trace[340870878] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5168; }","duration":"106.554321ms","start":"2026-07-01T07:29:27.409857Z","end":"2026-07-01T07:29:27.516412Z","steps":["trace[340870878] 'agreement among raft nodes before linearized reading' (duration: 106.394266ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:29:27.516655Z","caller":"traceutil/trace.go:171","msg":"trace[1095269473] transaction","detail":"{read_only:false; response_revision:5168; number_of_response:1; }","duration":"110.265756ms","start":"2026-07-01T07:29:27.406364Z","end":"2026-07-01T07:29:27.51663Z","steps":["trace[1095269473] 'process raft request' (duration: 109.321979ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:30:26.289172Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2868} {"level":"info","ts":"2026-07-01T07:30:26.364139Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2868,"took":"73.266816ms","hash":3426090727,"current-db-size-bytes":53497856,"current-db-size":"54 MB","current-db-size-in-use-bytes":29351936,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-07-01T07:30:26.364248Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3426090727,"revision":2868,"compact-revision":-1} {"level":"info","ts":"2026-07-01T07:33:03.43672Z","caller":"traceutil/trace.go:171","msg":"trace[908795103] transaction","detail":"{read_only:false; response_revision:6661; number_of_response:1; }","duration":"105.099434ms","start":"2026-07-01T07:33:03.331589Z","end":"2026-07-01T07:33:03.436688Z","steps":["trace[908795103] 'process raft request' (duration: 48.770419ms)","trace[908795103] 'compare' (duration: 56.083138ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:35:26.293943Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5603} {"level":"info","ts":"2026-07-01T07:35:26.408282Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5603,"took":"113.247144ms","hash":736924145,"current-db-size-bytes":53497856,"current-db-size":"54 MB","current-db-size-in-use-bytes":18280448,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-01T07:35:26.408366Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":736924145,"revision":5603,"compact-revision":2868}