{"level":"warn","ts":"2026-08-10T22:18:31.931697Z","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-10T22:18:31.931839Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.35: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.35:2380","--initial-cluster=instance=https://199.19.213.35:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.35:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.35: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-10T22:18:31.931911Z","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-10T22:18:31.931922Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.35:2380"]} {"level":"info","ts":"2026-08-10T22:18:31.931939Z","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-10T22:18:31.932853Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.35:2379"]} {"level":"info","ts":"2026-08-10T22:18:31.932971Z","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.35:2380"],"listen-peer-urls":["https://199.19.213.35:2380"],"advertise-client-urls":["https://199.19.213.35:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.35:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.35: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-10T22:18:31.942349Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"8.310999ms"} {"level":"info","ts":"2026-08-10T22:18:31.952893Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d1606b245347dc08","cluster-id":"e68e205b85faf98a"} {"level":"info","ts":"2026-08-10T22:18:31.953155Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 switched to configuration voters=()"} {"level":"info","ts":"2026-08-10T22:18:31.9533Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 became follower at term 0"} {"level":"info","ts":"2026-08-10T22:18:31.95342Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d1606b245347dc08 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-10T22:18:31.953486Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 became follower at term 1"} {"level":"info","ts":"2026-08-10T22:18:31.953664Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 switched to configuration voters=(15087176555451374600)"} {"level":"warn","ts":"2026-08-10T22:18:31.971213Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-10T22:18:31.975517Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-10T22:18:31.977347Z","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-10T22:18:31.979847Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d1606b245347dc08","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-10T22:18:31.980241Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d1606b245347dc08","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-10T22:18:31.980317Z","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-10T22:18:31.980354Z","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-10T22:18:31.980364Z","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-10T22:18:31.980982Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 switched to configuration voters=(15087176555451374600)"} {"level":"info","ts":"2026-08-10T22:18:31.981106Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e68e205b85faf98a","local-member-id":"d1606b245347dc08","added-peer-id":"d1606b245347dc08","added-peer-peer-urls":["https://199.19.213.35:2380"]} {"level":"info","ts":"2026-08-10T22:18:31.993366Z","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-10T22:18:31.99352Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.35:2380"} {"level":"info","ts":"2026-08-10T22:18:31.993587Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d1606b245347dc08","initial-advertise-peer-urls":["https://199.19.213.35:2380"],"listen-peer-urls":["https://199.19.213.35:2380"],"advertise-client-urls":["https://199.19.213.35:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.35:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-10T22:18:31.993563Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.35:2380"} {"level":"info","ts":"2026-08-10T22:18:31.993625Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-10T22:18:32.154011Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 is starting a new election at term 1"} {"level":"info","ts":"2026-08-10T22:18:32.154069Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-10T22:18:32.154116Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 received MsgPreVoteResp from d1606b245347dc08 at term 1"} {"level":"info","ts":"2026-08-10T22:18:32.154302Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 became candidate at term 2"} {"level":"info","ts":"2026-08-10T22:18:32.154418Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 received MsgVoteResp from d1606b245347dc08 at term 2"} {"level":"info","ts":"2026-08-10T22:18:32.154436Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 became leader at term 2"} {"level":"info","ts":"2026-08-10T22:18:32.154494Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d1606b245347dc08 elected leader d1606b245347dc08 at term 2"} {"level":"info","ts":"2026-08-10T22:18:32.155758Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d1606b245347dc08","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.35:2379]}","request-path":"/0/members/d1606b245347dc08/attributes","cluster-id":"e68e205b85faf98a","publish-timeout":"7s"} {"level":"info","ts":"2026-08-10T22:18:32.156028Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-10T22:18:32.156166Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-10T22:18:32.156196Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-10T22:18:32.159381Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e68e205b85faf98a","local-member-id":"d1606b245347dc08","cluster-version":"3.5"} {"level":"info","ts":"2026-08-10T22:18:32.159465Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-10T22:18:32.159505Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-10T22:18:32.160094Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.35:2379"} {"level":"info","ts":"2026-08-10T22:18:32.160281Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-10T22:18:32.160332Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-10T22:18:32.164732Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-08-10T22:18:36.393177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.053902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-10T22:18:36.393244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.22676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-08-10T22:18:36.393366Z","caller":"traceutil/trace.go:171","msg":"trace[1756962514] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:217; }","duration":"304.355931ms","start":"2026-08-10T22:18:36.088966Z","end":"2026-08-10T22:18:36.393322Z","steps":["trace[1756962514] 'range keys from in-memory index tree' (duration: 303.841645ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:18:36.393224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.441283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3491"} {"level":"info","ts":"2026-08-10T22:18:36.393438Z","caller":"traceutil/trace.go:171","msg":"trace[1045024498] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:217; }","duration":"303.6945ms","start":"2026-08-10T22:18:36.089732Z","end":"2026-08-10T22:18:36.393426Z","steps":["trace[1045024498] 'range keys from in-memory index tree' (duration: 303.287927ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:18:36.393491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:18:36.08894Z","time spent":"304.512046ms","remote":"127.0.0.1:45136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-10T22:18:36.393491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:18:36.089701Z","time spent":"303.775833ms","remote":"127.0.0.1:45040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3515,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-08-10T22:18:36.393386Z","caller":"traceutil/trace.go:171","msg":"trace[89436415] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:217; }","duration":"284.421167ms","start":"2026-08-10T22:18:36.108943Z","end":"2026-08-10T22:18:36.393364Z","steps":["trace[89436415] 'range keys from in-memory index tree' (duration: 284.013043ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:18:36.503607Z","caller":"traceutil/trace.go:171","msg":"trace[682084244] transaction","detail":"{read_only:false; response_revision:218; number_of_response:1; }","duration":"106.854439ms","start":"2026-08-10T22:18:36.396719Z","end":"2026-08-10T22:18:36.503574Z","steps":["trace[682084244] 'process raft request' (duration: 106.690514ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:18:36.503776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.487538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cronjob-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-10T22:18:36.503862Z","caller":"traceutil/trace.go:171","msg":"trace[1670600021] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cronjob-controller; range_end:; response_count:0; response_revision:218; }","duration":"106.600911ms","start":"2026-08-10T22:18:36.397241Z","end":"2026-08-10T22:18:36.503842Z","steps":["trace[1670600021] 'agreement among raft nodes before linearized reading' (duration: 106.434996ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:18:36.504132Z","caller":"traceutil/trace.go:171","msg":"trace[1080709432] linearizableReadLoop","detail":"{readStateIndex:224; appliedIndex:223; }","duration":"106.276422ms","start":"2026-08-10T22:18:36.397266Z","end":"2026-08-10T22:18:36.503543Z","steps":["trace[1080709432] 'read index received' (duration: 106.170099ms)","trace[1080709432] 'applied index is now lower than readState.Index' (duration: 105.563µs)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:18:36.636157Z","caller":"traceutil/trace.go:171","msg":"trace[601786008] linearizableReadLoop","detail":"{readStateIndex:225; appliedIndex:224; }","duration":"129.583372ms","start":"2026-08-10T22:18:36.506537Z","end":"2026-08-10T22:18:36.63612Z","steps":["trace[601786008] 'read index received' (duration: 125.567596ms)","trace[601786008] 'applied index is now lower than readState.Index' (duration: 4.014646ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:18:36.63619Z","caller":"traceutil/trace.go:171","msg":"trace[1859172319] transaction","detail":"{read_only:false; response_revision:219; number_of_response:1; }","duration":"233.209001ms","start":"2026-08-10T22:18:36.402953Z","end":"2026-08-10T22:18:36.636162Z","steps":["trace[1859172319] 'process raft request' (duration: 229.114192ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:18:36.636338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.535459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-08-10T22:18:36.636332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.774609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-08-10T22:18:36.636379Z","caller":"traceutil/trace.go:171","msg":"trace[678870440] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:219; }","duration":"128.623572ms","start":"2026-08-10T22:18:36.507743Z","end":"2026-08-10T22:18:36.636366Z","steps":["trace[678870440] 'agreement among raft nodes before linearized reading' (duration: 128.540409ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:18:36.636396Z","caller":"traceutil/trace.go:171","msg":"trace[911515562] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:219; }","duration":"129.886923ms","start":"2026-08-10T22:18:36.506494Z","end":"2026-08-10T22:18:36.636381Z","steps":["trace[911515562] 'agreement among raft nodes before linearized reading' (duration: 129.758689ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:19:08.775072Z","caller":"traceutil/trace.go:171","msg":"trace[378788434] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"206.047876ms","start":"2026-08-10T22:19:08.568951Z","end":"2026-08-10T22:19:08.774999Z","steps":["trace[378788434] 'process raft request' (duration: 205.849629ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:19:08.775279Z","caller":"traceutil/trace.go:171","msg":"trace[1910446383] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"206.353185ms","start":"2026-08-10T22:19:08.568912Z","end":"2026-08-10T22:19:08.775265Z","steps":["trace[1910446383] 'process raft request' (duration: 205.843509ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:19:08.775413Z","caller":"traceutil/trace.go:171","msg":"trace[2042257031] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"206.258632ms","start":"2026-08-10T22:19:08.569145Z","end":"2026-08-10T22:19:08.775404Z","steps":["trace[2042257031] 'process raft request' (duration: 205.760896ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:19:08.775584Z","caller":"traceutil/trace.go:171","msg":"trace[1167430182] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"206.419528ms","start":"2026-08-10T22:19:08.569105Z","end":"2026-08-10T22:19:08.77545Z","steps":["trace[1167430182] 'process raft request' (duration: 205.753636ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:19:08.775039Z","caller":"traceutil/trace.go:171","msg":"trace[303548265] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"209.702914ms","start":"2026-08-10T22:19:08.565308Z","end":"2026-08-10T22:19:08.775011Z","steps":["trace[303548265] 'process raft request' (duration: 113.536475ms)","trace[303548265] 'compare' (duration: 95.699754ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:19:08.775034Z","caller":"traceutil/trace.go:171","msg":"trace[602964594] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"205.822128ms","start":"2026-08-10T22:19:08.569177Z","end":"2026-08-10T22:19:08.774999Z","steps":["trace[602964594] 'process raft request' (duration: 205.777086ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:19:08.781894Z","caller":"traceutil/trace.go:171","msg":"trace[1531613024] transaction","detail":"{read_only:false; number_of_response:1; response_revision:496; }","duration":"211.310236ms","start":"2026-08-10T22:19:08.570525Z","end":"2026-08-10T22:19:08.781835Z","steps":["trace[1531613024] 'process raft request' (duration: 209.868479ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:19:08.784883Z","caller":"traceutil/trace.go:171","msg":"trace[285953304] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"214.398046ms","start":"2026-08-10T22:19:08.570443Z","end":"2026-08-10T22:19:08.784841Z","steps":["trace[285953304] 'process raft request' (duration: 207.906325ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:19:08.785307Z","caller":"traceutil/trace.go:171","msg":"trace[714744768] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"211.162412ms","start":"2026-08-10T22:19:08.574108Z","end":"2026-08-10T22:19:08.78527Z","steps":["trace[714744768] 'process raft request' (duration: 206.613104ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:19:08.785421Z","caller":"traceutil/trace.go:171","msg":"trace[2123399263] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"198.466669ms","start":"2026-08-10T22:19:08.586912Z","end":"2026-08-10T22:19:08.785378Z","steps":["trace[2123399263] 'process raft request' (duration: 194.487269ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:19:08.786721Z","caller":"traceutil/trace.go:171","msg":"trace[1138976093] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"194.049684ms","start":"2026-08-10T22:19:08.592648Z","end":"2026-08-10T22:19:08.786698Z","steps":["trace[1138976093] 'process raft request' (duration: 188.893436ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:19:08.787244Z","caller":"traceutil/trace.go:171","msg":"trace[375251410] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"172.980108ms","start":"2026-08-10T22:19:08.614232Z","end":"2026-08-10T22:19:08.787213Z","steps":["trace[375251410] 'process raft request' (duration: 172.780491ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:19:08.787885Z","caller":"traceutil/trace.go:171","msg":"trace[870283107] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"186.989074ms","start":"2026-08-10T22:19:08.600867Z","end":"2026-08-10T22:19:08.787856Z","steps":["trace[870283107] 'process raft request' (duration: 181.508476ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:19:15.35775Z","caller":"traceutil/trace.go:171","msg":"trace[1211021915] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"112.975158ms","start":"2026-08-10T22:19:15.244738Z","end":"2026-08-10T22:19:15.357713Z","steps":["trace[1211021915] 'process raft request' (duration: 112.126299ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:19:15.74394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.32508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-10T22:19:15.74406Z","caller":"traceutil/trace.go:171","msg":"trace[945699747] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:601; }","duration":"135.464935ms","start":"2026-08-10T22:19:15.608556Z","end":"2026-08-10T22:19:15.744021Z","steps":["trace[945699747] 'range keys from in-memory index tree' (duration: 135.161415ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:19:16.018343Z","caller":"traceutil/trace.go:171","msg":"trace[669345413] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:619; }","duration":"181.582553ms","start":"2026-08-10T22:19:15.836743Z","end":"2026-08-10T22:19:16.018326Z","steps":["trace[669345413] 'read index received' (duration: 181.438618ms)","trace[669345413] 'applied index is now lower than readState.Index' (duration: 143.265µs)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:19:16.018553Z","caller":"traceutil/trace.go:171","msg":"trace[1990553940] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"256.511976ms","start":"2026-08-10T22:19:15.762033Z","end":"2026-08-10T22:19:16.018545Z","steps":["trace[1990553940] 'process raft request' (duration: 256.193536ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:19:16.019049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.482395ms","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-10T22:19:16.019091Z","caller":"traceutil/trace.go:171","msg":"trace[1447357654] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:602; }","duration":"168.570668ms","start":"2026-08-10T22:19:15.850512Z","end":"2026-08-10T22:19:16.019082Z","steps":["trace[1447357654] 'agreement among raft nodes before linearized reading' (duration: 168.3377ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:19:16.019052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.293657ms","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-10T22:19:16.019176Z","caller":"traceutil/trace.go:171","msg":"trace[1871362197] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:602; }","duration":"182.41023ms","start":"2026-08-10T22:19:15.836726Z","end":"2026-08-10T22:19:16.019136Z","steps":["trace[1871362197] 'agreement among raft nodes before linearized reading' (duration: 182.018628ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:19:16.019275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.452784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-10T22:19:16.019304Z","caller":"traceutil/trace.go:171","msg":"trace[1722025828] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:602; }","duration":"168.532297ms","start":"2026-08-10T22:19:15.850763Z","end":"2026-08-10T22:19:16.019296Z","steps":["trace[1722025828] 'agreement among raft nodes before linearized reading' (duration: 168.453934ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:19:16.41351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.715061ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-10T22:19:16.413625Z","caller":"traceutil/trace.go:171","msg":"trace[694081648] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"389.914153ms","start":"2026-08-10T22:19:16.023694Z","end":"2026-08-10T22:19:16.413608Z","steps":["trace[694081648] 'process raft request' (duration: 200.449146ms)","trace[694081648] 'compare' (duration: 188.473614ms)"],"step_count":2} {"level":"warn","ts":"2026-08-10T22:19:16.413713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:19:16.023681Z","time spent":"389.996575ms","remote":"127.0.0.1:45136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-10T22:19:16.461987Z","caller":"traceutil/trace.go:171","msg":"trace[656355945] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"434.501003ms","start":"2026-08-10T22:19:16.027464Z","end":"2026-08-10T22:19:16.461965Z","steps":["trace[656355945] 'process raft request' (duration: 434.451961ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:19:16.462137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:19:16.027453Z","time spent":"434.609846ms","remote":"127.0.0.1:45136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-10T22:19:16.46207Z","caller":"traceutil/trace.go:171","msg":"trace[1341658393] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"437.303954ms","start":"2026-08-10T22:19:16.024725Z","end":"2026-08-10T22:19:16.462029Z","steps":["trace[1341658393] 'process raft request' (duration: 437.048095ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:19:16.462681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:19:16.024705Z","time spent":"437.872063ms","remote":"127.0.0.1:45136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-10T22:20:24.26704Z","caller":"traceutil/trace.go:171","msg":"trace[254160597] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"154.192083ms","start":"2026-08-10T22:20:24.112811Z","end":"2026-08-10T22:20:24.267003Z","steps":["trace[254160597] 'process raft request' (duration: 153.987891ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:21:15.258967Z","caller":"traceutil/trace.go:171","msg":"trace[543991006] linearizableReadLoop","detail":"{readStateIndex:1977; appliedIndex:1976; }","duration":"195.405477ms","start":"2026-08-10T22:21:15.063541Z","end":"2026-08-10T22:21:15.258946Z","steps":["trace[543991006] 'read index received' (duration: 195.294395ms)","trace[543991006] 'applied index is now lower than readState.Index' (duration: 110.202µs)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:21:15.259178Z","caller":"traceutil/trace.go:171","msg":"trace[1540955790] transaction","detail":"{read_only:false; response_revision:1906; number_of_response:1; }","duration":"208.863855ms","start":"2026-08-10T22:21:15.050304Z","end":"2026-08-10T22:21:15.259168Z","steps":["trace[1540955790] 'process raft request' (duration: 208.450908ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:21:15.259333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.785143ms","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-08-10T22:21:15.259387Z","caller":"traceutil/trace.go:171","msg":"trace[554833523] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1906; }","duration":"195.875835ms","start":"2026-08-10T22:21:15.063499Z","end":"2026-08-10T22:21:15.259375Z","steps":["trace[554833523] 'agreement among raft nodes before linearized reading' (duration: 195.725553ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:21:15.366807Z","caller":"traceutil/trace.go:171","msg":"trace[1560442424] linearizableReadLoop","detail":"{readStateIndex:1978; appliedIndex:1977; }","duration":"107.647676ms","start":"2026-08-10T22:21:15.25914Z","end":"2026-08-10T22:21:15.366788Z","steps":["trace[1560442424] 'read index received' (duration: 96.430947ms)","trace[1560442424] 'applied index is now lower than readState.Index' (duration: 11.215619ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:21:15.367005Z","caller":"traceutil/trace.go:171","msg":"trace[105046210] transaction","detail":"{read_only:false; response_revision:1907; number_of_response:1; }","duration":"207.265517ms","start":"2026-08-10T22:21:15.159724Z","end":"2026-08-10T22:21:15.36699Z","steps":["trace[105046210] 'process raft request' (duration: 195.781943ms)","trace[105046210] 'compare' (duration: 10.972355ms)"],"step_count":2} {"level":"warn","ts":"2026-08-10T22:21:15.367329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.769777ms","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-10T22:21:15.367414Z","caller":"traceutil/trace.go:171","msg":"trace[753051017] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1907; }","duration":"267.918709ms","start":"2026-08-10T22:21:15.099476Z","end":"2026-08-10T22:21:15.367395Z","steps":["trace[753051017] 'agreement among raft nodes before linearized reading' (duration: 267.561633ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:21:15.409138Z","caller":"traceutil/trace.go:171","msg":"trace[1497935678] transaction","detail":"{read_only:false; response_revision:1908; number_of_response:1; }","duration":"145.747959ms","start":"2026-08-10T22:21:15.263366Z","end":"2026-08-10T22:21:15.409114Z","steps":["trace[1497935678] 'process raft request' (duration: 145.592967ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:21:15.409909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.706638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.35\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-08-10T22:21:15.410085Z","caller":"traceutil/trace.go:171","msg":"trace[271194906] range","detail":"{range_begin:/registry/masterleases/199.19.213.35; range_end:; response_count:1; response_revision:1908; }","duration":"123.938832ms","start":"2026-08-10T22:21:15.286132Z","end":"2026-08-10T22:21:15.41007Z","steps":["trace[271194906] 'agreement among raft nodes before linearized reading' (duration: 123.627957ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:21:15.40993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.393819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6d50ef2b-2d91-42a3-9bdf-8661dfb1f153\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-08-10T22:21:15.410311Z","caller":"traceutil/trace.go:171","msg":"trace[1603349246] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6d50ef2b-2d91-42a3-9bdf-8661dfb1f153; range_end:; response_count:1; response_revision:1908; }","duration":"108.796736ms","start":"2026-08-10T22:21:15.301487Z","end":"2026-08-10T22:21:15.410284Z","steps":["trace[1603349246] 'agreement among raft nodes before linearized reading' (duration: 108.307278ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:21:15.409941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.127768ms","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-10T22:21:15.410612Z","caller":"traceutil/trace.go:171","msg":"trace[1216299135] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1908; }","duration":"123.733537ms","start":"2026-08-10T22:21:15.286773Z","end":"2026-08-10T22:21:15.410506Z","steps":["trace[1216299135] 'agreement among raft nodes before linearized reading' (duration: 123.066896ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:21:23.823818Z","caller":"traceutil/trace.go:171","msg":"trace[1574526223] transaction","detail":"{read_only:false; response_revision:1986; number_of_response:1; }","duration":"114.146207ms","start":"2026-08-10T22:21:23.709655Z","end":"2026-08-10T22:21:23.823801Z","steps":["trace[1574526223] 'process raft request' (duration: 106.123434ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:21:28.128654Z","caller":"traceutil/trace.go:171","msg":"trace[231741121] transaction","detail":"{read_only:false; response_revision:2011; number_of_response:1; }","duration":"293.822552ms","start":"2026-08-10T22:21:27.834806Z","end":"2026-08-10T22:21:28.128628Z","steps":["trace[231741121] 'process raft request' (duration: 293.494936ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:21:49.84475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.938716ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-10T22:21:49.844892Z","caller":"traceutil/trace.go:171","msg":"trace[421197026] linearizableReadLoop","detail":"{readStateIndex:2230; appliedIndex:2229; }","duration":"139.458576ms","start":"2026-08-10T22:21:49.705416Z","end":"2026-08-10T22:21:49.844875Z","steps":["trace[421197026] 'read index received' (duration: 35.290766ms)","trace[421197026] 'applied index is now lower than readState.Index' (duration: 104.16648ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:21:49.844933Z","caller":"traceutil/trace.go:171","msg":"trace[1359972162] transaction","detail":"{read_only:false; response_revision:2150; number_of_response:1; }","duration":"156.559742ms","start":"2026-08-10T22:21:49.688341Z","end":"2026-08-10T22:21:49.844901Z","steps":["trace[1359972162] 'process raft request' (duration: 52.355751ms)","trace[1359972162] 'compare' (duration: 103.753552ms)"],"step_count":2} {"level":"warn","ts":"2026-08-10T22:21:49.845019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.589768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-10T22:21:49.845071Z","caller":"traceutil/trace.go:171","msg":"trace[446670148] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:2150; }","duration":"139.638829ms","start":"2026-08-10T22:21:49.705411Z","end":"2026-08-10T22:21:49.84505Z","steps":["trace[446670148] 'agreement among raft nodes before linearized reading' (duration: 139.559028ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:21:49.845176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.444226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-10T22:21:49.845288Z","caller":"traceutil/trace.go:171","msg":"trace[1112801019] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2150; }","duration":"106.61336ms","start":"2026-08-10T22:21:49.738655Z","end":"2026-08-10T22:21:49.845269Z","steps":["trace[1112801019] 'agreement among raft nodes before linearized reading' (duration: 106.380965ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:21:50.564264Z","caller":"traceutil/trace.go:171","msg":"trace[1658300092] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"177.676856ms","start":"2026-08-10T22:21:50.386552Z","end":"2026-08-10T22:21:50.564229Z","steps":["trace[1658300092] 'process raft request' (duration: 78.035518ms)","trace[1658300092] 'compare' (duration: 98.919053ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:21:51.655754Z","caller":"traceutil/trace.go:171","msg":"trace[544823431] transaction","detail":"{read_only:false; response_revision:2157; number_of_response:1; }","duration":"196.307912ms","start":"2026-08-10T22:21:51.459425Z","end":"2026-08-10T22:21:51.655733Z","steps":["trace[544823431] 'process raft request' (duration: 195.72407ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:23:43.157043Z","caller":"traceutil/trace.go:171","msg":"trace[646298812] transaction","detail":"{read_only:false; response_revision:2845; number_of_response:1; }","duration":"215.457945ms","start":"2026-08-10T22:23:42.941493Z","end":"2026-08-10T22:23:43.156951Z","steps":["trace[646298812] 'process raft request' (duration: 215.330911ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:23:43.158471Z","caller":"traceutil/trace.go:171","msg":"trace[517298452] transaction","detail":"{read_only:false; response_revision:2846; number_of_response:1; }","duration":"135.454872ms","start":"2026-08-10T22:23:43.023007Z","end":"2026-08-10T22:23:43.158462Z","steps":["trace[517298452] 'process raft request' (duration: 135.407841ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:24:17.376395Z","caller":"traceutil/trace.go:171","msg":"trace[1398721571] transaction","detail":"{read_only:false; response_revision:3038; number_of_response:1; }","duration":"102.287982ms","start":"2026-08-10T22:24:17.274062Z","end":"2026-08-10T22:24:17.37635Z","steps":["trace[1398721571] 'process raft request' (duration: 102.188409ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:24:17.641285Z","caller":"traceutil/trace.go:171","msg":"trace[2147262023] transaction","detail":"{read_only:false; response_revision:3039; number_of_response:1; }","duration":"130.809935ms","start":"2026-08-10T22:24:17.510428Z","end":"2026-08-10T22:24:17.641238Z","steps":["trace[2147262023] 'process raft request' (duration: 130.60942ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:28:26.006973Z","caller":"traceutil/trace.go:171","msg":"trace[1978979749] transaction","detail":"{read_only:false; response_revision:5037; number_of_response:1; }","duration":"106.703831ms","start":"2026-08-10T22:28:25.900254Z","end":"2026-08-10T22:28:26.006958Z","steps":["trace[1978979749] 'process raft request' (duration: 106.611969ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:28:32.244464Z","caller":"traceutil/trace.go:171","msg":"trace[134167764] transaction","detail":"{read_only:false; response_revision:5143; number_of_response:1; }","duration":"393.344516ms","start":"2026-08-10T22:28:31.851098Z","end":"2026-08-10T22:28:32.244443Z","steps":["trace[134167764] 'process raft request' (duration: 393.16466ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:28:32.244681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:28:31.851084Z","time spent":"393.48365ms","remote":"127.0.0.1:45136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-10T22:28:32.351124Z","caller":"traceutil/trace.go:171","msg":"trace[30806623] linearizableReadLoop","detail":"{readStateIndex:5336; appliedIndex:5334; }","duration":"472.466649ms","start":"2026-08-10T22:28:31.878629Z","end":"2026-08-10T22:28:32.351095Z","steps":["trace[30806623] 'read index received' (duration: 365.732453ms)","trace[30806623] 'applied index is now lower than readState.Index' (duration: 106.733136ms)"],"step_count":2} {"level":"warn","ts":"2026-08-10T22:28:32.351323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.683335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-08-10T22:28:32.351361Z","caller":"traceutil/trace.go:171","msg":"trace[1803148330] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:5144; }","duration":"472.82331ms","start":"2026-08-10T22:28:31.878524Z","end":"2026-08-10T22:28:32.351347Z","steps":["trace[1803148330] 'agreement among raft nodes before linearized reading' (duration: 472.670385ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:28:32.351356Z","caller":"traceutil/trace.go:171","msg":"trace[1555106789] transaction","detail":"{read_only:false; response_revision:5144; number_of_response:1; }","duration":"499.050399ms","start":"2026-08-10T22:28:31.852267Z","end":"2026-08-10T22:28:32.351317Z","steps":["trace[1555106789] 'process raft request' (duration: 470.827047ms)","trace[1555106789] 'compare' (duration: 27.85131ms)"],"step_count":2} {"level":"warn","ts":"2026-08-10T22:28:32.351414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:28:31.878504Z","time spent":"472.900131ms","remote":"127.0.0.1:44972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":1845,"request content":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" "} {"level":"warn","ts":"2026-08-10T22:28:32.351507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:28:31.852249Z","time spent":"499.183793ms","remote":"127.0.0.1:45136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-10T22:28:32.374245Z","caller":"traceutil/trace.go:171","msg":"trace[755191946] transaction","detail":"{read_only:false; response_revision:5145; number_of_response:1; }","duration":"108.999946ms","start":"2026-08-10T22:28:32.265219Z","end":"2026-08-10T22:28:32.374219Z","steps":["trace[755191946] 'process raft request' (duration: 108.823141ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:28:32.496729Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2741} {"level":"warn","ts":"2026-08-10T22:28:32.74928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.373108ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-10T22:28:32.749512Z","caller":"traceutil/trace.go:171","msg":"trace[1178690941] transaction","detail":"{read_only:false; response_revision:5149; number_of_response:1; }","duration":"246.370407ms","start":"2026-08-10T22:28:32.503104Z","end":"2026-08-10T22:28:32.749475Z","steps":["trace[1178690941] 'process raft request' (duration: 10.70602ms)","trace[1178690941] 'compare' (duration: 215.494015ms)","trace[1178690941] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/events/monitoring/kube-prometheus-stack-grafana-65f89944dd-kwpzg.18ca922a08ddf468; req_size:880; } (duration: 19.664057ms)"],"step_count":3} {"level":"info","ts":"2026-08-10T22:28:32.749558Z","caller":"traceutil/trace.go:171","msg":"trace[725294371] transaction","detail":"{read_only:false; response_revision:5151; number_of_response:1; }","duration":"175.677825ms","start":"2026-08-10T22:28:32.573864Z","end":"2026-08-10T22:28:32.749542Z","steps":["trace[725294371] 'process raft request' (duration: 175.633524ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:28:32.749704Z","caller":"traceutil/trace.go:171","msg":"trace[1135345661] transaction","detail":"{read_only:false; response_revision:5150; number_of_response:1; }","duration":"237.456032ms","start":"2026-08-10T22:28:32.512216Z","end":"2026-08-10T22:28:32.749672Z","steps":["trace[1135345661] 'process raft request' (duration: 237.196824ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:28:32.749877Z","caller":"traceutil/trace.go:171","msg":"trace[1375627363] linearizableReadLoop","detail":"{readStateIndex:5343; appliedIndex:5341; }","duration":"209.689275ms","start":"2026-08-10T22:28:32.540174Z","end":"2026-08-10T22:28:32.749863Z","steps":["trace[1375627363] 'read index received' (duration: 84.418807ms)","trace[1375627363] 'applied index is now lower than readState.Index' (duration: 125.268708ms)"],"step_count":2} {"level":"warn","ts":"2026-08-10T22:28:32.750215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.046146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-08-10T22:28:32.75026Z","caller":"traceutil/trace.go:171","msg":"trace[1018742235] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5151; }","duration":"210.092728ms","start":"2026-08-10T22:28:32.540154Z","end":"2026-08-10T22:28:32.750247Z","steps":["trace[1018742235] 'agreement among raft nodes before linearized reading' (duration: 209.952193ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:28:32.750557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.554432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-10T22:28:32.750606Z","caller":"traceutil/trace.go:171","msg":"trace[994707103] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5151; }","duration":"143.621274ms","start":"2026-08-10T22:28:32.606972Z","end":"2026-08-10T22:28:32.750593Z","steps":["trace[994707103] 'agreement among raft nodes before linearized reading' (duration: 143.553372ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:28:32.75312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.932934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6a83070b-3b98-448d-8b1c-dd647192cd0e\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-08-10T22:28:32.753183Z","caller":"traceutil/trace.go:171","msg":"trace[1478333139] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6a83070b-3b98-448d-8b1c-dd647192cd0e; range_end:; response_count:1; response_revision:5151; }","duration":"155.025987ms","start":"2026-08-10T22:28:32.598141Z","end":"2026-08-10T22:28:32.753167Z","steps":["trace[1478333139] 'agreement among raft nodes before linearized reading' (duration: 152.065365ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:28:32.909014Z","caller":"traceutil/trace.go:171","msg":"trace[1226027434] transaction","detail":"{read_only:false; response_revision:5152; number_of_response:1; }","duration":"149.046983ms","start":"2026-08-10T22:28:32.75869Z","end":"2026-08-10T22:28:32.907737Z","steps":["trace[1226027434] 'process raft request' (duration: 71.575001ms)","trace[1226027434] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/services/endpoints/monitoring/kube-prometheus-stack-alertmanager; req_size:1279; } (duration: 71.439885ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:28:33.004057Z","caller":"traceutil/trace.go:171","msg":"trace[1004733451] linearizableReadLoop","detail":"{readStateIndex:5348; appliedIndex:5344; }","duration":"227.480014ms","start":"2026-08-10T22:28:32.776552Z","end":"2026-08-10T22:28:33.004032Z","steps":["trace[1004733451] 'read index received' (duration: 53.736099ms)","trace[1004733451] 'applied index is now lower than readState.Index' (duration: 173.742485ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:28:33.004243Z","caller":"traceutil/trace.go:171","msg":"trace[1360859016] transaction","detail":"{read_only:false; response_revision:5154; number_of_response:1; }","duration":"244.354465ms","start":"2026-08-10T22:28:32.759876Z","end":"2026-08-10T22:28:33.00423Z","steps":["trace[1360859016] 'process raft request' (duration: 244.018795ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:28:33.004439Z","caller":"traceutil/trace.go:171","msg":"trace[234114837] transaction","detail":"{read_only:false; response_revision:5155; number_of_response:1; }","duration":"244.004144ms","start":"2026-08-10T22:28:32.760425Z","end":"2026-08-10T22:28:33.004429Z","steps":["trace[234114837] 'process raft request' (duration: 243.555181ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:28:33.004572Z","caller":"traceutil/trace.go:171","msg":"trace[1705522726] transaction","detail":"{read_only:false; response_revision:5153; number_of_response:1; }","duration":"245.320865ms","start":"2026-08-10T22:28:32.7592Z","end":"2026-08-10T22:28:33.004521Z","steps":["trace[1705522726] 'process raft request' (duration: 224.507893ms)","trace[1705522726] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/services/endpoints/monitoring/alertmanager-operated; req_size:902; } (duration: 20.002588ms)"],"step_count":2} {"level":"warn","ts":"2026-08-10T22:28:33.004689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.126734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-08-10T22:28:33.004719Z","caller":"traceutil/trace.go:171","msg":"trace[1137969686] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:5155; }","duration":"228.201126ms","start":"2026-08-10T22:28:32.77651Z","end":"2026-08-10T22:28:33.004711Z","steps":["trace[1137969686] 'agreement among raft nodes before linearized reading' (duration: 228.024971ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:28:33.005887Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2741,"took":"506.315224ms","hash":960887450,"current-db-size-bytes":52146176,"current-db-size":"52 MB","current-db-size-in-use-bytes":26992640,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-08-10T22:28:33.006691Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":960887450,"revision":2741,"compact-revision":-1} {"level":"warn","ts":"2026-08-10T22:28:45.917495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.26086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-08-10T22:28:45.917599Z","caller":"traceutil/trace.go:171","msg":"trace[51773240] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5312; }","duration":"197.418003ms","start":"2026-08-10T22:28:45.720159Z","end":"2026-08-10T22:28:45.917577Z","steps":["trace[51773240] 'range keys from in-memory index tree' (duration: 197.12302ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:28:45.918048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.68388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-08-10T22:28:45.918115Z","caller":"traceutil/trace.go:171","msg":"trace[1642789702] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5312; }","duration":"221.808741ms","start":"2026-08-10T22:28:45.69629Z","end":"2026-08-10T22:28:45.918099Z","steps":["trace[1642789702] 'range keys from in-memory index tree' (duration: 221.489287ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:28:46.027002Z","caller":"traceutil/trace.go:171","msg":"trace[216536616] transaction","detail":"{read_only:false; response_revision:5314; number_of_response:1; }","duration":"103.529531ms","start":"2026-08-10T22:28:45.923434Z","end":"2026-08-10T22:28:46.026963Z","steps":["trace[216536616] 'process raft request' (duration: 102.098336ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:28:46.224714Z","caller":"traceutil/trace.go:171","msg":"trace[1668932803] transaction","detail":"{read_only:false; response_revision:5317; number_of_response:1; }","duration":"187.689289ms","start":"2026-08-10T22:28:46.036979Z","end":"2026-08-10T22:28:46.224668Z","steps":["trace[1668932803] 'process raft request' (duration: 103.725118ms)","trace[1668932803] 'compare' (duration: 83.733409ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:28:46.243681Z","caller":"traceutil/trace.go:171","msg":"trace[355464693] linearizableReadLoop","detail":"{readStateIndex:5518; appliedIndex:5515; }","duration":"168.69208ms","start":"2026-08-10T22:28:46.074965Z","end":"2026-08-10T22:28:46.243657Z","steps":["trace[355464693] 'read index received' (duration: 65.749021ms)","trace[355464693] 'applied index is now lower than readState.Index' (duration: 102.941769ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:28:46.243796Z","caller":"traceutil/trace.go:171","msg":"trace[292736900] transaction","detail":"{read_only:false; response_revision:5318; number_of_response:1; }","duration":"206.761528ms","start":"2026-08-10T22:28:46.037015Z","end":"2026-08-10T22:28:46.243777Z","steps":["trace[292736900] 'process raft request' (duration: 206.427884ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:28:46.244037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.068154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-10T22:28:46.244069Z","caller":"traceutil/trace.go:171","msg":"trace[404027422] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:5319; }","duration":"169.172475ms","start":"2026-08-10T22:28:46.07489Z","end":"2026-08-10T22:28:46.244062Z","steps":["trace[404027422] 'agreement among raft nodes before linearized reading' (duration: 169.106885ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:28:46.244185Z","caller":"traceutil/trace.go:171","msg":"trace[403083335] transaction","detail":"{read_only:false; response_revision:5319; number_of_response:1; }","duration":"201.865399ms","start":"2026-08-10T22:28:46.042309Z","end":"2026-08-10T22:28:46.244174Z","steps":["trace[403083335] 'process raft request' (duration: 201.282524ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:28:46.462852Z","caller":"traceutil/trace.go:171","msg":"trace[1147106552] transaction","detail":"{read_only:false; response_revision:5320; number_of_response:1; }","duration":"204.312594ms","start":"2026-08-10T22:28:46.258496Z","end":"2026-08-10T22:28:46.462808Z","steps":["trace[1147106552] 'process raft request' (duration: 105.147353ms)","trace[1147106552] 'compare' (duration: 98.947079ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:28:46.463071Z","caller":"traceutil/trace.go:171","msg":"trace[2012367806] linearizableReadLoop","detail":"{readStateIndex:5520; appliedIndex:5518; }","duration":"142.33506ms","start":"2026-08-10T22:28:46.320711Z","end":"2026-08-10T22:28:46.463046Z","steps":["trace[2012367806] 'read index received' (duration: 42.902895ms)","trace[2012367806] 'applied index is now lower than readState.Index' (duration: 99.431115ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:28:46.463199Z","caller":"traceutil/trace.go:171","msg":"trace[396356302] transaction","detail":"{read_only:false; response_revision:5321; number_of_response:1; }","duration":"158.138197ms","start":"2026-08-10T22:28:46.305049Z","end":"2026-08-10T22:28:46.463187Z","steps":["trace[396356302] 'process raft request' (duration: 157.709783ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:28:46.464193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.464622ms","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-08-10T22:28:46.464293Z","caller":"traceutil/trace.go:171","msg":"trace[404659996] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5321; }","duration":"143.633443ms","start":"2026-08-10T22:28:46.320637Z","end":"2026-08-10T22:28:46.46427Z","steps":["trace[404659996] 'agreement among raft nodes before linearized reading' (duration: 142.646583ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:33:32.506013Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5147} {"level":"info","ts":"2026-08-10T22:33:32.588382Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5147,"took":"80.663822ms","hash":1915784510,"current-db-size-bytes":52146176,"current-db-size":"52 MB","current-db-size-in-use-bytes":19808256,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-08-10T22:33:32.588695Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1915784510,"revision":5147,"compact-revision":2741}