{"level":"warn","ts":"2026-05-28T00:35:45.654167Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-28T00:35:45.654304Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.77: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.77:2380","--initial-cluster=instance=https://199.204.45.77:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.77:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.77: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-05-28T00:35:45.654612Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-28T00:35:45.654632Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.77:2380"]} {"level":"info","ts":"2026-05-28T00:35:45.654663Z","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-05-28T00:35:45.65553Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.77:2379"]} {"level":"info","ts":"2026-05-28T00:35:45.655628Z","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.77:2380"],"listen-peer-urls":["https://199.204.45.77:2380"],"advertise-client-urls":["https://199.204.45.77:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.77:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.77: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-05-28T00:35:45.661878Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.947553ms"} {"level":"info","ts":"2026-05-28T00:35:45.667863Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9133559b3198d4ec","cluster-id":"60f1aee33b0786f5"} {"level":"info","ts":"2026-05-28T00:35:45.668102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec switched to configuration voters=()"} {"level":"info","ts":"2026-05-28T00:35:45.668138Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became follower at term 0"} {"level":"info","ts":"2026-05-28T00:35:45.668227Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9133559b3198d4ec [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-28T00:35:45.668305Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became follower at term 1"} {"level":"info","ts":"2026-05-28T00:35:45.668407Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec switched to configuration voters=(10462800484352185580)"} {"level":"warn","ts":"2026-05-28T00:35:45.676517Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-28T00:35:45.678147Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-28T00:35:45.679356Z","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-05-28T00:35:45.681351Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9133559b3198d4ec","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-28T00:35:45.681584Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9133559b3198d4ec","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-28T00:35:45.685809Z","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-05-28T00:35:45.685903Z","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-05-28T00:35:45.685922Z","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-05-28T00:35:45.687263Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec switched to configuration voters=(10462800484352185580)"} {"level":"info","ts":"2026-05-28T00:35:45.687479Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"60f1aee33b0786f5","local-member-id":"9133559b3198d4ec","added-peer-id":"9133559b3198d4ec","added-peer-peer-urls":["https://199.204.45.77:2380"]} {"level":"info","ts":"2026-05-28T00:35:45.687695Z","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-05-28T00:35:45.687837Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.77:2380"} {"level":"info","ts":"2026-05-28T00:35:45.687855Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.77:2380"} {"level":"info","ts":"2026-05-28T00:35:45.688894Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9133559b3198d4ec","initial-advertise-peer-urls":["https://199.204.45.77:2380"],"listen-peer-urls":["https://199.204.45.77:2380"],"advertise-client-urls":["https://199.204.45.77:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.77:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-28T00:35:45.68893Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-28T00:35:46.269588Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec is starting a new election at term 1"} {"level":"info","ts":"2026-05-28T00:35:46.269693Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became pre-candidate at term 1"} {"level":"info","ts":"2026-05-28T00:35:46.269756Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec received MsgPreVoteResp from 9133559b3198d4ec at term 1"} {"level":"info","ts":"2026-05-28T00:35:46.269783Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became candidate at term 2"} {"level":"info","ts":"2026-05-28T00:35:46.269801Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec received MsgVoteResp from 9133559b3198d4ec at term 2"} {"level":"info","ts":"2026-05-28T00:35:46.269836Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became leader at term 2"} {"level":"info","ts":"2026-05-28T00:35:46.269858Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9133559b3198d4ec elected leader 9133559b3198d4ec at term 2"} {"level":"info","ts":"2026-05-28T00:35:46.271044Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9133559b3198d4ec","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.77:2379]}","request-path":"/0/members/9133559b3198d4ec/attributes","cluster-id":"60f1aee33b0786f5","publish-timeout":"7s"} {"level":"info","ts":"2026-05-28T00:35:46.271097Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-28T00:35:46.271164Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T00:35:46.271302Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-28T00:35:46.271585Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-28T00:35:46.272078Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-28T00:35:46.27204Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"60f1aee33b0786f5","local-member-id":"9133559b3198d4ec","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T00:35:46.272328Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T00:35:46.2724Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T00:35:46.274593Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.77:2379"} {"level":"info","ts":"2026-05-28T00:35:46.276161Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-28T00:35:56.289188Z","caller":"traceutil/trace.go:171","msg":"trace[775603406] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"116.449136ms","start":"2026-05-28T00:35:56.172614Z","end":"2026-05-28T00:35:56.289063Z","steps":["trace[775603406] 'process raft request' (duration: 116.243821ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T00:35:57.154227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.45145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-28T00:35:57.154363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"637.587497ms","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-05-28T00:35:57.154384Z","caller":"traceutil/trace.go:171","msg":"trace[137606705] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:347; }","duration":"244.979493ms","start":"2026-05-28T00:35:56.90938Z","end":"2026-05-28T00:35:57.15436Z","steps":["trace[137606705] 'range keys from in-memory index tree' (duration: 244.365786ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T00:35:57.154409Z","caller":"traceutil/trace.go:171","msg":"trace[1223348340] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:347; }","duration":"638.035389ms","start":"2026-05-28T00:35:56.516356Z","end":"2026-05-28T00:35:57.154392Z","steps":["trace[1223348340] 'range keys from in-memory index tree' (duration: 637.448023ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T00:35:57.154432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T00:35:56.516327Z","time spent":"638.097411ms","remote":"127.0.0.1:50014","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-05-28T00:36:30.371447Z","caller":"traceutil/trace.go:171","msg":"trace[1212809814] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:607; }","duration":"114.808331ms","start":"2026-05-28T00:36:30.256602Z","end":"2026-05-28T00:36:30.37141Z","steps":["trace[1212809814] 'read index received' (duration: 111.953473ms)","trace[1212809814] 'applied index is now lower than readState.Index' (duration: 2.853908ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T00:36:30.371528Z","caller":"traceutil/trace.go:171","msg":"trace[1736006902] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"252.18172ms","start":"2026-05-28T00:36:30.119288Z","end":"2026-05-28T00:36:30.37147Z","steps":["trace[1736006902] 'process raft request' (duration: 250.407102ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T00:36:30.371801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.276927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-j4p9s\" ","response":"range_response_count:1 size:16961"} {"level":"warn","ts":"2026-05-28T00:36:30.37179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.15444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-05-28T00:36:30.371851Z","caller":"traceutil/trace.go:171","msg":"trace[729116393] range","detail":"{range_begin:/registry/pods/kube-system/cilium-j4p9s; range_end:; response_count:1; response_revision:585; }","duration":"114.39085ms","start":"2026-05-28T00:36:30.257445Z","end":"2026-05-28T00:36:30.371836Z","steps":["trace[729116393] 'agreement among raft nodes before linearized reading' (duration: 114.133552ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T00:36:30.371902Z","caller":"traceutil/trace.go:171","msg":"trace[1652515111] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:585; }","duration":"115.325766ms","start":"2026-05-28T00:36:30.256538Z","end":"2026-05-28T00:36:30.371864Z","steps":["trace[1652515111] 'agreement among raft nodes before linearized reading' (duration: 114.980366ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T00:36:31.400885Z","caller":"traceutil/trace.go:171","msg":"trace[1666602497] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:611; }","duration":"490.622576ms","start":"2026-05-28T00:36:30.910229Z","end":"2026-05-28T00:36:31.400852Z","steps":["trace[1666602497] 'read index received' (duration: 489.72524ms)","trace[1666602497] 'applied index is now lower than readState.Index' (duration: 896.126µs)"],"step_count":2} {"level":"info","ts":"2026-05-28T00:36:31.40095Z","caller":"traceutil/trace.go:171","msg":"trace[407632558] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"526.623471ms","start":"2026-05-28T00:36:30.874279Z","end":"2026-05-28T00:36:31.400903Z","steps":["trace[407632558] 'process raft request' (duration: 525.896251ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T00:36:31.401198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.933284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T00:36:31.401312Z","caller":"traceutil/trace.go:171","msg":"trace[138559083] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:589; }","duration":"491.108008ms","start":"2026-05-28T00:36:30.910174Z","end":"2026-05-28T00:36:31.401282Z","steps":["trace[138559083] 'agreement among raft nodes before linearized reading' (duration: 490.841591ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T00:36:31.401363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T00:36:30.910152Z","time spent":"491.202111ms","remote":"127.0.0.1:49730","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-05-28T00:36:31.40186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T00:36:30.873895Z","time spent":"527.154435ms","remote":"127.0.0.1:49836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036161,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T00:36:32.529398Z","caller":"traceutil/trace.go:171","msg":"trace[1590731088] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"100.635994ms","start":"2026-05-28T00:36:32.428735Z","end":"2026-05-28T00:36:32.529371Z","steps":["trace[1590731088] 'process raft request' (duration: 100.573312ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T00:36:32.529791Z","caller":"traceutil/trace.go:171","msg":"trace[1596404616] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"133.145593ms","start":"2026-05-28T00:36:32.396617Z","end":"2026-05-28T00:36:32.529763Z","steps":["trace[1596404616] 'process raft request' (duration: 131.038116ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T00:36:36.811698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.312141ms","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-05-28T00:36:36.811785Z","caller":"traceutil/trace.go:171","msg":"trace[367786313] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:682; }","duration":"124.462876ms","start":"2026-05-28T00:36:36.687301Z","end":"2026-05-28T00:36:36.811764Z","steps":["trace[367786313] 'range keys from in-memory index tree' (duration: 124.055534ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T00:36:36.811671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.105143ms","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-05-28T00:36:36.811957Z","caller":"traceutil/trace.go:171","msg":"trace[1750879530] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:682; }","duration":"137.40872ms","start":"2026-05-28T00:36:36.674527Z","end":"2026-05-28T00:36:36.811935Z","steps":["trace[1750879530] 'range keys from in-memory index tree' (duration: 136.920368ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T00:36:46.994747Z","caller":"traceutil/trace.go:171","msg":"trace[691978732] linearizableReadLoop","detail":"{readStateIndex:787; appliedIndex:786; }","duration":"396.318605ms","start":"2026-05-28T00:36:46.598397Z","end":"2026-05-28T00:36:46.994716Z","steps":["trace[691978732] 'read index received' (duration: 396.109539ms)","trace[691978732] 'applied index is now lower than readState.Index' (duration: 207.745µs)"],"step_count":2} {"level":"info","ts":"2026-05-28T00:36:46.994791Z","caller":"traceutil/trace.go:171","msg":"trace[704091869] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"629.995219ms","start":"2026-05-28T00:36:46.364747Z","end":"2026-05-28T00:36:46.994742Z","steps":["trace[704091869] 'process raft request' (duration: 629.746762ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T00:36:46.99515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.732327ms","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-05-28T00:36:46.995209Z","caller":"traceutil/trace.go:171","msg":"trace[356046151] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:760; }","duration":"130.84024ms","start":"2026-05-28T00:36:46.864357Z","end":"2026-05-28T00:36:46.995198Z","steps":["trace[356046151] 'agreement among raft nodes before linearized reading' (duration: 130.698307ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T00:36:46.995279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T00:36:46.364724Z","time spent":"630.400849ms","remote":"127.0.0.1:49940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4024,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T00:36:46.995152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.630753ms","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-05-28T00:36:46.995588Z","caller":"traceutil/trace.go:171","msg":"trace[609403864] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:760; }","duration":"397.23332ms","start":"2026-05-28T00:36:46.598345Z","end":"2026-05-28T00:36:46.995578Z","steps":["trace[609403864] 'agreement among raft nodes before linearized reading' (duration: 396.479039ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T00:36:46.995621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T00:36:46.598324Z","time spent":"397.287121ms","remote":"127.0.0.1:50014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-28T00:36:49.136249Z","caller":"traceutil/trace.go:171","msg":"trace[2133559925] transaction","detail":"{read_only:false; response_revision:769; number_of_response:1; }","duration":"122.35938ms","start":"2026-05-28T00:36:49.013866Z","end":"2026-05-28T00:36:49.136226Z","steps":["trace[2133559925] 'process raft request' (duration: 92.501072ms)","trace[2133559925] 'compare' (duration: 29.756185ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T00:37:21.326712Z","caller":"traceutil/trace.go:171","msg":"trace[1921187161] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"136.263323ms","start":"2026-05-28T00:37:21.190429Z","end":"2026-05-28T00:37:21.326692Z","steps":["trace[1921187161] 'process raft request' (duration: 136.14661ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T00:37:21.865728Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15342812217275419747,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-28T00:37:22.282282Z","caller":"traceutil/trace.go:171","msg":"trace[1289080054] linearizableReadLoop","detail":"{readStateIndex:1009; appliedIndex:1007; }","duration":"916.930419ms","start":"2026-05-28T00:37:21.365325Z","end":"2026-05-28T00:37:22.282255Z","steps":["trace[1289080054] 'read index received' (duration: 898.048845ms)","trace[1289080054] 'applied index is now lower than readState.Index' (duration: 18.880294ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T00:37:22.282299Z","caller":"traceutil/trace.go:171","msg":"trace[1696262700] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"927.031014ms","start":"2026-05-28T00:37:21.355227Z","end":"2026-05-28T00:37:22.282258Z","steps":["trace[1696262700] 'process raft request' (duration: 907.990195ms)","trace[1696262700] 'compare' (duration: 18.546145ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T00:37:22.282316Z","caller":"traceutil/trace.go:171","msg":"trace[1846688512] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"457.760845ms","start":"2026-05-28T00:37:21.824539Z","end":"2026-05-28T00:37:22.282299Z","steps":["trace[1846688512] 'process raft request' (duration: 457.619861ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T00:37:22.282402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"917.053842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-28T00:37:22.28243Z","caller":"traceutil/trace.go:171","msg":"trace[1558320906] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:973; }","duration":"917.114094ms","start":"2026-05-28T00:37:21.365309Z","end":"2026-05-28T00:37:22.282423Z","steps":["trace[1558320906] 'agreement among raft nodes before linearized reading' (duration: 917.042742ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T00:37:22.282456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T00:37:21.365302Z","time spent":"917.148544ms","remote":"127.0.0.1:49836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":9,"response size":30,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"warn","ts":"2026-05-28T00:37:22.282459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T00:37:21.355209Z","time spent":"927.167777ms","remote":"127.0.0.1:50014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T00:37:22.28251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"624.91474ms","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-05-28T00:37:22.282541Z","caller":"traceutil/trace.go:171","msg":"trace[1519151930] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:973; }","duration":"625.014644ms","start":"2026-05-28T00:37:21.657517Z","end":"2026-05-28T00:37:22.282531Z","steps":["trace[1519151930] 'agreement among raft nodes before linearized reading' (duration: 624.88984ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T00:37:22.282535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T00:37:21.824512Z","time spent":"457.903208ms","remote":"127.0.0.1:50014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T00:37:22.282576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T00:37:21.657497Z","time spent":"625.069054ms","remote":"127.0.0.1:50014","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-05-28T00:37:22.282615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.695346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T00:37:22.282651Z","caller":"traceutil/trace.go:171","msg":"trace[510444889] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:973; }","duration":"372.76998ms","start":"2026-05-28T00:37:21.909869Z","end":"2026-05-28T00:37:22.282639Z","steps":["trace[510444889] 'agreement among raft nodes before linearized reading' (duration: 372.702718ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T00:37:22.282678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T00:37:21.909849Z","time spent":"372.8224ms","remote":"127.0.0.1:49730","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-05-28T00:37:22.282708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.475324ms","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-05-28T00:37:22.28274Z","caller":"traceutil/trace.go:171","msg":"trace[947466481] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:973; }","duration":"411.525124ms","start":"2026-05-28T00:37:21.871199Z","end":"2026-05-28T00:37:22.282724Z","steps":["trace[947466481] 'agreement among raft nodes before linearized reading' (duration: 411.459293ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T00:37:22.282775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T00:37:21.871158Z","time spent":"411.606977ms","remote":"127.0.0.1:50014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-28T00:37:22.568866Z","caller":"traceutil/trace.go:171","msg":"trace[1805080528] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"281.676936ms","start":"2026-05-28T00:37:22.28716Z","end":"2026-05-28T00:37:22.568837Z","steps":["trace[1805080528] 'process raft request' (duration: 281.136811ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T00:37:22.569051Z","caller":"traceutil/trace.go:171","msg":"trace[493665715] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"282.237171ms","start":"2026-05-28T00:37:22.286644Z","end":"2026-05-28T00:37:22.568882Z","steps":["trace[493665715] 'process raft request' (duration: 281.204633ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T00:37:43.647616Z","caller":"traceutil/trace.go:171","msg":"trace[373901673] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"226.988747ms","start":"2026-05-28T00:37:43.420595Z","end":"2026-05-28T00:37:43.647584Z","steps":["trace[373901673] 'process raft request' (duration: 226.813672ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T00:37:45.705381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.009214ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-28T00:37:45.705501Z","caller":"traceutil/trace.go:171","msg":"trace[1978726714] linearizableReadLoop","detail":"{readStateIndex:1090; appliedIndex:1089; }","duration":"887.424465ms","start":"2026-05-28T00:37:44.818055Z","end":"2026-05-28T00:37:45.705479Z","steps":["trace[1978726714] 'read index received' (duration: 353.129434ms)","trace[1978726714] 'applied index is now lower than readState.Index' (duration: 534.293201ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T00:37:45.70564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"796.98403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T00:37:45.705735Z","caller":"traceutil/trace.go:171","msg":"trace[1682363464] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1049; }","duration":"797.085582ms","start":"2026-05-28T00:37:44.90861Z","end":"2026-05-28T00:37:45.705696Z","steps":["trace[1682363464] 'agreement among raft nodes before linearized reading' (duration: 796.976649ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T00:37:45.705847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T00:37:44.908597Z","time spent":"797.234807ms","remote":"127.0.0.1:49730","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-05-28T00:37:45.705658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"887.59594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-28T00:37:45.706195Z","caller":"traceutil/trace.go:171","msg":"trace[1097812678] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1049; }","duration":"888.177515ms","start":"2026-05-28T00:37:44.818002Z","end":"2026-05-28T00:37:45.706179Z","steps":["trace[1097812678] 'agreement among raft nodes before linearized reading' (duration: 887.572218ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T00:37:45.706316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T00:37:44.81798Z","time spent":"888.316029ms","remote":"127.0.0.1:50080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":16,"response size":30,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"info","ts":"2026-05-28T00:37:45.847836Z","caller":"traceutil/trace.go:171","msg":"trace[544722331] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"137.442995ms","start":"2026-05-28T00:37:45.710373Z","end":"2026-05-28T00:37:45.847816Z","steps":["trace[544722331] 'process raft request' (duration: 137.26751ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T00:37:46.05523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.058191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T00:37:46.055321Z","caller":"traceutil/trace.go:171","msg":"trace[31906878] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1050; }","duration":"146.190554ms","start":"2026-05-28T00:37:45.909111Z","end":"2026-05-28T00:37:46.055301Z","steps":["trace[31906878] 'range keys from in-memory index tree' (duration: 145.959598ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T00:37:47.326625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.476557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T00:37:47.326933Z","caller":"traceutil/trace.go:171","msg":"trace[1342728514] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1055; }","duration":"417.759764ms","start":"2026-05-28T00:37:46.909078Z","end":"2026-05-28T00:37:47.326838Z","steps":["trace[1342728514] 'range keys from in-memory index tree' (duration: 417.323173ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T00:37:47.327058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T00:37:46.909057Z","time spent":"417.982421ms","remote":"127.0.0.1:49714","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-05-28T00:38:00.859118Z","caller":"traceutil/trace.go:171","msg":"trace[431121782] linearizableReadLoop","detail":"{readStateIndex:1195; appliedIndex:1194; }","duration":"155.917976ms","start":"2026-05-28T00:38:00.703182Z","end":"2026-05-28T00:38:00.8591Z","steps":["trace[431121782] 'read index received' (duration: 155.718721ms)","trace[431121782] 'applied index is now lower than readState.Index' (duration: 198.385µs)"],"step_count":2} {"level":"info","ts":"2026-05-28T00:38:00.859353Z","caller":"traceutil/trace.go:171","msg":"trace[516235783] transaction","detail":"{read_only:false; response_revision:1149; number_of_response:1; }","duration":"253.548414ms","start":"2026-05-28T00:38:00.605793Z","end":"2026-05-28T00:38:00.859342Z","steps":["trace[516235783] 'process raft request' (duration: 253.185604ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T00:38:00.859554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.365268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T00:38:00.859595Z","caller":"traceutil/trace.go:171","msg":"trace[1443123067] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1149; }","duration":"156.451961ms","start":"2026-05-28T00:38:00.703132Z","end":"2026-05-28T00:38:00.859584Z","steps":["trace[1443123067] 'agreement among raft nodes before linearized reading' (duration: 156.378909ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T00:38:02.899987Z","caller":"traceutil/trace.go:171","msg":"trace[1445135593] linearizableReadLoop","detail":"{readStateIndex:1201; appliedIndex:1200; }","duration":"244.862148ms","start":"2026-05-28T00:38:02.655109Z","end":"2026-05-28T00:38:02.899971Z","steps":["trace[1445135593] 'read index received' (duration: 244.709184ms)","trace[1445135593] 'applied index is now lower than readState.Index' (duration: 152.344µs)"],"step_count":2} {"level":"info","ts":"2026-05-28T00:38:02.900062Z","caller":"traceutil/trace.go:171","msg":"trace[1300154187] transaction","detail":"{read_only:false; response_revision:1155; number_of_response:1; }","duration":"348.705265ms","start":"2026-05-28T00:38:02.55135Z","end":"2026-05-28T00:38:02.900055Z","steps":["trace[1300154187] 'process raft request' (duration: 348.531161ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T00:38:02.900133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T00:38:02.551326Z","time spent":"348.752527ms","remote":"127.0.0.1:50014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T00:38:02.900787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.656829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T00:38:02.900877Z","caller":"traceutil/trace.go:171","msg":"trace[385761020] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1155; }","duration":"245.796663ms","start":"2026-05-28T00:38:02.655062Z","end":"2026-05-28T00:38:02.900859Z","steps":["trace[385761020] 'agreement among raft nodes before linearized reading' (duration: 245.093694ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T00:38:15.08105Z","caller":"traceutil/trace.go:171","msg":"trace[1070737416] transaction","detail":"{read_only:false; response_revision:1195; number_of_response:1; }","duration":"145.307246ms","start":"2026-05-28T00:38:14.935721Z","end":"2026-05-28T00:38:15.081028Z","steps":["trace[1070737416] 'process raft request' (duration: 144.897325ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T00:38:17.428264Z","caller":"traceutil/trace.go:171","msg":"trace[1252017804] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"119.385392ms","start":"2026-05-28T00:38:17.308851Z","end":"2026-05-28T00:38:17.428236Z","steps":["trace[1252017804] 'process raft request' (duration: 119.158816ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T00:38:19.419919Z","caller":"traceutil/trace.go:171","msg":"trace[61744488] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"259.038783ms","start":"2026-05-28T00:38:19.160848Z","end":"2026-05-28T00:38:19.419887Z","steps":["trace[61744488] 'process raft request' (duration: 250.249275ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T00:38:19.442772Z","caller":"traceutil/trace.go:171","msg":"trace[93692616] linearizableReadLoop","detail":"{readStateIndex:1287; appliedIndex:1283; }","duration":"114.185571ms","start":"2026-05-28T00:38:19.328565Z","end":"2026-05-28T00:38:19.44275Z","steps":["trace[93692616] 'read index received' (duration: 82.507638ms)","trace[93692616] 'applied index is now lower than readState.Index' (duration: 31.676663ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T00:38:19.442842Z","caller":"traceutil/trace.go:171","msg":"trace[507755202] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"281.477455ms","start":"2026-05-28T00:38:19.16134Z","end":"2026-05-28T00:38:19.442818Z","steps":["trace[507755202] 'process raft request' (duration: 281.372422ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T00:38:19.442891Z","caller":"traceutil/trace.go:171","msg":"trace[196610531] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"281.666601ms","start":"2026-05-28T00:38:19.161203Z","end":"2026-05-28T00:38:19.442869Z","steps":["trace[196610531] 'process raft request' (duration: 281.362582ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T00:38:19.442957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.371885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.77\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-28T00:38:19.44299Z","caller":"traceutil/trace.go:171","msg":"trace[2110158295] range","detail":"{range_begin:/registry/masterleases/199.204.45.77; range_end:; response_count:1; response_revision:1238; }","duration":"114.450217ms","start":"2026-05-28T00:38:19.32853Z","end":"2026-05-28T00:38:19.44298Z","steps":["trace[2110158295] 'agreement among raft nodes before linearized reading' (duration: 114.312143ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T00:38:19.443317Z","caller":"traceutil/trace.go:171","msg":"trace[880755678] transaction","detail":"{read_only:false; response_revision:1237; number_of_response:1; }","duration":"281.808434ms","start":"2026-05-28T00:38:19.161315Z","end":"2026-05-28T00:38:19.443124Z","steps":["trace[880755678] 'process raft request' (duration: 281.355892ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T00:38:21.957572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.715353ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-28T00:38:21.958002Z","caller":"traceutil/trace.go:171","msg":"trace[23107882] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"504.9087ms","start":"2026-05-28T00:38:21.453061Z","end":"2026-05-28T00:38:21.95797Z","steps":["trace[23107882] 'process raft request' (duration: 504.596931ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T00:38:21.958034Z","caller":"traceutil/trace.go:171","msg":"trace[514442203] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"504.944061ms","start":"2026-05-28T00:38:21.453056Z","end":"2026-05-28T00:38:21.958Z","steps":["trace[514442203] 'process raft request' (duration: 165.714743ms)","trace[514442203] 'compare' (duration: 338.61072ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T00:38:21.958048Z","caller":"traceutil/trace.go:171","msg":"trace[2112575368] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"282.343039ms","start":"2026-05-28T00:38:21.67567Z","end":"2026-05-28T00:38:21.958013Z","steps":["trace[2112575368] 'process raft request' (duration: 282.061592ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T00:38:21.95815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T00:38:21.453033Z","time spent":"505.054893ms","remote":"127.0.0.1:50014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T00:38:21.958148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T00:38:21.453042Z","time spent":"505.031533ms","remote":"127.0.0.1:50014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T00:38:22.369348Z","caller":"traceutil/trace.go:171","msg":"trace[733659777] linearizableReadLoop","detail":"{readStateIndex:1300; appliedIndex:1299; }","duration":"110.948161ms","start":"2026-05-28T00:38:22.258376Z","end":"2026-05-28T00:38:22.369324Z","steps":["trace[733659777] 'read index received' (duration: 99.236293ms)","trace[733659777] 'applied index is now lower than readState.Index' (duration: 11.710828ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T00:38:22.36949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.091486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T00:38:22.36953Z","caller":"traceutil/trace.go:171","msg":"trace[470060270] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:1250; }","duration":"111.162718ms","start":"2026-05-28T00:38:22.258356Z","end":"2026-05-28T00:38:22.369518Z","steps":["trace[470060270] 'agreement among raft nodes before linearized reading' (duration: 111.063765ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T00:38:22.369641Z","caller":"traceutil/trace.go:171","msg":"trace[1625273473] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"112.605947ms","start":"2026-05-28T00:38:22.256846Z","end":"2026-05-28T00:38:22.369452Z","steps":["trace[1625273473] 'process raft request' (duration: 100.846186ms)","trace[1625273473] 'compare' (duration: 11.539625ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T00:38:22.498877Z","caller":"traceutil/trace.go:171","msg":"trace[212206800] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"118.064454ms","start":"2026-05-28T00:38:22.380795Z","end":"2026-05-28T00:38:22.498859Z","steps":["trace[212206800] 'process raft request' (duration: 90.142484ms)","trace[212206800] 'compare' (duration: 27.817198ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T00:38:31.284035Z","caller":"traceutil/trace.go:171","msg":"trace[1006750783] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"162.530175ms","start":"2026-05-28T00:38:31.121485Z","end":"2026-05-28T00:38:31.284015Z","steps":["trace[1006750783] 'process raft request' (duration: 162.395191ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T00:38:31.772401Z","caller":"traceutil/trace.go:171","msg":"trace[1706829214] linearizableReadLoop","detail":"{readStateIndex:1368; appliedIndex:1367; }","duration":"280.714313ms","start":"2026-05-28T00:38:31.491665Z","end":"2026-05-28T00:38:31.772379Z","steps":["trace[1706829214] 'read index received' (duration: 246.186693ms)","trace[1706829214] 'applied index is now lower than readState.Index' (duration: 34.52676ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T00:38:31.772429Z","caller":"traceutil/trace.go:171","msg":"trace[1575846346] transaction","detail":"{read_only:false; response_revision:1316; number_of_response:1; }","duration":"504.89795ms","start":"2026-05-28T00:38:31.267499Z","end":"2026-05-28T00:38:31.772397Z","steps":["trace[1575846346] 'process raft request' (duration: 470.440562ms)","trace[1575846346] 'compare' (duration: 34.18435ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T00:38:31.772585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T00:38:31.267475Z","time spent":"505.010923ms","remote":"127.0.0.1:50014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T00:38:31.772663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.785993ms","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-05-28T00:38:31.772743Z","caller":"traceutil/trace.go:171","msg":"trace[330412195] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1316; }","duration":"241.892606ms","start":"2026-05-28T00:38:31.530833Z","end":"2026-05-28T00:38:31.772725Z","steps":["trace[330412195] 'agreement among raft nodes before linearized reading' (duration: 241.717381ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T00:38:31.772603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.921929ms","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-05-28T00:38:31.77317Z","caller":"traceutil/trace.go:171","msg":"trace[795355618] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1316; }","duration":"281.534467ms","start":"2026-05-28T00:38:31.491624Z","end":"2026-05-28T00:38:31.773158Z","steps":["trace[795355618] 'agreement among raft nodes before linearized reading' (duration: 280.873879ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T00:42:18.670492Z","caller":"traceutil/trace.go:171","msg":"trace[1581224716] transaction","detail":"{read_only:false; response_revision:2384; number_of_response:1; }","duration":"245.310633ms","start":"2026-05-28T00:42:18.425157Z","end":"2026-05-28T00:42:18.670468Z","steps":["trace[1581224716] 'process raft request' (duration: 245.17566ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T00:42:18.673971Z","caller":"traceutil/trace.go:171","msg":"trace[2069917749] transaction","detail":"{read_only:false; response_revision:2385; number_of_response:1; }","duration":"154.498137ms","start":"2026-05-28T00:42:18.51945Z","end":"2026-05-28T00:42:18.673948Z","steps":["trace[2069917749] 'process raft request' (duration: 154.392584ms)"],"step_count":1}