{"level":"warn","ts":"2026-08-22T10:33:27.734377Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-22T10:33:27.734479Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.126: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.126:2380","--initial-cluster=instance=https://199.19.213.126:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.126:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.126:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-08-22T10:33:27.734554Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-22T10:33:27.734571Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.126:2380"]} {"level":"info","ts":"2026-08-22T10:33:27.734592Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-22T10:33:27.735372Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.126:2379"]} {"level":"info","ts":"2026-08-22T10:33:27.73546Z","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.126:2380"],"listen-peer-urls":["https://199.19.213.126:2380"],"advertise-client-urls":["https://199.19.213.126:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.126:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.126:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-08-22T10:33:27.740662Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.946488ms"} {"level":"info","ts":"2026-08-22T10:33:27.752281Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e241c9714ab70808","cluster-id":"e3245fbcce84a6b1"} {"level":"info","ts":"2026-08-22T10:33:27.752387Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e241c9714ab70808 switched to configuration voters=()"} {"level":"info","ts":"2026-08-22T10:33:27.75241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e241c9714ab70808 became follower at term 0"} {"level":"info","ts":"2026-08-22T10:33:27.752417Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e241c9714ab70808 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-22T10:33:27.752425Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e241c9714ab70808 became follower at term 1"} {"level":"info","ts":"2026-08-22T10:33:27.752462Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e241c9714ab70808 switched to configuration voters=(16303533614479902728)"} {"level":"warn","ts":"2026-08-22T10:33:27.765449Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-22T10:33:27.767015Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-22T10:33:27.769799Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-08-22T10:33:27.771962Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e241c9714ab70808","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-22T10:33:27.774325Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e241c9714ab70808","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-22T10:33:27.7743Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-22T10:33:27.774803Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-22T10:33:27.774824Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-22T10:33:27.77663Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e241c9714ab70808 switched to configuration voters=(16303533614479902728)"} {"level":"info","ts":"2026-08-22T10:33:27.776756Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e3245fbcce84a6b1","local-member-id":"e241c9714ab70808","added-peer-id":"e241c9714ab70808","added-peer-peer-urls":["https://199.19.213.126:2380"]} {"level":"info","ts":"2026-08-22T10:33:27.779345Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-22T10:33:27.779509Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.126:2380"} {"level":"info","ts":"2026-08-22T10:33:27.779551Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.126:2380"} {"level":"info","ts":"2026-08-22T10:33:27.779622Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e241c9714ab70808","initial-advertise-peer-urls":["https://199.19.213.126:2380"],"listen-peer-urls":["https://199.19.213.126:2380"],"advertise-client-urls":["https://199.19.213.126:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.126:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-22T10:33:27.77967Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-22T10:33:28.652938Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e241c9714ab70808 is starting a new election at term 1"} {"level":"info","ts":"2026-08-22T10:33:28.653028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e241c9714ab70808 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-22T10:33:28.653088Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e241c9714ab70808 received MsgPreVoteResp from e241c9714ab70808 at term 1"} {"level":"info","ts":"2026-08-22T10:33:28.653295Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e241c9714ab70808 became candidate at term 2"} {"level":"info","ts":"2026-08-22T10:33:28.65332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e241c9714ab70808 received MsgVoteResp from e241c9714ab70808 at term 2"} {"level":"info","ts":"2026-08-22T10:33:28.653339Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e241c9714ab70808 became leader at term 2"} {"level":"info","ts":"2026-08-22T10:33:28.653399Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e241c9714ab70808 elected leader e241c9714ab70808 at term 2"} {"level":"info","ts":"2026-08-22T10:33:28.657135Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T10:33:28.658294Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-22T10:33:28.658306Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e241c9714ab70808","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.126:2379]}","request-path":"/0/members/e241c9714ab70808/attributes","cluster-id":"e3245fbcce84a6b1","publish-timeout":"7s"} {"level":"info","ts":"2026-08-22T10:33:28.658828Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-22T10:33:28.659318Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-22T10:33:28.659348Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-22T10:33:28.660901Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.126:2379"} {"level":"info","ts":"2026-08-22T10:33:28.6623Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e3245fbcce84a6b1","local-member-id":"e241c9714ab70808","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T10:33:28.662352Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-22T10:33:28.662407Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T10:33:28.662444Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-08-22T10:33:33.100158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.088868ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:42"} {"level":"info","ts":"2026-08-22T10:33:33.100458Z","caller":"traceutil/trace.go:171","msg":"trace[184978361] linearizableReadLoop","detail":"{readStateIndex:217; appliedIndex:215; }","duration":"134.074973ms","start":"2026-08-22T10:33:32.966365Z","end":"2026-08-22T10:33:33.10044Z","steps":["trace[184978361] 'read index received' (duration: 27.457726ms)","trace[184978361] 'applied index is now lower than readState.Index' (duration: 106.616377ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:33:33.100574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.202905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslicemirroring-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:33:33.100606Z","caller":"traceutil/trace.go:171","msg":"trace[1109660645] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslicemirroring-controller; range_end:; response_count:0; response_revision:211; }","duration":"134.276796ms","start":"2026-08-22T10:33:32.966319Z","end":"2026-08-22T10:33:33.100596Z","steps":["trace[1109660645] 'agreement among raft nodes before linearized reading' (duration: 134.191255ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:33:33.10075Z","caller":"traceutil/trace.go:171","msg":"trace[280748093] transaction","detail":"{read_only:false; response_revision:211; number_of_response:1; }","duration":"142.242624ms","start":"2026-08-22T10:33:32.958476Z","end":"2026-08-22T10:33:33.100718Z","steps":["trace[280748093] 'process raft request' (duration: 141.829367ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:33:33.250807Z","caller":"traceutil/trace.go:171","msg":"trace[949074273] linearizableReadLoop","detail":"{readStateIndex:218; appliedIndex:217; }","duration":"146.753818ms","start":"2026-08-22T10:33:33.104024Z","end":"2026-08-22T10:33:33.250778Z","steps":["trace[949074273] 'read index received' (duration: 139.263348ms)","trace[949074273] 'applied index is now lower than readState.Index' (duration: 7.48928ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:33:33.250888Z","caller":"traceutil/trace.go:171","msg":"trace[377210189] transaction","detail":"{read_only:false; response_revision:212; number_of_response:1; }","duration":"149.074217ms","start":"2026-08-22T10:33:33.101742Z","end":"2026-08-22T10:33:33.250816Z","steps":["trace[377210189] 'process raft request' (duration: 141.68412ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:33:33.251111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.066263ms","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-22T10:33:33.251181Z","caller":"traceutil/trace.go:171","msg":"trace[121330831] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:212; }","duration":"147.191495ms","start":"2026-08-22T10:33:33.103973Z","end":"2026-08-22T10:33:33.251165Z","steps":["trace[121330831] 'agreement among raft nodes before linearized reading' (duration: 146.909561ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:33:41.191489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.592288ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T10:33:41.191668Z","caller":"traceutil/trace.go:171","msg":"trace[1236899464] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"214.961628ms","start":"2026-08-22T10:33:40.976663Z","end":"2026-08-22T10:33:41.191625Z","steps":["trace[1236899464] 'process raft request' (duration: 66.678289ms)","trace[1236899464] 'compare' (duration: 147.445416ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:33:42.183508Z","caller":"traceutil/trace.go:171","msg":"trace[1784525701] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"110.762482ms","start":"2026-08-22T10:33:42.072719Z","end":"2026-08-22T10:33:42.183481Z","steps":["trace[1784525701] 'process raft request' (duration: 110.608829ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:33:51.787882Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":578888650211183479,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-22T10:33:52.288821Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":578888650211183479,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-22T10:33:52.294398Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.052428422s","expected-duration":"1s"} {"level":"info","ts":"2026-08-22T10:33:52.294835Z","caller":"traceutil/trace.go:171","msg":"trace[369424689] linearizableReadLoop","detail":"{readStateIndex:397; appliedIndex:396; }","duration":"1.00739955s","start":"2026-08-22T10:33:51.287404Z","end":"2026-08-22T10:33:52.294803Z","steps":["trace[369424689] 'read index received' (duration: 1.007194937s)","trace[369424689] 'applied index is now lower than readState.Index' (duration: 203.323µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:33:52.294903Z","caller":"traceutil/trace.go:171","msg":"trace[1711214080] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"1.053086853s","start":"2026-08-22T10:33:51.241783Z","end":"2026-08-22T10:33:52.29487Z","steps":["trace[1711214080] 'process raft request' (duration: 1.05288289s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:33:52.294992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.007574342s","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-22T10:33:52.295055Z","caller":"traceutil/trace.go:171","msg":"trace[628294455] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:386; }","duration":"1.007719754s","start":"2026-08-22T10:33:51.287317Z","end":"2026-08-22T10:33:52.295037Z","steps":["trace[628294455] 'agreement among raft nodes before linearized reading' (duration: 1.007592882s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:33:52.295121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:33:51.28727Z","time spent":"1.007822936s","remote":"127.0.0.1:60612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-22T10:33:52.295234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.269697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.126\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-22T10:33:52.295317Z","caller":"traceutil/trace.go:171","msg":"trace[1395990533] range","detail":"{range_begin:/registry/masterleases/199.19.213.126; range_end:; response_count:1; response_revision:386; }","duration":"503.375609ms","start":"2026-08-22T10:33:51.791921Z","end":"2026-08-22T10:33:52.295296Z","steps":["trace[1395990533] 'agreement among raft nodes before linearized reading' (duration: 503.202907ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:33:52.295074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:33:51.241766Z","time spent":"1.053186654s","remote":"127.0.0.1:60612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T10:33:52.295362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:33:51.791905Z","time spent":"503.44477ms","remote":"127.0.0.1:60364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.19.213.126\" "} {"level":"warn","ts":"2026-08-22T10:33:52.295497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.610512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:33:52.295661Z","caller":"traceutil/trace.go:171","msg":"trace[956313615] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:386; }","duration":"535.808624ms","start":"2026-08-22T10:33:51.759823Z","end":"2026-08-22T10:33:52.295631Z","steps":["trace[956313615] 'agreement among raft nodes before linearized reading' (duration: 535.267536ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:33:52.295726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:33:51.759806Z","time spent":"535.902927ms","remote":"127.0.0.1:60318","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-22T10:33:58.479869Z","caller":"traceutil/trace.go:171","msg":"trace[132001009] transaction","detail":"{read_only:false; response_revision:433; number_of_response:1; }","duration":"113.89241ms","start":"2026-08-22T10:33:58.365953Z","end":"2026-08-22T10:33:58.479845Z","steps":["trace[132001009] 'process raft request' (duration: 113.84495ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:33:58.479948Z","caller":"traceutil/trace.go:171","msg":"trace[1512086447] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"114.025362ms","start":"2026-08-22T10:33:58.365885Z","end":"2026-08-22T10:33:58.47991Z","steps":["trace[1512086447] 'process raft request' (duration: 113.628736ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:34:06.470271Z","caller":"traceutil/trace.go:171","msg":"trace[976865762] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"105.332275ms","start":"2026-08-22T10:34:06.364916Z","end":"2026-08-22T10:34:06.470249Z","steps":["trace[976865762] 'process raft request' (duration: 104.99426ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:34:07.503996Z","caller":"traceutil/trace.go:171","msg":"trace[1201089371] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"508.992543ms","start":"2026-08-22T10:34:06.994973Z","end":"2026-08-22T10:34:07.503966Z","steps":["trace[1201089371] 'process raft request' (duration: 508.868322ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:34:07.504188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:34:06.994953Z","time spent":"509.153515ms","remote":"127.0.0.1:60386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-22T10:34:07.513732Z","caller":"traceutil/trace.go:171","msg":"trace[2024768388] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"510.465195ms","start":"2026-08-22T10:34:07.00324Z","end":"2026-08-22T10:34:07.513706Z","steps":["trace[2024768388] 'process raft request' (duration: 510.220541ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:34:07.513782Z","caller":"traceutil/trace.go:171","msg":"trace[314104498] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"510.20224ms","start":"2026-08-22T10:34:07.003551Z","end":"2026-08-22T10:34:07.513753Z","steps":["trace[314104498] 'process raft request' (duration: 510.063238ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:34:07.513875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:34:07.00322Z","time spent":"510.588587ms","remote":"127.0.0.1:60386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-22T10:34:07.513916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:34:07.003529Z","time spent":"510.312192ms","remote":"127.0.0.1:60386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-22T10:34:07.51401Z","caller":"traceutil/trace.go:171","msg":"trace[2044724156] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"504.326345ms","start":"2026-08-22T10:34:07.00967Z","end":"2026-08-22T10:34:07.513996Z","steps":["trace[2044724156] 'process raft request' (duration: 504.066221ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:34:07.514045Z","caller":"traceutil/trace.go:171","msg":"trace[623772108] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"506.609298ms","start":"2026-08-22T10:34:07.007426Z","end":"2026-08-22T10:34:07.514036Z","steps":["trace[623772108] 'process raft request' (duration: 506.272664ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:34:07.514047Z","caller":"traceutil/trace.go:171","msg":"trace[882011685] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"507.168026ms","start":"2026-08-22T10:34:07.00686Z","end":"2026-08-22T10:34:07.514029Z","steps":["trace[882011685] 'process raft request' (duration: 506.798291ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:34:07.514061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:34:07.009657Z","time spent":"504.380066ms","remote":"127.0.0.1:60386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-22T10:34:07.514084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:34:07.007416Z","time spent":"506.648999ms","remote":"127.0.0.1:60386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-22T10:34:07.514111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:34:07.006847Z","time spent":"507.229147ms","remote":"127.0.0.1:60386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-22T10:34:07.514231Z","caller":"traceutil/trace.go:171","msg":"trace[1840488250] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"502.639731ms","start":"2026-08-22T10:34:07.011582Z","end":"2026-08-22T10:34:07.514222Z","steps":["trace[1840488250] 'process raft request' (duration: 502.190075ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:34:07.514188Z","caller":"traceutil/trace.go:171","msg":"trace[252693793] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"500.48972ms","start":"2026-08-22T10:34:07.013678Z","end":"2026-08-22T10:34:07.514168Z","steps":["trace[252693793] 'process raft request' (duration: 500.148325ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:34:07.514257Z","caller":"traceutil/trace.go:171","msg":"trace[1533518157] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"489.058654ms","start":"2026-08-22T10:34:07.025191Z","end":"2026-08-22T10:34:07.51425Z","steps":["trace[1533518157] 'process raft request' (duration: 488.73554ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:34:07.514235Z","caller":"traceutil/trace.go:171","msg":"trace[1441228872] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"351.340754ms","start":"2026-08-22T10:34:07.162865Z","end":"2026-08-22T10:34:07.514205Z","steps":["trace[1441228872] 'process raft request' (duration: 351.276083ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:34:07.514291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:34:07.025178Z","time spent":"489.098745ms","remote":"127.0.0.1:60386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-22T10:34:07.514294Z","caller":"traceutil/trace.go:171","msg":"trace[75615111] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"494.137238ms","start":"2026-08-22T10:34:07.020149Z","end":"2026-08-22T10:34:07.514286Z","steps":["trace[75615111] 'process raft request' (duration: 493.723312ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:34:07.51431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:34:07.013665Z","time spent":"500.602422ms","remote":"127.0.0.1:60386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-22T10:34:07.514321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:34:07.020141Z","time spent":"494.169948ms","remote":"127.0.0.1:60386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-22T10:34:07.514346Z","caller":"traceutil/trace.go:171","msg":"trace[47965949] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"465.623873ms","start":"2026-08-22T10:34:07.048716Z","end":"2026-08-22T10:34:07.51434Z","steps":["trace[47965949] 'process raft request' (duration: 465.298948ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:34:07.514347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:34:07.162834Z","time spent":"351.460166ms","remote":"127.0.0.1:60386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-22T10:34:07.514372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:34:07.048699Z","time spent":"465.660744ms","remote":"127.0.0.1:60386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-22T10:34:07.514262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:34:07.01157Z","time spent":"502.676591ms","remote":"127.0.0.1:60386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-22T10:34:08.503073Z","caller":"traceutil/trace.go:171","msg":"trace[406309016] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"186.556199ms","start":"2026-08-22T10:34:08.316492Z","end":"2026-08-22T10:34:08.503048Z","steps":["trace[406309016] 'process raft request' (duration: 186.393366ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:34:08.514523Z","caller":"traceutil/trace.go:171","msg":"trace[1796531992] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"184.717582ms","start":"2026-08-22T10:34:08.329769Z","end":"2026-08-22T10:34:08.514487Z","steps":["trace[1796531992] 'process raft request' (duration: 184.423368ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:34:08.514851Z","caller":"traceutil/trace.go:171","msg":"trace[1200650520] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"103.342105ms","start":"2026-08-22T10:34:08.411489Z","end":"2026-08-22T10:34:08.514831Z","steps":["trace[1200650520] 'process raft request' (duration: 102.959269ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:34:10.758722Z","caller":"traceutil/trace.go:171","msg":"trace[163239241] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"151.036297ms","start":"2026-08-22T10:34:10.607655Z","end":"2026-08-22T10:34:10.758691Z","steps":["trace[163239241] 'process raft request' (duration: 76.187313ms)","trace[163239241] 'compare' (duration: 74.691882ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:34:10.820487Z","caller":"traceutil/trace.go:171","msg":"trace[1814312361] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"212.028832ms","start":"2026-08-22T10:34:10.608414Z","end":"2026-08-22T10:34:10.820443Z","steps":["trace[1814312361] 'process raft request' (duration: 211.810409ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:34:10.820658Z","caller":"traceutil/trace.go:171","msg":"trace[1290474391] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"151.550214ms","start":"2026-08-22T10:34:10.669095Z","end":"2026-08-22T10:34:10.820646Z","steps":["trace[1290474391] 'process raft request' (duration: 151.363062ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:34:10.820669Z","caller":"traceutil/trace.go:171","msg":"trace[497395892] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"210.560151ms","start":"2026-08-22T10:34:10.610032Z","end":"2026-08-22T10:34:10.820592Z","steps":["trace[497395892] 'process raft request' (duration: 210.251237ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:34:11.583394Z","caller":"traceutil/trace.go:171","msg":"trace[888770854] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"288.332911ms","start":"2026-08-22T10:34:11.295037Z","end":"2026-08-22T10:34:11.58337Z","steps":["trace[888770854] 'process raft request' (duration: 287.874114ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:34:13.962892Z","caller":"traceutil/trace.go:171","msg":"trace[64188207] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:608; }","duration":"202.742215ms","start":"2026-08-22T10:34:13.760125Z","end":"2026-08-22T10:34:13.962867Z","steps":["trace[64188207] 'read index received' (duration: 201.960534ms)","trace[64188207] 'applied index is now lower than readState.Index' (duration: 780.751µs)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:34:13.96301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.870568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:34:13.963042Z","caller":"traceutil/trace.go:171","msg":"trace[1256170422] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:589; }","duration":"202.978688ms","start":"2026-08-22T10:34:13.760051Z","end":"2026-08-22T10:34:13.96303Z","steps":["trace[1256170422] 'agreement among raft nodes before linearized reading' (duration: 202.908877ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:34:13.963024Z","caller":"traceutil/trace.go:171","msg":"trace[21936049] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"302.147385ms","start":"2026-08-22T10:34:13.660833Z","end":"2026-08-22T10:34:13.96298Z","steps":["trace[21936049] 'process raft request' (duration: 301.517206ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:34:13.963257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:34:13.660807Z","time spent":"302.348428ms","remote":"127.0.0.1:60424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036257,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T10:34:14.749726Z","caller":"traceutil/trace.go:171","msg":"trace[917222121] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"288.432254ms","start":"2026-08-22T10:34:14.461269Z","end":"2026-08-22T10:34:14.749701Z","steps":["trace[917222121] 'process raft request' (duration: 287.900106ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:34:14.755041Z","caller":"traceutil/trace.go:171","msg":"trace[637477724] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:613; }","duration":"147.793929ms","start":"2026-08-22T10:34:14.607216Z","end":"2026-08-22T10:34:14.75501Z","steps":["trace[637477724] 'read index received' (duration: 141.828013ms)","trace[637477724] 'applied index is now lower than readState.Index' (duration: 5.964916ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:34:14.755358Z","caller":"traceutil/trace.go:171","msg":"trace[1416974270] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"228.54786ms","start":"2026-08-22T10:34:14.526773Z","end":"2026-08-22T10:34:14.75532Z","steps":["trace[1416974270] 'process raft request' (duration: 228.123904ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:34:14.755371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.131833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-22T10:34:14.755538Z","caller":"traceutil/trace.go:171","msg":"trace[339598993] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:595; }","duration":"148.320365ms","start":"2026-08-22T10:34:14.607172Z","end":"2026-08-22T10:34:14.755493Z","steps":["trace[339598993] 'agreement among raft nodes before linearized reading' (duration: 148.001901ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:34:14.887198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.282729ms","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-22T10:34:14.887292Z","caller":"traceutil/trace.go:171","msg":"trace[1706457176] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:597; }","duration":"103.407221ms","start":"2026-08-22T10:34:14.783865Z","end":"2026-08-22T10:34:14.887272Z","steps":["trace[1706457176] 'agreement among raft nodes before linearized reading' (duration: 103.180928ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:34:16.260226Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":578888650211183900,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-22T10:34:16.508924Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.190212144s","expected-duration":"1s"} {"level":"warn","ts":"2026-08-22T10:34:16.518236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.50901046s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-dfd8w\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-08-22T10:34:16.51831Z","caller":"traceutil/trace.go:171","msg":"trace[1809932636] range","detail":"{range_begin:/registry/pods/kube-system/cilium-dfd8w; range_end:; response_count:1; response_revision:600; }","duration":"1.509126092s","start":"2026-08-22T10:34:15.009161Z","end":"2026-08-22T10:34:16.518287Z","steps":["trace[1809932636] 'range keys from in-memory index tree' (duration: 1.508855378s)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:34:16.518846Z","caller":"traceutil/trace.go:171","msg":"trace[587457927] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"1.201610853s","start":"2026-08-22T10:34:15.317217Z","end":"2026-08-22T10:34:16.518827Z","steps":["trace[587457927] 'process raft request' (duration: 1.192014799s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:34:16.518933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"759.753716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:34:16.518981Z","caller":"traceutil/trace.go:171","msg":"trace[1812978513] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:601; }","duration":"759.849746ms","start":"2026-08-22T10:34:15.759121Z","end":"2026-08-22T10:34:16.518971Z","steps":["trace[1812978513] 'agreement among raft nodes before linearized reading' (duration: 759.767705ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:34:16.518842Z","caller":"traceutil/trace.go:171","msg":"trace[326880428] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:620; }","duration":"759.644363ms","start":"2026-08-22T10:34:15.759172Z","end":"2026-08-22T10:34:16.518817Z","steps":["trace[326880428] 'read index received' (duration: 749.939468ms)","trace[326880428] 'applied index is now lower than readState.Index' (duration: 9.703755ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:34:16.518982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:34:15.317184Z","time spent":"1.201726195s","remote":"127.0.0.1:60424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T10:34:16.519016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:34:15.759102Z","time spent":"759.907957ms","remote":"127.0.0.1:60332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-22T10:34:16.51953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:34:15.00914Z","time spent":"1.509240263s","remote":"127.0.0.1:60530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-dfd8w\" "} {"level":"info","ts":"2026-08-22T10:34:18.443686Z","caller":"traceutil/trace.go:171","msg":"trace[1927229000] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"128.486689ms","start":"2026-08-22T10:34:18.315179Z","end":"2026-08-22T10:34:18.443666Z","steps":["trace[1927229000] 'process raft request' (duration: 128.174035ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:34:21.468344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.324136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"} {"level":"info","ts":"2026-08-22T10:34:21.468433Z","caller":"traceutil/trace.go:171","msg":"trace[1443071677] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:679; }","duration":"157.494519ms","start":"2026-08-22T10:34:21.310913Z","end":"2026-08-22T10:34:21.468408Z","steps":["trace[1443071677] 'range keys from in-memory index tree' (duration: 157.101253ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:34:28.384948Z","caller":"traceutil/trace.go:171","msg":"trace[1649688987] transaction","detail":"{read_only:false; response_revision:737; number_of_response:1; }","duration":"282.859365ms","start":"2026-08-22T10:34:28.102054Z","end":"2026-08-22T10:34:28.384913Z","steps":["trace[1649688987] 'process raft request' (duration: 282.708833ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:34:28.511117Z","caller":"traceutil/trace.go:171","msg":"trace[501016445] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"113.663388ms","start":"2026-08-22T10:34:28.397423Z","end":"2026-08-22T10:34:28.511086Z","steps":["trace[501016445] 'process raft request' (duration: 113.435615ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:34:29.046301Z","caller":"traceutil/trace.go:171","msg":"trace[44801073] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"158.366128ms","start":"2026-08-22T10:34:28.887908Z","end":"2026-08-22T10:34:29.046274Z","steps":["trace[44801073] 'process raft request' (duration: 158.171745ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:34:29.155046Z","caller":"traceutil/trace.go:171","msg":"trace[1766471472] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"104.338869ms","start":"2026-08-22T10:34:29.050682Z","end":"2026-08-22T10:34:29.155021Z","steps":["trace[1766471472] 'process raft request' (duration: 104.208808ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:34:29.155308Z","caller":"traceutil/trace.go:171","msg":"trace[1180683297] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"104.304579ms","start":"2026-08-22T10:34:29.050973Z","end":"2026-08-22T10:34:29.155278Z","steps":["trace[1180683297] 'process raft request' (duration: 104.011985ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:34:32.420977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.693048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-zhvdt\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-08-22T10:34:32.421084Z","caller":"traceutil/trace.go:171","msg":"trace[380254420] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-zhvdt; range_end:; response_count:1; response_revision:762; }","duration":"313.835949ms","start":"2026-08-22T10:34:32.107212Z","end":"2026-08-22T10:34:32.421048Z","steps":["trace[380254420] 'range keys from in-memory index tree' (duration: 313.498745ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:34:32.421132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:34:32.10719Z","time spent":"313.93126ms","remote":"127.0.0.1:60530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3989,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-zhvdt\" "} {"level":"warn","ts":"2026-08-22T10:34:32.421323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.948945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.126\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-08-22T10:34:32.421385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.185662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-22T10:34:32.421491Z","caller":"traceutil/trace.go:171","msg":"trace[904411058] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:762; }","duration":"426.357945ms","start":"2026-08-22T10:34:31.995109Z","end":"2026-08-22T10:34:32.421467Z","steps":["trace[904411058] 'range keys from in-memory index tree' (duration: 425.959899ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:34:32.421426Z","caller":"traceutil/trace.go:171","msg":"trace[132229410] range","detail":"{range_begin:/registry/masterleases/199.19.213.126; range_end:; response_count:1; response_revision:762; }","duration":"626.069447ms","start":"2026-08-22T10:34:31.795332Z","end":"2026-08-22T10:34:32.421402Z","steps":["trace[132229410] 'range keys from in-memory index tree' (duration: 625.67463ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:34:32.421555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:34:31.995084Z","time spent":"426.458936ms","remote":"127.0.0.1:60612","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-08-22T10:34:32.421643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:34:31.795252Z","time spent":"626.368441ms","remote":"127.0.0.1:60364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.19.213.126\" "} {"level":"info","ts":"2026-08-22T10:34:32.568846Z","caller":"traceutil/trace.go:171","msg":"trace[272049944] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"139.927519ms","start":"2026-08-22T10:34:32.428892Z","end":"2026-08-22T10:34:32.56882Z","steps":["trace[272049944] 'process raft request' (duration: 139.710275ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:34:32.569012Z","caller":"traceutil/trace.go:171","msg":"trace[188977755] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"139.030607ms","start":"2026-08-22T10:34:32.429958Z","end":"2026-08-22T10:34:32.568989Z","steps":["trace[188977755] 'process raft request' (duration: 138.802894ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:35:06.176317Z","caller":"traceutil/trace.go:171","msg":"trace[207250273] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"161.182499ms","start":"2026-08-22T10:35:06.015099Z","end":"2026-08-22T10:35:06.176281Z","steps":["trace[207250273] 'process raft request' (duration: 160.960136ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:35:11.592229Z","caller":"traceutil/trace.go:171","msg":"trace[1019132053] transaction","detail":"{read_only:false; response_revision:1023; number_of_response:1; }","duration":"150.272509ms","start":"2026-08-22T10:35:11.44193Z","end":"2026-08-22T10:35:11.592203Z","steps":["trace[1019132053] 'process raft request' (duration: 150.102087ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:35:11.74957Z","caller":"traceutil/trace.go:171","msg":"trace[1538985242] linearizableReadLoop","detail":"{readStateIndex:1058; appliedIndex:1056; }","duration":"287.745434ms","start":"2026-08-22T10:35:11.461798Z","end":"2026-08-22T10:35:11.749543Z","steps":["trace[1538985242] 'read index received' (duration: 130.264127ms)","trace[1538985242] 'applied index is now lower than readState.Index' (duration: 157.480307ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:35:11.749819Z","caller":"traceutil/trace.go:171","msg":"trace[1578899485] transaction","detail":"{read_only:false; response_revision:1024; number_of_response:1; }","duration":"307.003937ms","start":"2026-08-22T10:35:11.442794Z","end":"2026-08-22T10:35:11.749798Z","steps":["trace[1578899485] 'process raft request' (duration: 277.318817ms)","trace[1578899485] 'compare' (duration: 29.329966ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:35:11.749925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:35:11.442785Z","time spent":"307.070318ms","remote":"127.0.0.1:60612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T10:35:11.750121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.317691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-22T10:35:11.750158Z","caller":"traceutil/trace.go:171","msg":"trace[616582894] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1024; }","duration":"288.357531ms","start":"2026-08-22T10:35:11.461792Z","end":"2026-08-22T10:35:11.750149Z","steps":["trace[616582894] 'agreement among raft nodes before linearized reading' (duration: 288.29436ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:35:13.057189Z","caller":"traceutil/trace.go:171","msg":"trace[656765424] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"198.412096ms","start":"2026-08-22T10:35:12.858749Z","end":"2026-08-22T10:35:13.057161Z","steps":["trace[656765424] 'process raft request' (duration: 198.245705ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:35:13.678253Z","caller":"traceutil/trace.go:171","msg":"trace[1783620032] transaction","detail":"{read_only:false; response_revision:1030; number_of_response:1; }","duration":"335.232003ms","start":"2026-08-22T10:35:13.342991Z","end":"2026-08-22T10:35:13.678223Z","steps":["trace[1783620032] 'process raft request' (duration: 334.9967ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:35:13.678417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:35:13.342975Z","time spent":"335.360695ms","remote":"127.0.0.1:60612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T10:35:13.859694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.463968ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T10:35:13.859833Z","caller":"traceutil/trace.go:171","msg":"trace[999106483] linearizableReadLoop","detail":"{readStateIndex:1066; appliedIndex:1065; }","duration":"105.716704ms","start":"2026-08-22T10:35:13.754072Z","end":"2026-08-22T10:35:13.859789Z","steps":["trace[999106483] 'read index received' (duration: 47.6µs)","trace[999106483] 'applied index is now lower than readState.Index' (duration: 105.667944ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:35:13.859827Z","caller":"traceutil/trace.go:171","msg":"trace[1709120043] transaction","detail":"{read_only:false; response_revision:1031; number_of_response:1; }","duration":"178.102688ms","start":"2026-08-22T10:35:13.681694Z","end":"2026-08-22T10:35:13.859797Z","steps":["trace[1709120043] 'process raft request' (duration: 45.438138ms)","trace[1709120043] 'compare' (duration: 132.313926ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:35:13.859972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.892736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-22T10:35:13.860007Z","caller":"traceutil/trace.go:171","msg":"trace[408839733] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1031; }","duration":"105.937627ms","start":"2026-08-22T10:35:13.754059Z","end":"2026-08-22T10:35:13.859997Z","steps":["trace[408839733] 'agreement among raft nodes before linearized reading' (duration: 105.806765ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:35:40.411888Z","caller":"traceutil/trace.go:171","msg":"trace[1447823009] transaction","detail":"{read_only:false; response_revision:1118; number_of_response:1; }","duration":"171.854393ms","start":"2026-08-22T10:35:40.240006Z","end":"2026-08-22T10:35:40.411861Z","steps":["trace[1447823009] 'process raft request' (duration: 171.717652ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:36:10.496579Z","caller":"traceutil/trace.go:171","msg":"trace[557611954] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"125.768949ms","start":"2026-08-22T10:36:10.370776Z","end":"2026-08-22T10:36:10.496545Z","steps":["trace[557611954] 'process raft request' (duration: 82.548085ms)","trace[557611954] 'compare' (duration: 43.168833ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:36:19.875835Z","caller":"traceutil/trace.go:171","msg":"trace[1681939198] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"158.102265ms","start":"2026-08-22T10:36:19.717696Z","end":"2026-08-22T10:36:19.875798Z","steps":["trace[1681939198] 'process raft request' (duration: 157.751513ms)"],"step_count":1}