{"level":"warn","ts":"2026-05-25T14:19:07.930103Z","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-25T14:19:07.930224Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.227: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.227:2380","--initial-cluster=instance=https://199.204.45.227:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.227:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.227: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-25T14:19:07.930291Z","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-25T14:19:07.930301Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-05-25T14:19:07.930322Z","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-25T14:19:07.930973Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"]} {"level":"info","ts":"2026-05-25T14:19:07.931051Z","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.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.227: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-25T14:19:07.935628Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.361599ms"} {"level":"info","ts":"2026-05-25T14:19:07.941756Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"572db18442eba1c2","cluster-id":"fb1028a037bf3cd6"} {"level":"info","ts":"2026-05-25T14:19:07.941826Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=()"} {"level":"info","ts":"2026-05-25T14:19:07.941848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 0"} {"level":"info","ts":"2026-05-25T14:19:07.94186Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 572db18442eba1c2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-25T14:19:07.941867Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 1"} {"level":"info","ts":"2026-05-25T14:19:07.941909Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"warn","ts":"2026-05-25T14:19:07.956455Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-25T14:19:07.959751Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-25T14:19:07.961071Z","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-25T14:19:07.963711Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"572db18442eba1c2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-25T14:19:07.964479Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"572db18442eba1c2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-25T14:19:07.964594Z","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-25T14:19:07.964648Z","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-25T14:19:07.964661Z","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-25T14:19:07.967914Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"info","ts":"2026-05-25T14:19:07.968214Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","added-peer-id":"572db18442eba1c2","added-peer-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-05-25T14:19:07.970204Z","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-25T14:19:07.970392Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-05-25T14:19:07.970468Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-05-25T14:19:07.970524Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"572db18442eba1c2","initial-advertise-peer-urls":["https://199.204.45.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-25T14:19:07.970562Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-25T14:19:08.545944Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 is starting a new election at term 1"} {"level":"info","ts":"2026-05-25T14:19:08.547599Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-25T14:19:08.54822Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgPreVoteResp from 572db18442eba1c2 at term 1"} {"level":"info","ts":"2026-05-25T14:19:08.548259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became candidate at term 2"} {"level":"info","ts":"2026-05-25T14:19:08.548278Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgVoteResp from 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-05-25T14:19:08.548339Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became leader at term 2"} {"level":"info","ts":"2026-05-25T14:19:08.548383Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 572db18442eba1c2 elected leader 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-05-25T14:19:08.628023Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"572db18442eba1c2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.227:2379]}","request-path":"/0/members/572db18442eba1c2/attributes","cluster-id":"fb1028a037bf3cd6","publish-timeout":"7s"} {"level":"info","ts":"2026-05-25T14:19:08.628237Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-25T14:19:08.628313Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-25T14:19:08.628637Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-25T14:19:08.630323Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-25T14:19:08.63037Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-25T14:19:08.632084Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-25T14:19:08.632662Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.227:2379"} {"level":"info","ts":"2026-05-25T14:19:08.668614Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","cluster-version":"3.5"} {"level":"info","ts":"2026-05-25T14:19:08.668869Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-25T14:19:08.668913Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-25T14:19:14.73375Z","caller":"traceutil/trace.go:171","msg":"trace[95024949] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"107.983592ms","start":"2026-05-25T14:19:14.625686Z","end":"2026-05-25T14:19:14.733669Z","steps":["trace[95024949] 'process raft request' (duration: 44.091336ms)","trace[95024949] 'compare' (duration: 63.609821ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T14:19:14.754411Z","caller":"traceutil/trace.go:171","msg":"trace[929373292] transaction","detail":"{read_only:false; number_of_response:0; response_revision:314; }","duration":"100.837724ms","start":"2026-05-25T14:19:14.653553Z","end":"2026-05-25T14:19:14.75439Z","steps":["trace[929373292] 'process raft request' (duration: 100.453216ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:19:14.754558Z","caller":"traceutil/trace.go:171","msg":"trace[1808167427] transaction","detail":"{read_only:false; number_of_response:0; response_revision:314; }","duration":"100.407024ms","start":"2026-05-25T14:19:14.654142Z","end":"2026-05-25T14:19:14.754549Z","steps":["trace[1808167427] 'process raft request' (duration: 99.959725ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:19:14.754642Z","caller":"traceutil/trace.go:171","msg":"trace[1691143653] transaction","detail":"{read_only:false; number_of_response:0; response_revision:314; }","duration":"100.276822ms","start":"2026-05-25T14:19:14.654358Z","end":"2026-05-25T14:19:14.754635Z","steps":["trace[1691143653] 'process raft request' (duration: 99.780672ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:19:15.799125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.572095ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-25T14:19:15.799241Z","caller":"traceutil/trace.go:171","msg":"trace[2082159513] linearizableReadLoop","detail":"{readStateIndex:337; appliedIndex:336; }","duration":"616.708778ms","start":"2026-05-25T14:19:15.182515Z","end":"2026-05-25T14:19:15.799224Z","steps":["trace[2082159513] 'read index received' (duration: 436.458308ms)","trace[2082159513] 'applied index is now lower than readState.Index' (duration: 180.24921ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T14:19:15.799348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.834911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-25T14:19:15.799378Z","caller":"traceutil/trace.go:171","msg":"trace[766441425] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:325; }","duration":"616.912803ms","start":"2026-05-25T14:19:15.18246Z","end":"2026-05-25T14:19:15.799373Z","steps":["trace[766441425] 'agreement among raft nodes before linearized reading' (duration: 616.81015ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:19:15.799403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:19:15.182429Z","time spent":"616.968993ms","remote":"127.0.0.1:45696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-25T14:19:15.799699Z","caller":"traceutil/trace.go:171","msg":"trace[779034059] transaction","detail":"{read_only:false; response_revision:325; number_of_response:1; }","duration":"624.738274ms","start":"2026-05-25T14:19:15.174951Z","end":"2026-05-25T14:19:15.79969Z","steps":["trace[779034059] 'process raft request' (duration: 444.080986ms)","trace[779034059] 'compare' (duration: 179.422562ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T14:19:15.799748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:19:15.174935Z","time spent":"624.794576ms","remote":"127.0.0.1:45620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":209,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-25T14:19:16.979711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"890.093784ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-25T14:19:16.979835Z","caller":"traceutil/trace.go:171","msg":"trace[236954994] linearizableReadLoop","detail":"{readStateIndex:338; appliedIndex:337; }","duration":"1.17531817s","start":"2026-05-25T14:19:15.804499Z","end":"2026-05-25T14:19:16.979817Z","steps":["trace[236954994] 'read index received' (duration: 284.916509ms)","trace[236954994] 'applied index is now lower than readState.Index' (duration: 890.400211ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T14:19:16.980159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.175657928s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslicemirroring-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-25T14:19:16.980255Z","caller":"traceutil/trace.go:171","msg":"trace[1426812614] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"1.176006334s","start":"2026-05-25T14:19:15.804153Z","end":"2026-05-25T14:19:16.98016Z","steps":["trace[1426812614] 'process raft request' (duration: 285.215795ms)","trace[1426812614] 'compare' (duration: 889.941161ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T14:19:16.980372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"878.750268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-25T14:19:16.98048Z","caller":"traceutil/trace.go:171","msg":"trace[1899325679] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:326; }","duration":"878.911932ms","start":"2026-05-25T14:19:16.101544Z","end":"2026-05-25T14:19:16.980456Z","steps":["trace[1899325679] 'agreement among raft nodes before linearized reading' (duration: 878.676487ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:19:16.980372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.195049ms","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-05-25T14:19:16.980536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:19:16.101526Z","time spent":"879.000503ms","remote":"127.0.0.1:45696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-25T14:19:16.980563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:19:15.804126Z","time spent":"1.17627396s","remote":"127.0.0.1:45696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-25T14:19:16.980589Z","caller":"traceutil/trace.go:171","msg":"trace[728385319] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:326; }","duration":"331.464805ms","start":"2026-05-25T14:19:16.649101Z","end":"2026-05-25T14:19:16.980565Z","steps":["trace[728385319] 'agreement among raft nodes before linearized reading' (duration: 331.147569ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:19:16.980754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:19:16.649082Z","time spent":"331.65523ms","remote":"127.0.0.1:45696","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-05-25T14:19:16.980522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"878.882531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-05-25T14:19:16.980858Z","caller":"traceutil/trace.go:171","msg":"trace[1755234396] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:326; }","duration":"879.243298ms","start":"2026-05-25T14:19:16.101589Z","end":"2026-05-25T14:19:16.980833Z","steps":["trace[1755234396] 'agreement among raft nodes before linearized reading' (duration: 878.777289ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:19:16.980909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:19:16.101566Z","time spent":"879.33091ms","remote":"127.0.0.1:45696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-25T14:19:16.980206Z","caller":"traceutil/trace.go:171","msg":"trace[1439502603] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslicemirroring-controller; range_end:; response_count:0; response_revision:326; }","duration":"1.175725618s","start":"2026-05-25T14:19:15.804467Z","end":"2026-05-25T14:19:16.980192Z","steps":["trace[1439502603] 'agreement among raft nodes before linearized reading' (duration: 1.175622086s)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:19:16.981018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:19:15.804455Z","time spent":"1.176555116s","remote":"127.0.0.1:45620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslicemirroring-controller\" "} {"level":"info","ts":"2026-05-25T14:19:18.532925Z","caller":"traceutil/trace.go:171","msg":"trace[619557368] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"138.112897ms","start":"2026-05-25T14:19:18.394772Z","end":"2026-05-25T14:19:18.532885Z","steps":["trace[619557368] 'process raft request' (duration: 83.949115ms)","trace[619557368] 'compare' (duration: 53.906017ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T14:19:18.82922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.307606ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-25T14:19:18.829417Z","caller":"traceutil/trace.go:171","msg":"trace[393250360] linearizableReadLoop","detail":"{readStateIndex:373; appliedIndex:372; }","duration":"194.562247ms","start":"2026-05-25T14:19:18.634766Z","end":"2026-05-25T14:19:18.829328Z","steps":["trace[393250360] 'read index received' (duration: 62.049647ms)","trace[393250360] 'applied index is now lower than readState.Index' (duration: 132.51104ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T14:19:18.829448Z","caller":"traceutil/trace.go:171","msg":"trace[760641839] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"221.190142ms","start":"2026-05-25T14:19:18.608169Z","end":"2026-05-25T14:19:18.829359Z","steps":["trace[760641839] 'process raft request' (duration: 88.659532ms)","trace[760641839] 'compare' (duration: 132.07124ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T14:19:18.829588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.805792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-05-25T14:19:18.82999Z","caller":"traceutil/trace.go:171","msg":"trace[1525585417] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:361; }","duration":"195.198059ms","start":"2026-05-25T14:19:18.634733Z","end":"2026-05-25T14:19:18.829931Z","steps":["trace[1525585417] 'agreement among raft nodes before linearized reading' (duration: 194.75418ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:19:18.848387Z","caller":"traceutil/trace.go:171","msg":"trace[1279673582] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"210.719923ms","start":"2026-05-25T14:19:18.63765Z","end":"2026-05-25T14:19:18.84837Z","steps":["trace[1279673582] 'process raft request' (duration: 210.620041ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:19:18.848639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.9453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-25T14:19:18.848696Z","caller":"traceutil/trace.go:171","msg":"trace[835731532] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:362; }","duration":"113.063952ms","start":"2026-05-25T14:19:18.735621Z","end":"2026-05-25T14:19:18.848685Z","steps":["trace[835731532] 'agreement among raft nodes before linearized reading' (duration: 112.93521ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:19:18.848843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.965687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-05-25T14:19:18.848941Z","caller":"traceutil/trace.go:171","msg":"trace[197961570] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:362; }","duration":"163.171041ms","start":"2026-05-25T14:19:18.685748Z","end":"2026-05-25T14:19:18.848919Z","steps":["trace[197961570] 'agreement among raft nodes before linearized reading' (duration: 162.722581ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:19:18.979031Z","caller":"traceutil/trace.go:171","msg":"trace[747426088] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"119.437337ms","start":"2026-05-25T14:19:18.859569Z","end":"2026-05-25T14:19:18.979006Z","steps":["trace[747426088] 'process raft request' (duration: 119.254382ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:19:18.979029Z","caller":"traceutil/trace.go:171","msg":"trace[275767513] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"121.251124ms","start":"2026-05-25T14:19:18.857715Z","end":"2026-05-25T14:19:18.978966Z","steps":["trace[275767513] 'process raft request' (duration: 92.38964ms)","trace[275767513] 'compare' (duration: 28.522986ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T14:19:18.979369Z","caller":"traceutil/trace.go:171","msg":"trace[2123110077] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"119.667912ms","start":"2026-05-25T14:19:18.859683Z","end":"2026-05-25T14:19:18.979351Z","steps":["trace[2123110077] 'process raft request' (duration: 119.264324ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:19:18.97964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.451139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4017"} {"level":"info","ts":"2026-05-25T14:19:18.979745Z","caller":"traceutil/trace.go:171","msg":"trace[481873813] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:370; }","duration":"122.578931ms","start":"2026-05-25T14:19:18.857139Z","end":"2026-05-25T14:19:18.979717Z","steps":["trace[481873813] 'agreement among raft nodes before linearized reading' (duration: 122.191233ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:19:47.357903Z","caller":"traceutil/trace.go:171","msg":"trace[311203946] linearizableReadLoop","detail":"{readStateIndex:552; appliedIndex:551; }","duration":"191.720951ms","start":"2026-05-25T14:19:47.166142Z","end":"2026-05-25T14:19:47.357863Z","steps":["trace[311203946] 'read index received' (duration: 170.016561ms)","trace[311203946] 'applied index is now lower than readState.Index' (duration: 21.702419ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T14:19:47.358141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.946384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-25T14:19:47.358247Z","caller":"traceutil/trace.go:171","msg":"trace[1948661088] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:532; }","duration":"192.126218ms","start":"2026-05-25T14:19:47.166098Z","end":"2026-05-25T14:19:47.358224Z","steps":["trace[1948661088] 'agreement among raft nodes before linearized reading' (duration: 191.865673ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:19:47.358601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.135905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-25T14:19:47.358824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.220833ms","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-25T14:19:47.358958Z","caller":"traceutil/trace.go:171","msg":"trace[662524273] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:532; }","duration":"112.393137ms","start":"2026-05-25T14:19:47.246518Z","end":"2026-05-25T14:19:47.358911Z","steps":["trace[662524273] 'agreement among raft nodes before linearized reading' (duration: 112.101332ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:19:47.358724Z","caller":"traceutil/trace.go:171","msg":"trace[368336665] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:532; }","duration":"184.320498ms","start":"2026-05-25T14:19:47.174386Z","end":"2026-05-25T14:19:47.358707Z","steps":["trace[368336665] 'agreement among raft nodes before linearized reading' (duration: 184.127055ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:19:49.22587Z","caller":"traceutil/trace.go:171","msg":"trace[348285245] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"102.639982ms","start":"2026-05-25T14:19:49.12319Z","end":"2026-05-25T14:19:49.22583Z","steps":["trace[348285245] 'process raft request' (duration: 97.233074ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:19:49.689374Z","caller":"traceutil/trace.go:171","msg":"trace[1706413143] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"160.202472ms","start":"2026-05-25T14:19:49.529145Z","end":"2026-05-25T14:19:49.689347Z","steps":["trace[1706413143] 'process raft request' (duration: 159.875076ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:19:49.691551Z","caller":"traceutil/trace.go:171","msg":"trace[1942541114] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:660; }","duration":"134.622421ms","start":"2026-05-25T14:19:49.556907Z","end":"2026-05-25T14:19:49.69153Z","steps":["trace[1942541114] 'read index received' (duration: 132.102855ms)","trace[1942541114] 'applied index is now lower than readState.Index' (duration: 2.518465ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T14:19:49.691922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.989807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:570105"} {"level":"info","ts":"2026-05-25T14:19:49.691962Z","caller":"traceutil/trace.go:171","msg":"trace[1049010192] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:639; }","duration":"135.125179ms","start":"2026-05-25T14:19:49.556824Z","end":"2026-05-25T14:19:49.691949Z","steps":["trace[1049010192] 'agreement among raft nodes before linearized reading' (duration: 134.783773ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:19:49.692292Z","caller":"traceutil/trace.go:171","msg":"trace[101520391] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"147.299889ms","start":"2026-05-25T14:19:49.54495Z","end":"2026-05-25T14:19:49.69225Z","steps":["trace[101520391] 'process raft request' (duration: 146.495835ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:19:49.890547Z","caller":"traceutil/trace.go:171","msg":"trace[1958555726] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"161.068568ms","start":"2026-05-25T14:19:49.729445Z","end":"2026-05-25T14:19:49.890514Z","steps":["trace[1958555726] 'process raft request' (duration: 153.685734ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:19:49.89115Z","caller":"traceutil/trace.go:171","msg":"trace[1299369049] linearizableReadLoop","detail":"{readStateIndex:666; appliedIndex:664; }","duration":"104.329834ms","start":"2026-05-25T14:19:49.786792Z","end":"2026-05-25T14:19:49.891122Z","steps":["trace[1299369049] 'read index received' (duration: 96.442291ms)","trace[1299369049] 'applied index is now lower than readState.Index' (duration: 7.886223ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T14:19:49.891465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.644469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutefilters.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:15688"} {"level":"info","ts":"2026-05-25T14:19:49.8915Z","caller":"traceutil/trace.go:171","msg":"trace[849777881] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/httproutefilters.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:643; }","duration":"104.736191ms","start":"2026-05-25T14:19:49.786751Z","end":"2026-05-25T14:19:49.891488Z","steps":["trace[849777881] 'agreement among raft nodes before linearized reading' (duration: 104.470397ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:19:49.89155Z","caller":"traceutil/trace.go:171","msg":"trace[816350221] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"143.561013ms","start":"2026-05-25T14:19:49.747939Z","end":"2026-05-25T14:19:49.8915Z","steps":["trace[816350221] 'process raft request' (duration: 143.053813ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:19:57.075965Z","caller":"traceutil/trace.go:171","msg":"trace[780012885] linearizableReadLoop","detail":"{readStateIndex:730; appliedIndex:729; }","duration":"241.777843ms","start":"2026-05-25T14:19:56.834162Z","end":"2026-05-25T14:19:57.07594Z","steps":["trace[780012885] 'read index received' (duration: 241.716242ms)","trace[780012885] 'applied index is now lower than readState.Index' (duration: 60.751µs)"],"step_count":2} {"level":"info","ts":"2026-05-25T14:19:57.076092Z","caller":"traceutil/trace.go:171","msg":"trace[1674354653] transaction","detail":"{read_only:false; response_revision:706; number_of_response:1; }","duration":"277.742834ms","start":"2026-05-25T14:19:56.798311Z","end":"2026-05-25T14:19:57.076054Z","steps":["trace[1674354653] 'process raft request' (duration: 277.419168ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:19:57.076243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.028487ms","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-25T14:19:57.076279Z","caller":"traceutil/trace.go:171","msg":"trace[1665609364] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:706; }","duration":"242.15553ms","start":"2026-05-25T14:19:56.834114Z","end":"2026-05-25T14:19:57.07627Z","steps":["trace[1665609364] 'agreement among raft nodes before linearized reading' (duration: 241.918136ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:19:57.887371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"786.617302ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-25T14:19:57.887937Z","caller":"traceutil/trace.go:171","msg":"trace[1208195210] linearizableReadLoop","detail":"{readStateIndex:732; appliedIndex:730; }","duration":"711.614428ms","start":"2026-05-25T14:19:57.176114Z","end":"2026-05-25T14:19:57.887728Z","steps":["trace[1208195210] 'read index received' (duration: 56.951µs)","trace[1208195210] 'applied index is now lower than readState.Index' (duration: 711.555627ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T14:19:57.88807Z","caller":"traceutil/trace.go:171","msg":"trace[1467246063] transaction","detail":"{read_only:false; response_revision:707; number_of_response:1; }","duration":"804.505822ms","start":"2026-05-25T14:19:57.083546Z","end":"2026-05-25T14:19:57.888052Z","steps":["trace[1467246063] 'process raft request' (duration: 803.988983ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:19:57.88825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:19:57.083512Z","time spent":"804.636235ms","remote":"127.0.0.1:45696","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-25T14:19:57.888808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"712.694268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-25T14:19:57.888852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.718205ms","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-05-25T14:19:57.888914Z","caller":"traceutil/trace.go:171","msg":"trace[930602438] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:707; }","duration":"444.773446ms","start":"2026-05-25T14:19:57.444118Z","end":"2026-05-25T14:19:57.888892Z","steps":["trace[930602438] 'agreement among raft nodes before linearized reading' (duration: 444.590413ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:19:57.888909Z","caller":"traceutil/trace.go:171","msg":"trace[375061819] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:707; }","duration":"712.849021ms","start":"2026-05-25T14:19:57.176032Z","end":"2026-05-25T14:19:57.888881Z","steps":["trace[375061819] 'agreement among raft nodes before linearized reading' (duration: 712.699288ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:19:57.888949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.564419ms","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-05-25T14:19:57.888965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:19:57.444081Z","time spent":"444.867157ms","remote":"127.0.0.1:45696","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-05-25T14:19:57.888976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:19:57.175991Z","time spent":"712.971114ms","remote":"127.0.0.1:45462","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-25T14:19:57.889004Z","caller":"traceutil/trace.go:171","msg":"trace[743212539] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:707; }","duration":"446.6406ms","start":"2026-05-25T14:19:57.442348Z","end":"2026-05-25T14:19:57.888988Z","steps":["trace[743212539] 'agreement among raft nodes before linearized reading' (duration: 446.486667ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:19:57.889048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:19:57.442336Z","time spent":"446.701351ms","remote":"127.0.0.1:45696","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-05-25T14:19:57.889083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.805732ms","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-05-25T14:19:57.889129Z","caller":"traceutil/trace.go:171","msg":"trace[1121618022] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:707; }","duration":"453.874423ms","start":"2026-05-25T14:19:57.435242Z","end":"2026-05-25T14:19:57.889116Z","steps":["trace[1121618022] 'agreement among raft nodes before linearized reading' (duration: 453.750761ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:19:57.889167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:19:57.435231Z","time spent":"453.928674ms","remote":"127.0.0.1:45696","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-05-25T14:19:57.888636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.410766ms","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-05-25T14:19:57.889466Z","caller":"traceutil/trace.go:171","msg":"trace[641928148] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:707; }","duration":"460.310593ms","start":"2026-05-25T14:19:57.429125Z","end":"2026-05-25T14:19:57.889435Z","steps":["trace[641928148] 'agreement among raft nodes before linearized reading' (duration: 459.263223ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:19:57.889576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:19:57.429099Z","time spent":"460.416384ms","remote":"127.0.0.1:45696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-25T14:19:58.148874Z","caller":"traceutil/trace.go:171","msg":"trace[432393564] transaction","detail":"{read_only:false; response_revision:708; number_of_response:1; }","duration":"254.671756ms","start":"2026-05-25T14:19:57.894146Z","end":"2026-05-25T14:19:58.148817Z","steps":["trace[432393564] 'process raft request' (duration: 215.545972ms)","trace[432393564] 'compare' (duration: 38.803328ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T14:19:58.149128Z","caller":"traceutil/trace.go:171","msg":"trace[1144392482] transaction","detail":"{read_only:false; response_revision:709; number_of_response:1; }","duration":"254.024334ms","start":"2026-05-25T14:19:57.895087Z","end":"2026-05-25T14:19:58.149112Z","steps":["trace[1144392482] 'process raft request' (duration: 253.661946ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:19:58.149372Z","caller":"traceutil/trace.go:171","msg":"trace[1261980983] transaction","detail":"{read_only:false; response_revision:710; number_of_response:1; }","duration":"254.224357ms","start":"2026-05-25T14:19:57.895135Z","end":"2026-05-25T14:19:58.149359Z","steps":["trace[1261980983] 'process raft request' (duration: 253.919511ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:19:58.149565Z","caller":"traceutil/trace.go:171","msg":"trace[804635991] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"254.36925ms","start":"2026-05-25T14:19:57.895186Z","end":"2026-05-25T14:19:58.149555Z","steps":["trace[804635991] 'process raft request' (duration: 254.132306ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:20:12.086213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.151367ms","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-25T14:20:12.086343Z","caller":"traceutil/trace.go:171","msg":"trace[260779328] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:801; }","duration":"124.34212ms","start":"2026-05-25T14:20:11.961979Z","end":"2026-05-25T14:20:12.086321Z","steps":["trace[260779328] 'range keys from in-memory index tree' (duration: 123.995973ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:20:14.993098Z","caller":"traceutil/trace.go:171","msg":"trace[1045155845] transaction","detail":"{read_only:false; response_revision:821; number_of_response:1; }","duration":"140.430129ms","start":"2026-05-25T14:20:14.852605Z","end":"2026-05-25T14:20:14.993035Z","steps":["trace[1045155845] 'process raft request' (duration: 140.175155ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:20:15.098907Z","caller":"traceutil/trace.go:171","msg":"trace[1888412011] transaction","detail":"{read_only:false; response_revision:822; number_of_response:1; }","duration":"175.730747ms","start":"2026-05-25T14:20:14.923139Z","end":"2026-05-25T14:20:15.09887Z","steps":["trace[1888412011] 'process raft request' (duration: 165.566322ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:20:38.603572Z","caller":"traceutil/trace.go:171","msg":"trace[93249458] transaction","detail":"{read_only:false; response_revision:1031; number_of_response:1; }","duration":"163.083358ms","start":"2026-05-25T14:20:38.440456Z","end":"2026-05-25T14:20:38.60354Z","steps":["trace[93249458] 'process raft request' (duration: 131.855048ms)","trace[93249458] 'compare' (duration: 31.055547ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T14:20:38.604119Z","caller":"traceutil/trace.go:171","msg":"trace[2114431174] transaction","detail":"{read_only:false; response_revision:1032; number_of_response:1; }","duration":"163.373594ms","start":"2026-05-25T14:20:38.440701Z","end":"2026-05-25T14:20:38.604075Z","steps":["trace[2114431174] 'process raft request' (duration: 162.795473ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:21:22.806641Z","caller":"traceutil/trace.go:171","msg":"trace[901307599] transaction","detail":"{read_only:false; response_revision:1178; number_of_response:1; }","duration":"136.083697ms","start":"2026-05-25T14:21:22.670533Z","end":"2026-05-25T14:21:22.806617Z","steps":["trace[901307599] 'process raft request' (duration: 135.719639ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:21:22.810201Z","caller":"traceutil/trace.go:171","msg":"trace[818782022] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"136.956676ms","start":"2026-05-25T14:21:22.673223Z","end":"2026-05-25T14:21:22.810179Z","steps":["trace[818782022] 'process raft request' (duration: 136.877914ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:21:41.270496Z","caller":"traceutil/trace.go:171","msg":"trace[664212417] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"115.263872ms","start":"2026-05-25T14:21:41.155201Z","end":"2026-05-25T14:21:41.270465Z","steps":["trace[664212417] 'process raft request' (duration: 114.665519ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:21:44.758421Z","caller":"traceutil/trace.go:171","msg":"trace[977077194] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"165.395349ms","start":"2026-05-25T14:21:44.593001Z","end":"2026-05-25T14:21:44.758397Z","steps":["trace[977077194] 'process raft request' (duration: 165.262706ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:22:15.320885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.779117ms","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-25T14:22:15.320942Z","caller":"traceutil/trace.go:171","msg":"trace[726720468] transaction","detail":"{read_only:false; response_revision:1388; number_of_response:1; }","duration":"160.259227ms","start":"2026-05-25T14:22:15.160656Z","end":"2026-05-25T14:22:15.320915Z","steps":["trace[726720468] 'process raft request' (duration: 130.097601ms)","trace[726720468] 'compare' (duration: 29.787948ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T14:22:15.321047Z","caller":"traceutil/trace.go:171","msg":"trace[2047139765] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1387; }","duration":"161.027812ms","start":"2026-05-25T14:22:15.159983Z","end":"2026-05-25T14:22:15.321011Z","steps":["trace[2047139765] 'range keys from in-memory index tree' (duration: 160.459801ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:22:16.501249Z","caller":"traceutil/trace.go:171","msg":"trace[1295394250] transaction","detail":"{read_only:false; response_revision:1395; number_of_response:1; }","duration":"103.721565ms","start":"2026-05-25T14:22:16.397471Z","end":"2026-05-25T14:22:16.501193Z","steps":["trace[1295394250] 'process raft request' (duration: 103.341758ms)"],"step_count":1}