{"level":"warn","ts":"2026-08-08T05:48:09.430252Z","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-08T05:48:09.430358Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.240:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.240:2380","--initial-cluster=instance=https://199.204.45.240:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.240:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.240:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-08-08T05:48:09.430427Z","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-08T05:48:09.430442Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.240:2380"]} {"level":"info","ts":"2026-08-08T05:48:09.430473Z","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-08T05:48:09.431227Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"]} {"level":"info","ts":"2026-08-08T05:48:09.431318Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.240:2380"],"listen-peer-urls":["https://199.204.45.240:2380"],"advertise-client-urls":["https://199.204.45.240:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.240:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-08-08T05:48:09.470731Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"39.184493ms"} {"level":"info","ts":"2026-08-08T05:48:09.496666Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4e46287fb5aa4785","cluster-id":"cae704afa9813e87"} {"level":"info","ts":"2026-08-08T05:48:09.496762Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=()"} {"level":"info","ts":"2026-08-08T05:48:09.497082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became follower at term 0"} {"level":"info","ts":"2026-08-08T05:48:09.497098Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4e46287fb5aa4785 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-08T05:48:09.497118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became follower at term 1"} {"level":"info","ts":"2026-08-08T05:48:09.497176Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=(5640240112301918085)"} {"level":"warn","ts":"2026-08-08T05:48:09.550533Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-08T05:48:09.55703Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-08T05:48:09.558389Z","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-08T05:48:09.565053Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4e46287fb5aa4785","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-08T05:48:09.565252Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4e46287fb5aa4785","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-08T05:48:09.565316Z","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-08T05:48:09.56598Z","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-08T05:48:09.566006Z","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-08T05:48:09.573599Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=(5640240112301918085)"} {"level":"info","ts":"2026-08-08T05:48:09.57369Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cae704afa9813e87","local-member-id":"4e46287fb5aa4785","added-peer-id":"4e46287fb5aa4785","added-peer-peer-urls":["https://199.204.45.240:2380"]} {"level":"info","ts":"2026-08-08T05:48:09.574314Z","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-08T05:48:09.574494Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4e46287fb5aa4785","initial-advertise-peer-urls":["https://199.204.45.240:2380"],"listen-peer-urls":["https://199.204.45.240:2380"],"advertise-client-urls":["https://199.204.45.240:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-08T05:48:09.574526Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-08T05:48:09.574616Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.240:2380"} {"level":"info","ts":"2026-08-08T05:48:09.574633Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.240:2380"} {"level":"info","ts":"2026-08-08T05:48:09.800333Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 is starting a new election at term 1"} {"level":"info","ts":"2026-08-08T05:48:09.800412Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-08T05:48:09.800445Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 received MsgPreVoteResp from 4e46287fb5aa4785 at term 1"} {"level":"info","ts":"2026-08-08T05:48:09.800465Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became candidate at term 2"} {"level":"info","ts":"2026-08-08T05:48:09.800476Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 received MsgVoteResp from 4e46287fb5aa4785 at term 2"} {"level":"info","ts":"2026-08-08T05:48:09.800492Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became leader at term 2"} {"level":"info","ts":"2026-08-08T05:48:09.800513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4e46287fb5aa4785 elected leader 4e46287fb5aa4785 at term 2"} {"level":"info","ts":"2026-08-08T05:48:09.802983Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-08T05:48:09.804298Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-08T05:48:09.804289Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4e46287fb5aa4785","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.240:2379]}","request-path":"/0/members/4e46287fb5aa4785/attributes","cluster-id":"cae704afa9813e87","publish-timeout":"7s"} {"level":"info","ts":"2026-08-08T05:48:09.804703Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-08T05:48:09.805131Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-08T05:48:09.80516Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-08T05:48:09.80706Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.240:2379"} {"level":"info","ts":"2026-08-08T05:48:09.808019Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-08T05:48:09.810543Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cae704afa9813e87","local-member-id":"4e46287fb5aa4785","cluster-version":"3.5"} {"level":"info","ts":"2026-08-08T05:48:09.810619Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-08T05:48:09.81065Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-08T05:48:29.717539Z","caller":"traceutil/trace.go:171","msg":"trace[1565311283] linearizableReadLoop","detail":"{readStateIndex:394; appliedIndex:393; }","duration":"255.872404ms","start":"2026-08-08T05:48:29.461637Z","end":"2026-08-08T05:48:29.717509Z","steps":["trace[1565311283] 'read index received' (duration: 255.629526ms)","trace[1565311283] 'applied index is now lower than readState.Index' (duration: 241.468µs)"],"step_count":2} {"level":"info","ts":"2026-08-08T05:48:29.717932Z","caller":"traceutil/trace.go:171","msg":"trace[149958718] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"287.048777ms","start":"2026-08-08T05:48:29.430865Z","end":"2026-08-08T05:48:29.717914Z","steps":["trace[149958718] 'process raft request' (duration: 286.475638ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:48:29.7182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.556526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-08T05:48:29.718263Z","caller":"traceutil/trace.go:171","msg":"trace[673137399] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:380; }","duration":"256.680931ms","start":"2026-08-08T05:48:29.46157Z","end":"2026-08-08T05:48:29.718251Z","steps":["trace[673137399] 'agreement among raft nodes before linearized reading' (duration: 256.575117ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:48:29.718423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.742814ms","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-08T05:48:29.718459Z","caller":"traceutil/trace.go:171","msg":"trace[1390238780] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:380; }","duration":"128.820346ms","start":"2026-08-08T05:48:29.58963Z","end":"2026-08-08T05:48:29.71845Z","steps":["trace[1390238780] 'agreement among raft nodes before linearized reading' (duration: 128.763675ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:48:30.443364Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153701132649602678,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-08T05:48:31.089835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.475577ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-08T05:48:31.089915Z","caller":"traceutil/trace.go:171","msg":"trace[1767246989] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"1.367401405s","start":"2026-08-08T05:48:29.722501Z","end":"2026-08-08T05:48:31.089902Z","steps":["trace[1767246989] 'process raft request' (duration: 934.37497ms)","trace[1767246989] 'compare' (duration: 432.167566ms)"],"step_count":2} {"level":"warn","ts":"2026-08-08T05:48:31.089959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:29.72249Z","time spent":"1.367448306s","remote":"127.0.0.1:52846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-08T05:48:31.226392Z","caller":"traceutil/trace.go:171","msg":"trace[877040101] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"1.503368818s","start":"2026-08-08T05:48:29.723001Z","end":"2026-08-08T05:48:31.22637Z","steps":["trace[877040101] 'process raft request' (duration: 1.470846638s)","trace[877040101] 'compare' (duration: 32.27133ms)"],"step_count":2} {"level":"warn","ts":"2026-08-08T05:48:31.226511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:29.722981Z","time spent":"1.503465451s","remote":"127.0.0.1:52846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-08T05:48:31.226665Z","caller":"traceutil/trace.go:171","msg":"trace[1252456751] linearizableReadLoop","detail":"{readStateIndex:397; appliedIndex:394; }","duration":"1.284237111s","start":"2026-08-08T05:48:29.942388Z","end":"2026-08-08T05:48:31.226625Z","steps":["trace[1252456751] 'read index received' (duration: 714.600161ms)","trace[1252456751] 'applied index is now lower than readState.Index' (duration: 569.63527ms)"],"step_count":2} {"level":"info","ts":"2026-08-08T05:48:31.226764Z","caller":"traceutil/trace.go:171","msg":"trace[99868956] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"1.501810225s","start":"2026-08-08T05:48:29.724945Z","end":"2026-08-08T05:48:31.226756Z","steps":["trace[99868956] 'process raft request' (duration: 1.501362051s)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:48:31.22678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.284372125s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-08T05:48:31.22681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:29.724934Z","time spent":"1.501854806s","remote":"127.0.0.1:52846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-08T05:48:31.226814Z","caller":"traceutil/trace.go:171","msg":"trace[1112488035] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:383; }","duration":"1.284441578s","start":"2026-08-08T05:48:29.942362Z","end":"2026-08-08T05:48:31.226804Z","steps":["trace[1112488035] 'agreement among raft nodes before linearized reading' (duration: 1.284366205s)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:48:31.226849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:29.942347Z","time spent":"1.2844947s","remote":"127.0.0.1:52588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-08T05:48:33.738145Z","caller":"traceutil/trace.go:171","msg":"trace[1457051830] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"219.013618ms","start":"2026-08-08T05:48:33.519101Z","end":"2026-08-08T05:48:33.738115Z","steps":["trace[1457051830] 'process raft request' (duration: 202.534695ms)","trace[1457051830] 'compare' (duration: 16.266246ms)"],"step_count":2} {"level":"info","ts":"2026-08-08T05:48:39.42271Z","caller":"traceutil/trace.go:171","msg":"trace[780036766] linearizableReadLoop","detail":"{readStateIndex:447; appliedIndex:446; }","duration":"169.646519ms","start":"2026-08-08T05:48:39.253035Z","end":"2026-08-08T05:48:39.422682Z","steps":["trace[780036766] 'read index received' (duration: 169.420711ms)","trace[780036766] 'applied index is now lower than readState.Index' (duration: 224.588µs)"],"step_count":2} {"level":"info","ts":"2026-08-08T05:48:39.422824Z","caller":"traceutil/trace.go:171","msg":"trace[773041435] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"287.077391ms","start":"2026-08-08T05:48:39.135713Z","end":"2026-08-08T05:48:39.42279Z","steps":["trace[773041435] 'process raft request' (duration: 286.822433ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:48:39.422902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.846445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-08T05:48:39.422947Z","caller":"traceutil/trace.go:171","msg":"trace[438334364] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:431; }","duration":"169.938538ms","start":"2026-08-08T05:48:39.252997Z","end":"2026-08-08T05:48:39.422936Z","steps":["trace[438334364] 'agreement among raft nodes before linearized reading' (duration: 169.833864ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:48:39.423154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.140656ms","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-08T05:48:39.423278Z","caller":"traceutil/trace.go:171","msg":"trace[1775815608] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:431; }","duration":"162.312683ms","start":"2026-08-08T05:48:39.260943Z","end":"2026-08-08T05:48:39.423256Z","steps":["trace[1775815608] 'agreement among raft nodes before linearized reading' (duration: 161.986912ms)"],"step_count":1} {"level":"info","ts":"2026-08-08T05:48:46.933331Z","caller":"traceutil/trace.go:171","msg":"trace[263462243] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"823.594567ms","start":"2026-08-08T05:48:46.10971Z","end":"2026-08-08T05:48:46.933304Z","steps":["trace[263462243] 'process raft request' (duration: 823.445642ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:48:46.933489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:46.109686Z","time spent":"823.727131ms","remote":"127.0.0.1:52846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-08T05:48:47.066368Z","caller":"traceutil/trace.go:171","msg":"trace[812169988] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"831.887813ms","start":"2026-08-08T05:48:46.234447Z","end":"2026-08-08T05:48:47.066335Z","steps":["trace[812169988] 'process raft request' (duration: 831.674076ms)"],"step_count":1} {"level":"info","ts":"2026-08-08T05:48:47.06664Z","caller":"traceutil/trace.go:171","msg":"trace[2032304748] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"825.279434ms","start":"2026-08-08T05:48:46.241326Z","end":"2026-08-08T05:48:47.066605Z","steps":["trace[2032304748] 'process raft request' (duration: 824.947064ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:48:47.066803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:46.241308Z","time spent":"825.422138ms","remote":"127.0.0.1:52634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-08T05:48:47.066662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:46.234411Z","time spent":"832.153341ms","remote":"127.0.0.1:52634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-08T05:48:47.067008Z","caller":"traceutil/trace.go:171","msg":"trace[2003220641] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"815.860046ms","start":"2026-08-08T05:48:46.25114Z","end":"2026-08-08T05:48:47.067Z","steps":["trace[2003220641] 'process raft request' (duration: 815.333209ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:48:47.067089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:46.251122Z","time spent":"815.919128ms","remote":"127.0.0.1:52634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-08T05:48:47.067165Z","caller":"traceutil/trace.go:171","msg":"trace[574937337] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"816.97269ms","start":"2026-08-08T05:48:46.250184Z","end":"2026-08-08T05:48:47.067157Z","steps":["trace[574937337] 'process raft request' (duration: 816.254518ms)"],"step_count":1} {"level":"info","ts":"2026-08-08T05:48:47.067187Z","caller":"traceutil/trace.go:171","msg":"trace[48923411] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"817.086285ms","start":"2026-08-08T05:48:46.25008Z","end":"2026-08-08T05:48:47.067166Z","steps":["trace[48923411] 'process raft request' (duration: 816.233808ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:48:47.06721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:46.25016Z","time spent":"817.030122ms","remote":"127.0.0.1:52634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-08T05:48:47.066965Z","caller":"traceutil/trace.go:171","msg":"trace[910447594] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"828.486915ms","start":"2026-08-08T05:48:46.238467Z","end":"2026-08-08T05:48:47.066954Z","steps":["trace[910447594] 'process raft request' (duration: 827.769733ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:48:47.067286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:46.250063Z","time spent":"817.182968ms","remote":"127.0.0.1:52634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-08T05:48:47.067304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:46.238458Z","time spent":"828.825755ms","remote":"127.0.0.1:52634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-08T05:48:47.067392Z","caller":"traceutil/trace.go:171","msg":"trace[4769472] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"809.887156ms","start":"2026-08-08T05:48:46.257496Z","end":"2026-08-08T05:48:47.067384Z","steps":["trace[4769472] 'process raft request' (duration: 809.36815ms)"],"step_count":1} {"level":"info","ts":"2026-08-08T05:48:47.067407Z","caller":"traceutil/trace.go:171","msg":"trace[1612813649] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"811.726435ms","start":"2026-08-08T05:48:46.255665Z","end":"2026-08-08T05:48:47.067391Z","steps":["trace[1612813649] 'process raft request' (duration: 811.031133ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:48:47.06744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:46.257488Z","time spent":"809.933139ms","remote":"127.0.0.1:52634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-08T05:48:47.067455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:46.255653Z","time spent":"811.776437ms","remote":"127.0.0.1:52634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-08T05:48:47.067526Z","caller":"traceutil/trace.go:171","msg":"trace[1347330969] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"802.431361ms","start":"2026-08-08T05:48:46.265087Z","end":"2026-08-08T05:48:47.067518Z","steps":["trace[1347330969] 'process raft request' (duration: 801.887754ms)"],"step_count":1} {"level":"info","ts":"2026-08-08T05:48:47.067478Z","caller":"traceutil/trace.go:171","msg":"trace[667046609] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"811.699684ms","start":"2026-08-08T05:48:46.255684Z","end":"2026-08-08T05:48:47.067383Z","steps":["trace[667046609] 'process raft request' (duration: 811.074575ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:48:47.067575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:46.265073Z","time spent":"802.480333ms","remote":"127.0.0.1:52634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-08T05:48:47.067726Z","caller":"traceutil/trace.go:171","msg":"trace[265323395] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"788.929404ms","start":"2026-08-08T05:48:46.278788Z","end":"2026-08-08T05:48:47.067718Z","steps":["trace[265323395] 'process raft request' (duration: 788.322105ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:48:47.067779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:46.278759Z","time spent":"788.997126ms","remote":"127.0.0.1:52634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-08T05:48:47.067774Z","caller":"traceutil/trace.go:171","msg":"trace[299047497] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"677.322077ms","start":"2026-08-08T05:48:46.390398Z","end":"2026-08-08T05:48:47.067721Z","steps":["trace[299047497] 'process raft request' (duration: 676.939835ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:48:47.068101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:46.390369Z","time spent":"677.478952ms","remote":"127.0.0.1:52634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-08T05:48:47.072315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:46.255672Z","time spent":"811.926431ms","remote":"127.0.0.1:52634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-08T05:48:54.000314Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153701132649603117,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-08T05:48:54.391971Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.018594872s","expected-duration":"1s"} {"level":"info","ts":"2026-08-08T05:48:54.392965Z","caller":"traceutil/trace.go:171","msg":"trace[1049734515] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:610; }","duration":"892.94598ms","start":"2026-08-08T05:48:53.499996Z","end":"2026-08-08T05:48:54.392942Z","steps":["trace[1049734515] 'read index received' (duration: 892.798645ms)","trace[1049734515] 'applied index is now lower than readState.Index' (duration: 146.385µs)"],"step_count":2} {"level":"info","ts":"2026-08-08T05:48:54.393071Z","caller":"traceutil/trace.go:171","msg":"trace[1066092846] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"1.021240123s","start":"2026-08-08T05:48:53.371795Z","end":"2026-08-08T05:48:54.393035Z","steps":["trace[1066092846] 'process raft request' (duration: 1.020666285s)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:48:54.393227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"827.486861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-wq2x9\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-08-08T05:48:54.393234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"893.216268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-08-08T05:48:54.393122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"890.38185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.240\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-08T05:48:54.393304Z","caller":"traceutil/trace.go:171","msg":"trace[1456696409] range","detail":"{range_begin:/registry/masterleases/199.204.45.240; range_end:; response_count:1; response_revision:591; }","duration":"890.595556ms","start":"2026-08-08T05:48:53.502696Z","end":"2026-08-08T05:48:54.393291Z","steps":["trace[1456696409] 'agreement among raft nodes before linearized reading' (duration: 890.347519ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:48:54.393307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.575187ms","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-08T05:48:54.39337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.368761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-08T05:48:54.393405Z","caller":"traceutil/trace.go:171","msg":"trace[620490925] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:591; }","duration":"452.430583ms","start":"2026-08-08T05:48:53.940964Z","end":"2026-08-08T05:48:54.393395Z","steps":["trace[620490925] 'agreement among raft nodes before linearized reading' (duration: 452.385301ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:48:54.393444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:53.940946Z","time spent":"452.491104ms","remote":"127.0.0.1:52588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-08T05:48:54.393255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:53.371764Z","time spent":"1.021397827s","remote":"127.0.0.1:52682","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036297,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-08T05:48:54.393402Z","caller":"traceutil/trace.go:171","msg":"trace[1857864006] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:591; }","duration":"544.710161ms","start":"2026-08-08T05:48:53.84867Z","end":"2026-08-08T05:48:54.39338Z","steps":["trace[1857864006] 'agreement among raft nodes before linearized reading' (duration: 544.422042ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:48:54.393618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:53.84865Z","time spent":"544.959579ms","remote":"127.0.0.1:52846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-08T05:48:54.393347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:53.502637Z","time spent":"890.70046ms","remote":"127.0.0.1:52608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.240\" "} {"level":"info","ts":"2026-08-08T05:48:54.393304Z","caller":"traceutil/trace.go:171","msg":"trace[1078365687] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:591; }","duration":"893.335201ms","start":"2026-08-08T05:48:53.499953Z","end":"2026-08-08T05:48:54.393288Z","steps":["trace[1078365687] 'agreement among raft nodes before linearized reading' (duration: 893.098694ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:48:54.393735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:53.499936Z","time spent":"893.788465ms","remote":"127.0.0.1:52846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-08T05:48:54.393268Z","caller":"traceutil/trace.go:171","msg":"trace[973789544] range","detail":"{range_begin:/registry/pods/kube-system/cilium-wq2x9; range_end:; response_count:1; response_revision:591; }","duration":"827.547813ms","start":"2026-08-08T05:48:53.565709Z","end":"2026-08-08T05:48:54.393257Z","steps":["trace[973789544] 'agreement among raft nodes before linearized reading' (duration: 827.43508ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:48:54.393828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:53.565693Z","time spent":"828.127882ms","remote":"127.0.0.1:52766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-wq2x9\" "} {"level":"warn","ts":"2026-08-08T05:48:54.393341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"864.335762ms","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-08T05:48:54.393934Z","caller":"traceutil/trace.go:171","msg":"trace[1762270824] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:591; }","duration":"864.964593ms","start":"2026-08-08T05:48:53.528959Z","end":"2026-08-08T05:48:54.393924Z","steps":["trace[1762270824] 'agreement among raft nodes before linearized reading' (duration: 864.329022ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:48:54.393963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:53.528934Z","time spent":"865.020864ms","remote":"127.0.0.1:52846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-08T05:48:54.394293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"856.743358ms","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-08T05:48:54.394375Z","caller":"traceutil/trace.go:171","msg":"trace[1323437690] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:591; }","duration":"856.866222ms","start":"2026-08-08T05:48:53.537489Z","end":"2026-08-08T05:48:54.394356Z","steps":["trace[1323437690] 'agreement among raft nodes before linearized reading' (duration: 856.598704ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:48:54.394421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:53.537475Z","time spent":"856.936834ms","remote":"127.0.0.1:52846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-08T05:48:55.754351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.150169ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-08T05:48:55.754618Z","caller":"traceutil/trace.go:171","msg":"trace[2086892109] linearizableReadLoop","detail":"{readStateIndex:619; appliedIndex:616; }","duration":"813.413248ms","start":"2026-08-08T05:48:54.941187Z","end":"2026-08-08T05:48:55.754601Z","steps":["trace[2086892109] 'read index received' (duration: 376.938319ms)","trace[2086892109] 'applied index is now lower than readState.Index' (duration: 436.474009ms)"],"step_count":2} {"level":"info","ts":"2026-08-08T05:48:55.754604Z","caller":"traceutil/trace.go:171","msg":"trace[542974462] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"1.34692267s","start":"2026-08-08T05:48:54.407649Z","end":"2026-08-08T05:48:55.754572Z","steps":["trace[542974462] 'process raft request' (duration: 910.452201ms)","trace[542974462] 'compare' (duration: 435.618303ms)"],"step_count":2} {"level":"warn","ts":"2026-08-08T05:48:55.754721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"813.534361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-08T05:48:55.754691Z","caller":"traceutil/trace.go:171","msg":"trace[674104164] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"1.306173211s","start":"2026-08-08T05:48:54.448491Z","end":"2026-08-08T05:48:55.754665Z","steps":["trace[674104164] 'process raft request' (duration: 1.306073128s)"],"step_count":1} {"level":"info","ts":"2026-08-08T05:48:55.754723Z","caller":"traceutil/trace.go:171","msg":"trace[1589680347] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"1.345517447s","start":"2026-08-08T05:48:54.409179Z","end":"2026-08-08T05:48:55.754696Z","steps":["trace[1589680347] 'process raft request' (duration: 1.34528977s)"],"step_count":1} {"level":"info","ts":"2026-08-08T05:48:55.754752Z","caller":"traceutil/trace.go:171","msg":"trace[2075537848] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:598; }","duration":"813.598673ms","start":"2026-08-08T05:48:54.941141Z","end":"2026-08-08T05:48:55.754739Z","steps":["trace[2075537848] 'agreement among raft nodes before linearized reading' (duration: 813.516051ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:48:55.754766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:54.407635Z","time spent":"1.347046674s","remote":"127.0.0.1:52766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-08T05:48:55.754789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:54.941123Z","time spent":"813.659205ms","remote":"127.0.0.1:52588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-08T05:48:55.754811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:54.448465Z","time spent":"1.306292795s","remote":"127.0.0.1:52830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-08T05:48:55.754852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:54.409168Z","time spent":"1.345611699s","remote":"127.0.0.1:52608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-08T05:48:56.927669Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153701132649603139,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-08T05:48:57.42851Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153701132649603139,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-08T05:48:57.929354Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153701132649603139,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-08T05:48:58.190882Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.423030372s","expected-duration":"1s"} {"level":"info","ts":"2026-08-08T05:48:58.191273Z","caller":"traceutil/trace.go:171","msg":"trace[1627789659] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"2.423475165s","start":"2026-08-08T05:48:55.767777Z","end":"2026-08-08T05:48:58.191252Z","steps":["trace[1627789659] 'process raft request' (duration: 2.42331808s)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:48:58.191389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:55.767765Z","time spent":"2.423562827s","remote":"127.0.0.1:52766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-08T05:48:58.261717Z","caller":"traceutil/trace.go:171","msg":"trace[1795224987] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:619; }","duration":"1.834618549s","start":"2026-08-08T05:48:56.427076Z","end":"2026-08-08T05:48:58.261695Z","steps":["trace[1795224987] 'read index received' (duration: 1.76400257s)","trace[1795224987] 'applied index is now lower than readState.Index' (duration: 70.614439ms)"],"step_count":2} {"level":"warn","ts":"2026-08-08T05:48:58.261905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.834829096s","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-08T05:48:58.261965Z","caller":"traceutil/trace.go:171","msg":"trace[730078614] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:600; }","duration":"1.834925588s","start":"2026-08-08T05:48:56.427026Z","end":"2026-08-08T05:48:58.261952Z","steps":["trace[730078614] 'agreement among raft nodes before linearized reading' (duration: 1.834813615s)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:48:58.261998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:56.427005Z","time spent":"1.83498503s","remote":"127.0.0.1:52846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-08T05:48:58.261977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.834779794s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-08-08T05:48:58.262019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.834904668s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-08T05:48:58.262032Z","caller":"traceutil/trace.go:171","msg":"trace[2096375062] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:600; }","duration":"1.83499211s","start":"2026-08-08T05:48:56.427026Z","end":"2026-08-08T05:48:58.262018Z","steps":["trace[2096375062] 'agreement among raft nodes before linearized reading' (duration: 1.834711772s)"],"step_count":1} {"level":"info","ts":"2026-08-08T05:48:58.262059Z","caller":"traceutil/trace.go:171","msg":"trace[1336403013] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:600; }","duration":"1.8350076s","start":"2026-08-08T05:48:56.427039Z","end":"2026-08-08T05:48:58.262047Z","steps":["trace[1336403013] 'agreement among raft nodes before linearized reading' (duration: 1.834815104s)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:48:58.262126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:56.427026Z","time spent":"1.835089053s","remote":"127.0.0.1:52846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-08T05:48:58.262107Z","caller":"traceutil/trace.go:171","msg":"trace[1503855236] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"1.305686184s","start":"2026-08-08T05:48:56.95639Z","end":"2026-08-08T05:48:58.262076Z","steps":["trace[1503855236] 'process raft request' (duration: 1.29964358s)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:48:58.262131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.835048002s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-08-08T05:48:58.262065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:56.427005Z","time spent":"1.835051222s","remote":"127.0.0.1:52846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-08T05:48:58.262187Z","caller":"traceutil/trace.go:171","msg":"trace[1808956875] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:600; }","duration":"1.835199326s","start":"2026-08-08T05:48:56.426972Z","end":"2026-08-08T05:48:58.262172Z","steps":["trace[1808956875] 'agreement among raft nodes before linearized reading' (duration: 1.835047221s)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:48:58.262233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:56.426954Z","time spent":"1.835266719s","remote":"127.0.0.1:52846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-08T05:48:58.262247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:56.956374Z","time spent":"1.305796597s","remote":"127.0.0.1:52846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-08T05:48:58.264421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.323297705s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-08T05:48:58.26446Z","caller":"traceutil/trace.go:171","msg":"trace[548546510] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:604; }","duration":"1.323370307s","start":"2026-08-08T05:48:56.941081Z","end":"2026-08-08T05:48:58.264451Z","steps":["trace[548546510] 'agreement among raft nodes before linearized reading' (duration: 1.323303575s)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:48:58.264481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:56.94106Z","time spent":"1.323415509s","remote":"127.0.0.1:52588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-08T05:48:58.698082Z","caller":"traceutil/trace.go:171","msg":"trace[671275965] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"115.235263ms","start":"2026-08-08T05:48:58.582824Z","end":"2026-08-08T05:48:58.69806Z","steps":["trace[671275965] 'process raft request' (duration: 115.082208ms)"],"step_count":1} {"level":"info","ts":"2026-08-08T05:48:58.706644Z","caller":"traceutil/trace.go:171","msg":"trace[1666552855] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"111.989164ms","start":"2026-08-08T05:48:58.594632Z","end":"2026-08-08T05:48:58.706621Z","steps":["trace[1666552855] 'process raft request' (duration: 111.724286ms)"],"step_count":1} {"level":"info","ts":"2026-08-08T05:49:00.329753Z","caller":"traceutil/trace.go:171","msg":"trace[302323686] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:649; }","duration":"388.544584ms","start":"2026-08-08T05:48:59.941189Z","end":"2026-08-08T05:49:00.329734Z","steps":["trace[302323686] 'read index received' (duration: 388.41648ms)","trace[302323686] 'applied index is now lower than readState.Index' (duration: 127.154µs)"],"step_count":2} {"level":"info","ts":"2026-08-08T05:49:00.329831Z","caller":"traceutil/trace.go:171","msg":"trace[1175068779] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"521.682415ms","start":"2026-08-08T05:48:59.8081Z","end":"2026-08-08T05:49:00.329782Z","steps":["trace[1175068779] 'process raft request' (duration: 521.52445ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:49:00.330041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.800703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-08T05:49:00.330294Z","caller":"traceutil/trace.go:171","msg":"trace[1964295000] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:628; }","duration":"389.137303ms","start":"2026-08-08T05:48:59.941141Z","end":"2026-08-08T05:49:00.330279Z","steps":["trace[1964295000] 'agreement among raft nodes before linearized reading' (duration: 388.7364ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:49:00.330359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:59.941126Z","time spent":"389.220966ms","remote":"127.0.0.1:52578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-08T05:49:00.330271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:48:59.808072Z","time spent":"522.100958ms","remote":"127.0.0.1:52634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4580,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-08T05:49:00.335251Z","caller":"traceutil/trace.go:171","msg":"trace[763500966] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"327.718069ms","start":"2026-08-08T05:49:00.007507Z","end":"2026-08-08T05:49:00.335225Z","steps":["trace[763500966] 'process raft request' (duration: 327.4186ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:49:00.335286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.22507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-gjtd8\" ","response":"range_response_count:1 size:4888"} {"level":"info","ts":"2026-08-08T05:49:00.335372Z","caller":"traceutil/trace.go:171","msg":"trace[1507189079] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-gjtd8; range_end:; response_count:1; response_revision:630; }","duration":"294.358174ms","start":"2026-08-08T05:49:00.040998Z","end":"2026-08-08T05:49:00.335356Z","steps":["trace[1507189079] 'agreement among raft nodes before linearized reading' (duration: 294.091176ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:49:00.335387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:49:00.007487Z","time spent":"327.832223ms","remote":"127.0.0.1:52634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9343,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-08T05:49:00.335266Z","caller":"traceutil/trace.go:171","msg":"trace[757642811] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"127.365394ms","start":"2026-08-08T05:49:00.20788Z","end":"2026-08-08T05:49:00.335245Z","steps":["trace[757642811] 'process raft request' (duration: 127.153117ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:49:03.063565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.918156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-08T05:49:03.063633Z","caller":"traceutil/trace.go:171","msg":"trace[1338559463] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:677; }","duration":"121.02637ms","start":"2026-08-08T05:49:02.942593Z","end":"2026-08-08T05:49:03.06362Z","steps":["trace[1338559463] 'range keys from in-memory index tree' (duration: 120.853604ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:49:03.063855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.654466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"info","ts":"2026-08-08T05:49:03.063996Z","caller":"traceutil/trace.go:171","msg":"trace[518450022] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:677; }","duration":"257.873852ms","start":"2026-08-08T05:49:02.806098Z","end":"2026-08-08T05:49:03.063972Z","steps":["trace[518450022] 'range keys from in-memory index tree' (duration: 257.392518ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:49:14.195774Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153701132649603431,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-08T05:49:14.427483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"880.87968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-08T05:49:14.427646Z","caller":"traceutil/trace.go:171","msg":"trace[1157126656] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:761; }","duration":"881.083876ms","start":"2026-08-08T05:49:13.546544Z","end":"2026-08-08T05:49:14.427628Z","steps":["trace[1157126656] 'count revisions from in-memory index tree' (duration: 880.758557ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:49:14.427502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"923.140279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.240\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-08-08T05:49:14.427727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:49:13.546531Z","time spent":"881.180529ms","remote":"127.0.0.1:53030","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"info","ts":"2026-08-08T05:49:14.427793Z","caller":"traceutil/trace.go:171","msg":"trace[496710308] range","detail":"{range_begin:/registry/masterleases/199.204.45.240; range_end:; response_count:1; response_revision:761; }","duration":"923.450738ms","start":"2026-08-08T05:49:13.504289Z","end":"2026-08-08T05:49:14.42774Z","steps":["trace[496710308] 'range keys from in-memory index tree' (duration: 922.975023ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:49:14.428035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:49:13.504269Z","time spent":"923.604832ms","remote":"127.0.0.1:52608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.240\" "} {"level":"warn","ts":"2026-08-08T05:49:14.696553Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153701132649603431,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-08T05:49:14.887454Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.196363048s","expected-duration":"1s"} {"level":"info","ts":"2026-08-08T05:49:14.888496Z","caller":"traceutil/trace.go:171","msg":"trace[911495513] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"1.197501851s","start":"2026-08-08T05:49:13.690964Z","end":"2026-08-08T05:49:14.888466Z","steps":["trace[911495513] 'process raft request' (duration: 1.196834532s)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:49:14.888801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:49:13.69094Z","time spent":"1.197648226s","remote":"127.0.0.1:52830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-08T05:49:14.895701Z","caller":"traceutil/trace.go:171","msg":"trace[1351922775] linearizableReadLoop","detail":"{readStateIndex:788; appliedIndex:786; }","duration":"1.200130418s","start":"2026-08-08T05:49:13.695545Z","end":"2026-08-08T05:49:14.895676Z","steps":["trace[1351922775] 'read index received' (duration: 1.192299657s)","trace[1351922775] 'applied index is now lower than readState.Index' (duration: 7.829081ms)"],"step_count":2} {"level":"warn","ts":"2026-08-08T05:49:14.896051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.200476779s","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":"warn","ts":"2026-08-08T05:49:14.896096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"825.922922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-08T05:49:14.896162Z","caller":"traceutil/trace.go:171","msg":"trace[281028420] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:762; }","duration":"826.036835ms","start":"2026-08-08T05:49:14.070111Z","end":"2026-08-08T05:49:14.896148Z","steps":["trace[281028420] 'agreement among raft nodes before linearized reading' (duration: 825.908441ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:49:14.896153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.658511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-08-08T05:49:14.896211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:49:14.070089Z","time spent":"826.111108ms","remote":"127.0.0.1:53066","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-08-08T05:49:14.896244Z","caller":"traceutil/trace.go:171","msg":"trace[1015974911] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:762; }","duration":"470.807315ms","start":"2026-08-08T05:49:14.425414Z","end":"2026-08-08T05:49:14.896221Z","steps":["trace[1015974911] 'agreement among raft nodes before linearized reading' (duration: 470.558788ms)"],"step_count":1} {"level":"info","ts":"2026-08-08T05:49:14.896184Z","caller":"traceutil/trace.go:171","msg":"trace[450044310] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:762; }","duration":"1.200633714s","start":"2026-08-08T05:49:13.695499Z","end":"2026-08-08T05:49:14.896133Z","steps":["trace[450044310] 'agreement among raft nodes before linearized reading' (duration: 1.200362356s)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:49:14.896371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:49:13.69548Z","time spent":"1.20087764s","remote":"127.0.0.1:52846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-08T05:49:14.896429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.542238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-08-08T05:49:14.896303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:49:14.425376Z","time spent":"470.918348ms","remote":"127.0.0.1:52846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-08T05:49:14.896473Z","caller":"traceutil/trace.go:171","msg":"trace[829957222] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:762; }","duration":"470.61077ms","start":"2026-08-08T05:49:14.425848Z","end":"2026-08-08T05:49:14.896459Z","steps":["trace[829957222] 'agreement among raft nodes before linearized reading' (duration: 470.509427ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:49:14.896502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:49:14.425841Z","time spent":"470.654891ms","remote":"127.0.0.1:52846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-08T05:49:14.895714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:49:14.42914Z","time spent":"466.567831ms","remote":"127.0.0.1:52608","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-08-08T05:49:14.896373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"857.642327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-08T05:49:14.89661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.79267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-08-08T05:49:14.896282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"953.909287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-08T05:49:14.896671Z","caller":"traceutil/trace.go:171","msg":"trace[1787301261] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:762; }","duration":"857.996787ms","start":"2026-08-08T05:49:14.038646Z","end":"2026-08-08T05:49:14.896642Z","steps":["trace[1787301261] 'agreement among raft nodes before linearized reading' (duration: 857.704228ms)"],"step_count":1} {"level":"info","ts":"2026-08-08T05:49:14.896706Z","caller":"traceutil/trace.go:171","msg":"trace[862871227] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:762; }","duration":"479.947475ms","start":"2026-08-08T05:49:14.41674Z","end":"2026-08-08T05:49:14.896687Z","steps":["trace[862871227] 'agreement among raft nodes before linearized reading' (duration: 479.616235ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:49:14.896831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.29501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-08T05:49:14.896881Z","caller":"traceutil/trace.go:171","msg":"trace[1018440640] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:762; }","duration":"471.380012ms","start":"2026-08-08T05:49:14.42549Z","end":"2026-08-08T05:49:14.89687Z","steps":["trace[1018440640] 'agreement among raft nodes before linearized reading' (duration: 471.209257ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:49:14.896913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:49:14.42547Z","time spent":"471.436664ms","remote":"127.0.0.1:52846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-08T05:49:14.896829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:49:14.41672Z","time spent":"480.097479ms","remote":"127.0.0.1:52846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-08T05:49:14.89672Z","caller":"traceutil/trace.go:171","msg":"trace[116760427] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:762; }","duration":"954.378831ms","start":"2026-08-08T05:49:13.942315Z","end":"2026-08-08T05:49:14.896694Z","steps":["trace[116760427] 'agreement among raft nodes before linearized reading' (duration: 953.572148ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:49:14.897029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:49:13.942296Z","time spent":"954.71636ms","remote":"127.0.0.1:52588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-08T05:49:14.896763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:49:14.038626Z","time spent":"858.09376ms","remote":"127.0.0.1:52984","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "} {"level":"info","ts":"2026-08-08T05:49:29.197733Z","caller":"traceutil/trace.go:171","msg":"trace[80336594] linearizableReadLoop","detail":"{readStateIndex:959; appliedIndex:958; }","duration":"216.297921ms","start":"2026-08-08T05:49:28.98142Z","end":"2026-08-08T05:49:29.197718Z","steps":["trace[80336594] 'read index received' (duration: 216.147867ms)","trace[80336594] 'applied index is now lower than readState.Index' (duration: 149.494µs)"],"step_count":2} {"level":"info","ts":"2026-08-08T05:49:29.197813Z","caller":"traceutil/trace.go:171","msg":"trace[547665354] transaction","detail":"{read_only:false; response_revision:930; number_of_response:1; }","duration":"220.052859ms","start":"2026-08-08T05:49:28.977754Z","end":"2026-08-08T05:49:29.197807Z","steps":["trace[547665354] 'process raft request' (duration: 219.850403ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:49:29.19804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.691476ms","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":"warn","ts":"2026-08-08T05:49:29.19816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.726273ms","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-08T05:49:29.198189Z","caller":"traceutil/trace.go:171","msg":"trace[1699162214] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:930; }","duration":"216.779054ms","start":"2026-08-08T05:49:28.981402Z","end":"2026-08-08T05:49:29.198181Z","steps":["trace[1699162214] 'agreement among raft nodes before linearized reading' (duration: 216.684652ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:49:29.198207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.047319ms","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-08T05:49:29.198226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.833888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-08T05:49:29.19826Z","caller":"traceutil/trace.go:171","msg":"trace[623726642] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:930; }","duration":"212.11378ms","start":"2026-08-08T05:49:28.986124Z","end":"2026-08-08T05:49:29.198238Z","steps":["trace[623726642] 'agreement among raft nodes before linearized reading' (duration: 212.023337ms)"],"step_count":1} {"level":"info","ts":"2026-08-08T05:49:29.198281Z","caller":"traceutil/trace.go:171","msg":"trace[563130240] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:930; }","duration":"207.91199ms","start":"2026-08-08T05:49:28.990355Z","end":"2026-08-08T05:49:29.198266Z","steps":["trace[563130240] 'agreement among raft nodes before linearized reading' (duration: 207.766366ms)"],"step_count":1} {"level":"info","ts":"2026-08-08T05:49:29.198383Z","caller":"traceutil/trace.go:171","msg":"trace[1073983466] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:930; }","duration":"213.793079ms","start":"2026-08-08T05:49:28.98431Z","end":"2026-08-08T05:49:29.198103Z","steps":["trace[1073983466] 'agreement among raft nodes before linearized reading' (duration: 213.602574ms)"],"step_count":1} {"level":"info","ts":"2026-08-08T05:50:09.566405Z","caller":"traceutil/trace.go:171","msg":"trace[321660149] transaction","detail":"{read_only:false; response_revision:1078; number_of_response:1; }","duration":"109.633448ms","start":"2026-08-08T05:50:09.456754Z","end":"2026-08-08T05:50:09.566388Z","steps":["trace[321660149] 'process raft request' (duration: 109.458802ms)"],"step_count":1} {"level":"info","ts":"2026-08-08T05:50:09.566425Z","caller":"traceutil/trace.go:171","msg":"trace[607184354] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"109.008231ms","start":"2026-08-08T05:50:09.457394Z","end":"2026-08-08T05:50:09.566402Z","steps":["trace[607184354] 'process raft request' (duration: 108.960509ms)"],"step_count":1} {"level":"info","ts":"2026-08-08T05:50:09.566556Z","caller":"traceutil/trace.go:171","msg":"trace[657511105] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"109.189715ms","start":"2026-08-08T05:50:09.457356Z","end":"2026-08-08T05:50:09.566546Z","steps":["trace[657511105] 'process raft request' (duration: 108.962659ms)"],"step_count":1} {"level":"info","ts":"2026-08-08T05:51:08.114285Z","caller":"traceutil/trace.go:171","msg":"trace[1928560878] linearizableReadLoop","detail":"{readStateIndex:1361; appliedIndex:1360; }","duration":"150.155594ms","start":"2026-08-08T05:51:07.964089Z","end":"2026-08-08T05:51:08.114244Z","steps":["trace[1928560878] 'read index received' (duration: 145.174313ms)","trace[1928560878] 'applied index is now lower than readState.Index' (duration: 4.979471ms)"],"step_count":2} {"level":"info","ts":"2026-08-08T05:51:08.114385Z","caller":"traceutil/trace.go:171","msg":"trace[2088880468] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"152.931667ms","start":"2026-08-08T05:51:07.961399Z","end":"2026-08-08T05:51:08.11433Z","steps":["trace[2088880468] 'process raft request' (duration: 147.888664ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:51:08.114623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.494333ms","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-08T05:51:08.114745Z","caller":"traceutil/trace.go:171","msg":"trace[1887841840] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1309; }","duration":"150.666737ms","start":"2026-08-08T05:51:07.964053Z","end":"2026-08-08T05:51:08.114719Z","steps":["trace[1887841840] 'agreement among raft nodes before linearized reading' (duration: 150.339969ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:51:09.571823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"857.647424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-08T05:51:09.571884Z","caller":"traceutil/trace.go:171","msg":"trace[1935182483] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1311; }","duration":"857.763987ms","start":"2026-08-08T05:51:08.714105Z","end":"2026-08-08T05:51:09.571869Z","steps":["trace[1935182483] 'count revisions from in-memory index tree' (duration: 857.570601ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:51:09.571939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:51:08.714085Z","time spent":"857.845788ms","remote":"127.0.0.1:53066","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-08-08T05:51:09.670004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.85631ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-08T05:51:09.670109Z","caller":"traceutil/trace.go:171","msg":"trace[672632186] linearizableReadLoop","detail":"{readStateIndex:1364; appliedIndex:1363; }","duration":"728.08616ms","start":"2026-08-08T05:51:08.942004Z","end":"2026-08-08T05:51:09.67009Z","steps":["trace[672632186] 'read index received' (duration: 494.023983ms)","trace[672632186] 'applied index is now lower than readState.Index' (duration: 234.060557ms)"],"step_count":2} {"level":"warn","ts":"2026-08-08T05:51:09.670236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"728.223083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-08T05:51:09.670326Z","caller":"traceutil/trace.go:171","msg":"trace[280684548] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1311; }","duration":"728.347396ms","start":"2026-08-08T05:51:08.941954Z","end":"2026-08-08T05:51:09.670301Z","steps":["trace[280684548] 'agreement among raft nodes before linearized reading' (duration: 728.212083ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:51:09.670336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.728671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-08T05:51:09.670367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:51:08.94193Z","time spent":"728.427449ms","remote":"127.0.0.1:52588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-08T05:51:09.670411Z","caller":"traceutil/trace.go:171","msg":"trace[616563023] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:1311; }","duration":"398.877555ms","start":"2026-08-08T05:51:09.271515Z","end":"2026-08-08T05:51:09.670393Z","steps":["trace[616563023] 'agreement among raft nodes before linearized reading' (duration: 398.70781ms)"],"step_count":1} {"level":"warn","ts":"2026-08-08T05:51:09.67046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-08T05:51:09.27149Z","time spent":"398.959527ms","remote":"127.0.0.1:53074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":4,"response size":30,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "}