{"level":"warn","ts":"2026-07-12T01:44:08.136814Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-12T01:44:08.136911Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.3: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.3:2380","--initial-cluster=instance=https://199.204.45.3:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.3:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.3: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-07-12T01:44:08.136989Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-12T01:44:08.137008Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.3:2380"]} {"level":"info","ts":"2026-07-12T01:44:08.13703Z","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-07-12T01:44:08.137882Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"]} {"level":"info","ts":"2026-07-12T01:44:08.138006Z","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.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.3: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-07-12T01:44:08.143191Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.909913ms"} {"level":"info","ts":"2026-07-12T01:44:08.149278Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"597401b06ce1cf3d","cluster-id":"dfc54657ad8a2432"} {"level":"info","ts":"2026-07-12T01:44:08.149344Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=()"} {"level":"info","ts":"2026-07-12T01:44:08.149432Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 0"} {"level":"info","ts":"2026-07-12T01:44:08.149451Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 597401b06ce1cf3d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-12T01:44:08.149461Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 1"} {"level":"info","ts":"2026-07-12T01:44:08.149496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"} {"level":"warn","ts":"2026-07-12T01:44:08.155902Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-12T01:44:08.160807Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-12T01:44:08.168957Z","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-07-12T01:44:08.171162Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"597401b06ce1cf3d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-12T01:44:08.171286Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"597401b06ce1cf3d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-12T01:44:08.17149Z","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-07-12T01:44:08.171556Z","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-07-12T01:44:08.171567Z","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-07-12T01:44:08.17281Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"} {"level":"info","ts":"2026-07-12T01:44:08.173713Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","added-peer-id":"597401b06ce1cf3d","added-peer-peer-urls":["https://199.204.45.3:2380"]} {"level":"info","ts":"2026-07-12T01:44:08.175305Z","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-07-12T01:44:08.175537Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"597401b06ce1cf3d","initial-advertise-peer-urls":["https://199.204.45.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-12T01:44:08.175581Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-12T01:44:08.176149Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.3:2380"} {"level":"info","ts":"2026-07-12T01:44:08.176203Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.3:2380"} {"level":"info","ts":"2026-07-12T01:44:08.649671Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d is starting a new election at term 1"} {"level":"info","ts":"2026-07-12T01:44:08.649743Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became pre-candidate at term 1"} {"level":"info","ts":"2026-07-12T01:44:08.649784Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgPreVoteResp from 597401b06ce1cf3d at term 1"} {"level":"info","ts":"2026-07-12T01:44:08.64981Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became candidate at term 2"} {"level":"info","ts":"2026-07-12T01:44:08.649826Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgVoteResp from 597401b06ce1cf3d at term 2"} {"level":"info","ts":"2026-07-12T01:44:08.649847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became leader at term 2"} {"level":"info","ts":"2026-07-12T01:44:08.649866Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 597401b06ce1cf3d elected leader 597401b06ce1cf3d at term 2"} {"level":"info","ts":"2026-07-12T01:44:08.70209Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-12T01:44:08.703616Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-12T01:44:08.7036Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"597401b06ce1cf3d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.3:2379]}","request-path":"/0/members/597401b06ce1cf3d/attributes","cluster-id":"dfc54657ad8a2432","publish-timeout":"7s"} {"level":"info","ts":"2026-07-12T01:44:08.704075Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-12T01:44:08.704523Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-12T01:44:08.704639Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-12T01:44:08.705223Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","cluster-version":"3.5"} {"level":"info","ts":"2026-07-12T01:44:08.70533Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-12T01:44:08.705365Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-12T01:44:08.708083Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.3:2379"} {"level":"info","ts":"2026-07-12T01:44:08.710463Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-12T01:44:15.672878Z","caller":"traceutil/trace.go:171","msg":"trace[756972151] transaction","detail":"{read_only:false; response_revision:330; number_of_response:1; }","duration":"116.946689ms","start":"2026-07-12T01:44:15.555904Z","end":"2026-07-12T01:44:15.672851Z","steps":["trace[756972151] 'process raft request' (duration: 116.797167ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:44:22.056928Z","caller":"traceutil/trace.go:171","msg":"trace[146247554] linearizableReadLoop","detail":"{readStateIndex:413; appliedIndex:412; }","duration":"259.670656ms","start":"2026-07-12T01:44:21.797228Z","end":"2026-07-12T01:44:22.056899Z","steps":["trace[146247554] 'read index received' (duration: 259.530585ms)","trace[146247554] 'applied index is now lower than readState.Index' (duration: 138.601µs)"],"step_count":2} {"level":"warn","ts":"2026-07-12T01:44:22.056963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:21.524613Z","time spent":"532.344675ms","remote":"127.0.0.1:50924","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-07-12T01:44:22.057157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.920168ms","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-07-12T01:44:22.05725Z","caller":"traceutil/trace.go:171","msg":"trace[1750723871] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:400; }","duration":"260.061429ms","start":"2026-07-12T01:44:21.797172Z","end":"2026-07-12T01:44:22.057233Z","steps":["trace[1750723871] 'agreement among raft nodes before linearized reading' (duration: 259.897858ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:44:22.973211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.818398ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-12T01:44:22.973365Z","caller":"traceutil/trace.go:171","msg":"trace[118166972] linearizableReadLoop","detail":"{readStateIndex:415; appliedIndex:413; }","duration":"904.734788ms","start":"2026-07-12T01:44:22.06862Z","end":"2026-07-12T01:44:22.973355Z","steps":["trace[118166972] 'read index received' (duration: 182.566486ms)","trace[118166972] 'applied index is now lower than readState.Index' (duration: 722.167812ms)"],"step_count":2} {"level":"info","ts":"2026-07-12T01:44:22.973466Z","caller":"traceutil/trace.go:171","msg":"trace[121180597] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"911.379154ms","start":"2026-07-12T01:44:22.06208Z","end":"2026-07-12T01:44:22.973459Z","steps":["trace[121180597] 'process raft request' (duration: 911.210762ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:44:22.973513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:22.062069Z","time spent":"911.423404ms","remote":"127.0.0.1:51186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-12T01:44:22.97353Z","caller":"traceutil/trace.go:171","msg":"trace[490684623] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"914.131261ms","start":"2026-07-12T01:44:22.059363Z","end":"2026-07-12T01:44:22.973494Z","steps":["trace[490684623] 'process raft request' (duration: 191.715287ms)","trace[490684623] 'compare' (duration: 721.726237ms)"],"step_count":2} {"level":"warn","ts":"2026-07-12T01:44:22.973648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:22.05933Z","time spent":"914.262433ms","remote":"127.0.0.1:50924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":116,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-12T01:44:22.973688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"843.363044ms","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-07-12T01:44:22.973726Z","caller":"traceutil/trace.go:171","msg":"trace[944406419] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:402; }","duration":"843.435964ms","start":"2026-07-12T01:44:22.130284Z","end":"2026-07-12T01:44:22.97372Z","steps":["trace[944406419] 'agreement among raft nodes before linearized reading' (duration: 843.319333ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:44:22.973779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:22.130266Z","time spent":"843.477664ms","remote":"127.0.0.1:51186","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-07-12T01:44:22.973907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"905.295553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-12T01:44:22.97394Z","caller":"traceutil/trace.go:171","msg":"trace[204552632] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:402; }","duration":"905.359904ms","start":"2026-07-12T01:44:22.068575Z","end":"2026-07-12T01:44:22.973935Z","steps":["trace[204552632] 'agreement among raft nodes before linearized reading' (duration: 905.316634ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:44:22.973965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:22.068553Z","time spent":"905.408255ms","remote":"127.0.0.1:50874","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-07-12T01:44:22.974007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"712.369384ms","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-07-12T01:44:22.974064Z","caller":"traceutil/trace.go:171","msg":"trace[962113070] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:402; }","duration":"712.465695ms","start":"2026-07-12T01:44:22.261588Z","end":"2026-07-12T01:44:22.974053Z","steps":["trace[962113070] 'agreement among raft nodes before linearized reading' (duration: 712.345043ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:44:22.974102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:22.261571Z","time spent":"712.520675ms","remote":"127.0.0.1:51186","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":"warn","ts":"2026-07-12T01:44:22.97407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.589606ms","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-07-12T01:44:22.974175Z","caller":"traceutil/trace.go:171","msg":"trace[327717672] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:402; }","duration":"616.736387ms","start":"2026-07-12T01:44:22.357413Z","end":"2026-07-12T01:44:22.97415Z","steps":["trace[327717672] 'agreement among raft nodes before linearized reading' (duration: 616.519215ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:44:22.974242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:22.357374Z","time spent":"616.856838ms","remote":"127.0.0.1:51186","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":"warn","ts":"2026-07-12T01:44:22.974235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.898189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6957"} {"level":"info","ts":"2026-07-12T01:44:22.974374Z","caller":"traceutil/trace.go:171","msg":"trace[1390667637] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:402; }","duration":"532.0861ms","start":"2026-07-12T01:44:22.442252Z","end":"2026-07-12T01:44:22.974338Z","steps":["trace[1390667637] 'agreement among raft nodes before linearized reading' (duration: 531.755177ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:44:22.974446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:22.442236Z","time spent":"532.199942ms","remote":"127.0.0.1:51086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":6980,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"info","ts":"2026-07-12T01:44:23.136884Z","caller":"traceutil/trace.go:171","msg":"trace[838837824] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"157.347648ms","start":"2026-07-12T01:44:22.979513Z","end":"2026-07-12T01:44:23.13686Z","steps":["trace[838837824] 'process raft request' (duration: 156.58747ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:44:23.137004Z","caller":"traceutil/trace.go:171","msg":"trace[1023496561] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"157.426279ms","start":"2026-07-12T01:44:22.979537Z","end":"2026-07-12T01:44:23.136963Z","steps":["trace[1023496561] 'process raft request' (duration: 157.185207ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:44:23.137075Z","caller":"traceutil/trace.go:171","msg":"trace[370070049] linearizableReadLoop","detail":"{readStateIndex:418; appliedIndex:416; }","duration":"157.343988ms","start":"2026-07-12T01:44:22.979717Z","end":"2026-07-12T01:44:23.137061Z","steps":["trace[370070049] 'read index received' (duration: 85.132999ms)","trace[370070049] 'applied index is now lower than readState.Index' (duration: 72.209969ms)"],"step_count":2} {"level":"warn","ts":"2026-07-12T01:44:23.13722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.469199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-12T01:44:23.13754Z","caller":"traceutil/trace.go:171","msg":"trace[113679187] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:406; }","duration":"157.870744ms","start":"2026-07-12T01:44:22.97964Z","end":"2026-07-12T01:44:23.137511Z","steps":["trace[113679187] 'agreement among raft nodes before linearized reading' (duration: 157.460709ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:44:23.137255Z","caller":"traceutil/trace.go:171","msg":"trace[1135185510] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"152.836423ms","start":"2026-07-12T01:44:22.984392Z","end":"2026-07-12T01:44:23.137228Z","steps":["trace[1135185510] 'process raft request' (duration: 152.404228ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:44:45.73984Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933267122539649423,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-12T01:44:45.76779Z","caller":"traceutil/trace.go:171","msg":"trace[2035963993] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"536.927511ms","start":"2026-07-12T01:44:45.230822Z","end":"2026-07-12T01:44:45.767749Z","steps":["trace[2035963993] 'process raft request' (duration: 536.68211ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:44:45.767963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:45.230802Z","time spent":"537.09298ms","remote":"127.0.0.1:50936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-12T01:44:45.788058Z","caller":"traceutil/trace.go:171","msg":"trace[666797377] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"543.447879ms","start":"2026-07-12T01:44:45.244587Z","end":"2026-07-12T01:44:45.788035Z","steps":["trace[666797377] 'process raft request' (duration: 543.308392ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:44:45.788178Z","caller":"traceutil/trace.go:171","msg":"trace[548419723] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"543.503901ms","start":"2026-07-12T01:44:45.244646Z","end":"2026-07-12T01:44:45.78815Z","steps":["trace[548419723] 'process raft request' (duration: 543.348644ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:44:45.788229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:45.244553Z","time spent":"543.575934ms","remote":"127.0.0.1:50936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-12T01:44:45.788358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:45.244641Z","time spent":"543.608696ms","remote":"127.0.0.1:50936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-12T01:44:45.788507Z","caller":"traceutil/trace.go:171","msg":"trace[307611891] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"527.563666ms","start":"2026-07-12T01:44:45.260912Z","end":"2026-07-12T01:44:45.788476Z","steps":["trace[307611891] 'process raft request' (duration: 527.123725ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:44:45.788602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:45.260891Z","time spent":"527.680272ms","remote":"127.0.0.1:50936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-12T01:44:45.788752Z","caller":"traceutil/trace.go:171","msg":"trace[644494766] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"520.773725ms","start":"2026-07-12T01:44:45.267924Z","end":"2026-07-12T01:44:45.788698Z","steps":["trace[644494766] 'process raft request' (duration: 520.151065ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:44:45.78894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:45.267906Z","time spent":"520.950053ms","remote":"127.0.0.1:50936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-12T01:44:45.789035Z","caller":"traceutil/trace.go:171","msg":"trace[848572703] linearizableReadLoop","detail":"{readStateIndex:555; appliedIndex:543; }","duration":"549.951124ms","start":"2026-07-12T01:44:45.239068Z","end":"2026-07-12T01:44:45.789019Z","steps":["trace[848572703] 'read index received' (duration: 528.476199ms)","trace[848572703] 'applied index is now lower than readState.Index' (duration: 21.474065ms)"],"step_count":2} {"level":"info","ts":"2026-07-12T01:44:45.789111Z","caller":"traceutil/trace.go:171","msg":"trace[1904291173] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"392.226092ms","start":"2026-07-12T01:44:45.396876Z","end":"2026-07-12T01:44:45.789102Z","steps":["trace[1904291173] 'process raft request' (duration: 392.081875ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:44:45.789066Z","caller":"traceutil/trace.go:171","msg":"trace[1286367972] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"510.112366ms","start":"2026-07-12T01:44:45.278924Z","end":"2026-07-12T01:44:45.789036Z","steps":["trace[1286367972] 'process raft request' (duration: 509.806751ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:44:45.789154Z","caller":"traceutil/trace.go:171","msg":"trace[513060155] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"517.077565ms","start":"2026-07-12T01:44:45.272065Z","end":"2026-07-12T01:44:45.789143Z","steps":["trace[513060155] 'process raft request' (duration: 516.567551ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:44:45.789166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:45.396825Z","time spent":"392.312116ms","remote":"127.0.0.1:50936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-12T01:44:45.789131Z","caller":"traceutil/trace.go:171","msg":"trace[1086853942] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"486.845794ms","start":"2026-07-12T01:44:45.302228Z","end":"2026-07-12T01:44:45.789074Z","steps":["trace[1086853942] 'process raft request' (duration: 486.595462ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:44:45.789258Z","caller":"traceutil/trace.go:171","msg":"trace[151914383] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"521.001476ms","start":"2026-07-12T01:44:45.268245Z","end":"2026-07-12T01:44:45.789247Z","steps":["trace[151914383] 'process raft request' (duration: 520.345375ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:44:45.789284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:45.278916Z","time spent":"510.279005ms","remote":"127.0.0.1:50936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-12T01:44:45.789307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.232858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-07-12T01:44:45.789311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:45.268236Z","time spent":"521.054959ms","remote":"127.0.0.1:50936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-12T01:44:45.789341Z","caller":"traceutil/trace.go:171","msg":"trace[528333080] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:537; }","duration":"550.308832ms","start":"2026-07-12T01:44:45.239023Z","end":"2026-07-12T01:44:45.789332Z","steps":["trace[528333080] 'agreement among raft nodes before linearized reading' (duration: 550.218617ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:44:45.789376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:45.239002Z","time spent":"550.366544ms","remote":"127.0.0.1:51186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-12T01:44:45.78944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:45.302204Z","time spent":"487.080946ms","remote":"127.0.0.1:50936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-12T01:44:45.789469Z","caller":"traceutil/trace.go:171","msg":"trace[809264692] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"508.807323ms","start":"2026-07-12T01:44:45.280653Z","end":"2026-07-12T01:44:45.78946Z","steps":["trace[809264692] 'process raft request' (duration: 508.12261ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:44:45.789516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:45.280645Z","time spent":"508.848515ms","remote":"127.0.0.1:50936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-12T01:44:45.789566Z","caller":"traceutil/trace.go:171","msg":"trace[2087885785] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"512.077642ms","start":"2026-07-12T01:44:45.277445Z","end":"2026-07-12T01:44:45.789523Z","steps":["trace[2087885785] 'process raft request' (duration: 511.239561ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:44:45.789217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:45.272053Z","time spent":"517.135068ms","remote":"127.0.0.1:50936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-12T01:44:45.789664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:45.27743Z","time spent":"512.175447ms","remote":"127.0.0.1:50936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-12T01:44:45.796804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.66424ms","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-07-12T01:44:45.79687Z","caller":"traceutil/trace.go:171","msg":"trace[847520938] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:539; }","duration":"557.750494ms","start":"2026-07-12T01:44:45.239106Z","end":"2026-07-12T01:44:45.796856Z","steps":["trace[847520938] 'agreement among raft nodes before linearized reading' (duration: 557.630448ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:44:45.796951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:45.239101Z","time spent":"557.840529ms","remote":"127.0.0.1:51186","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-07-12T01:44:52.678387Z","caller":"traceutil/trace.go:171","msg":"trace[1183964823] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:650; }","duration":"227.699752ms","start":"2026-07-12T01:44:52.450659Z","end":"2026-07-12T01:44:52.678358Z","steps":["trace[1183964823] 'read index received' (duration: 226.894055ms)","trace[1183964823] 'applied index is now lower than readState.Index' (duration: 804.767µs)"],"step_count":2} {"level":"info","ts":"2026-07-12T01:44:52.678596Z","caller":"traceutil/trace.go:171","msg":"trace[1681681656] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"649.977484ms","start":"2026-07-12T01:44:52.028574Z","end":"2026-07-12T01:44:52.678552Z","steps":["trace[1681681656] 'process raft request' (duration: 649.20861ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:44:52.678719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.034607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-cx72f\" ","response":"range_response_count:1 size:16957"} {"level":"info","ts":"2026-07-12T01:44:52.678815Z","caller":"traceutil/trace.go:171","msg":"trace[977096340] range","detail":"{range_begin:/registry/pods/kube-system/cilium-cx72f; range_end:; response_count:1; response_revision:626; }","duration":"228.184123ms","start":"2026-07-12T01:44:52.450609Z","end":"2026-07-12T01:44:52.678793Z","steps":["trace[977096340] 'agreement among raft nodes before linearized reading' (duration: 227.903441ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:44:52.678807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:52.028542Z","time spent":"650.161842ms","remote":"127.0.0.1:50982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036157,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-12T01:44:53.717158Z","caller":"traceutil/trace.go:171","msg":"trace[1961730234] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"586.134056ms","start":"2026-07-12T01:44:53.130989Z","end":"2026-07-12T01:44:53.717123Z","steps":["trace[1961730234] 'process raft request' (duration: 585.941277ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:44:53.717349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:53.130965Z","time spent":"586.294403ms","remote":"127.0.0.1:51186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-12T01:44:54.999123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.494146ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-12T01:44:54.999298Z","caller":"traceutil/trace.go:171","msg":"trace[326664843] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"1.794350008s","start":"2026-07-12T01:44:53.204909Z","end":"2026-07-12T01:44:54.999259Z","steps":["trace[326664843] 'process raft request' (duration: 1.498541328s)","trace[326664843] 'compare' (duration: 295.11421ms)"],"step_count":2} {"level":"info","ts":"2026-07-12T01:44:54.99936Z","caller":"traceutil/trace.go:171","msg":"trace[434311113] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"1.062764427s","start":"2026-07-12T01:44:53.936571Z","end":"2026-07-12T01:44:54.999336Z","steps":["trace[434311113] 'process raft request' (duration: 1.062669833s)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:44:54.999471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:53.936552Z","time spent":"1.062855991s","remote":"127.0.0.1:51186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-12T01:44:54.999589Z","caller":"traceutil/trace.go:171","msg":"trace[2113158974] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:653; }","duration":"1.774878881s","start":"2026-07-12T01:44:53.224569Z","end":"2026-07-12T01:44:54.999447Z","steps":["trace[2113158974] 'read index received' (duration: 492.46352ms)","trace[2113158974] 'applied index is now lower than readState.Index' (duration: 1.282412311s)"],"step_count":2} {"level":"warn","ts":"2026-07-12T01:44:54.99996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:53.204876Z","time spent":"1.794498605s","remote":"127.0.0.1:50982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036193,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-12T01:44:54.999909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.77533325s","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-07-12T01:44:55.000168Z","caller":"traceutil/trace.go:171","msg":"trace[1280945210] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:631; }","duration":"1.775604782s","start":"2026-07-12T01:44:53.224509Z","end":"2026-07-12T01:44:55.000114Z","steps":["trace[1280945210] 'agreement among raft nodes before linearized reading' (duration: 1.775193334s)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:44:55.000299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:53.224486Z","time spent":"1.77577585s","remote":"127.0.0.1:51186","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-07-12T01:44:55.000758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.096629317s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-07-12T01:44:55.0008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.101306945s","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-07-12T01:44:55.000894Z","caller":"traceutil/trace.go:171","msg":"trace[1387221776] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:631; }","duration":"1.101442661s","start":"2026-07-12T01:44:53.899436Z","end":"2026-07-12T01:44:55.000879Z","steps":["trace[1387221776] 'agreement among raft nodes before linearized reading' (duration: 1.101212051s)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:44:55.000944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:53.899416Z","time spent":"1.101516594s","remote":"127.0.0.1:51186","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-07-12T01:44:55.00101Z","caller":"traceutil/trace.go:171","msg":"trace[1099423869] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:631; }","duration":"1.096772453s","start":"2026-07-12T01:44:53.904092Z","end":"2026-07-12T01:44:55.000865Z","steps":["trace[1099423869] 'agreement among raft nodes before linearized reading' (duration: 1.096559694s)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:44:55.001118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:53.904083Z","time spent":"1.097019864s","remote":"127.0.0.1:51186","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-07-12T01:45:06.707729Z","caller":"traceutil/trace.go:171","msg":"trace[1913962574] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"163.917482ms","start":"2026-07-12T01:45:06.543784Z","end":"2026-07-12T01:45:06.707702Z","steps":["trace[1913962574] 'process raft request' (duration: 163.629981ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:45:09.489804Z","caller":"traceutil/trace.go:171","msg":"trace[412434361] linearizableReadLoop","detail":"{readStateIndex:826; appliedIndex:825; }","duration":"398.364419ms","start":"2026-07-12T01:45:09.09141Z","end":"2026-07-12T01:45:09.489774Z","steps":["trace[412434361] 'read index received' (duration: 398.206183ms)","trace[412434361] 'applied index is now lower than readState.Index' (duration: 156.776µs)"],"step_count":2} {"level":"info","ts":"2026-07-12T01:45:09.489992Z","caller":"traceutil/trace.go:171","msg":"trace[1233889057] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"413.079006ms","start":"2026-07-12T01:45:09.076867Z","end":"2026-07-12T01:45:09.489946Z","steps":["trace[1233889057] 'process raft request' (duration: 412.736953ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:45:09.490069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.640459ms","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-07-12T01:45:09.490105Z","caller":"traceutil/trace.go:171","msg":"trace[1540848055] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:797; }","duration":"398.729072ms","start":"2026-07-12T01:45:09.091365Z","end":"2026-07-12T01:45:09.490094Z","steps":["trace[1540848055] 'agreement among raft nodes before linearized reading' (duration: 398.583087ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:45:09.490138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:45:09.091348Z","time spent":"398.782215ms","remote":"127.0.0.1:51186","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-07-12T01:45:09.490182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:45:09.076849Z","time spent":"413.240092ms","remote":"127.0.0.1:51186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-12T01:45:09.490156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.38982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-12T01:45:09.490264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.799782ms","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-07-12T01:45:09.490286Z","caller":"traceutil/trace.go:171","msg":"trace[1756261943] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:797; }","duration":"114.593228ms","start":"2026-07-12T01:45:09.375675Z","end":"2026-07-12T01:45:09.490268Z","steps":["trace[1756261943] 'agreement among raft nodes before linearized reading' (duration: 114.37085ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:45:09.490336Z","caller":"traceutil/trace.go:171","msg":"trace[813289680] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:797; }","duration":"395.898686ms","start":"2026-07-12T01:45:09.094419Z","end":"2026-07-12T01:45:09.490317Z","steps":["trace[813289680] 'agreement among raft nodes before linearized reading' (duration: 395.612895ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:45:09.490376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:45:09.094412Z","time spent":"395.953838ms","remote":"127.0.0.1:51186","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-07-12T01:45:09.819494Z","caller":"traceutil/trace.go:171","msg":"trace[1094938228] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"324.429751ms","start":"2026-07-12T01:45:09.495032Z","end":"2026-07-12T01:45:09.819462Z","steps":["trace[1094938228] 'process raft request' (duration: 224.839511ms)","trace[1094938228] 'compare' (duration: 99.473275ms)"],"step_count":2} {"level":"warn","ts":"2026-07-12T01:45:09.819656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:45:09.495002Z","time spent":"324.573746ms","remote":"127.0.0.1:51186","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-07-12T01:45:09.824896Z","caller":"traceutil/trace.go:171","msg":"trace[1667362313] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"329.722271ms","start":"2026-07-12T01:45:09.495158Z","end":"2026-07-12T01:45:09.82488Z","steps":["trace[1667362313] 'process raft request' (duration: 329.600286ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:45:09.825052Z","caller":"traceutil/trace.go:171","msg":"trace[652953534] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"259.109898ms","start":"2026-07-12T01:45:09.565911Z","end":"2026-07-12T01:45:09.825021Z","steps":["trace[652953534] 'process raft request' (duration: 258.926221ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:45:09.825092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:45:09.495133Z","time spent":"329.907238ms","remote":"127.0.0.1:51186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-12T01:45:36.171369Z","caller":"traceutil/trace.go:171","msg":"trace[1670390762] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"216.096253ms","start":"2026-07-12T01:45:35.955236Z","end":"2026-07-12T01:45:36.171332Z","steps":["trace[1670390762] 'process raft request' (duration: 184.911376ms)","trace[1670390762] 'compare' (duration: 30.535548ms)"],"step_count":2} {"level":"info","ts":"2026-07-12T01:45:36.171509Z","caller":"traceutil/trace.go:171","msg":"trace[463686832] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"215.936158ms","start":"2026-07-12T01:45:35.955552Z","end":"2026-07-12T01:45:36.171489Z","steps":["trace[463686832] 'process raft request' (duration: 215.583837ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:45:36.171671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.571096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-12T01:45:36.171702Z","caller":"traceutil/trace.go:171","msg":"trace[30999975] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1015; }","duration":"104.65622ms","start":"2026-07-12T01:45:36.067038Z","end":"2026-07-12T01:45:36.171695Z","steps":["trace[30999975] 'agreement among raft nodes before linearized reading' (duration: 104.582557ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:45:36.171984Z","caller":"traceutil/trace.go:171","msg":"trace[1049265660] linearizableReadLoop","detail":"{readStateIndex:1050; appliedIndex:1048; }","duration":"104.154935ms","start":"2026-07-12T01:45:36.067105Z","end":"2026-07-12T01:45:36.17126Z","steps":["trace[1049265660] 'read index received' (duration: 72.963668ms)","trace[1049265660] 'applied index is now lower than readState.Index' (duration: 31.187047ms)"],"step_count":2} {"level":"info","ts":"2026-07-12T01:45:38.473817Z","caller":"traceutil/trace.go:171","msg":"trace[1192687561] transaction","detail":"{read_only:false; response_revision:1020; number_of_response:1; }","duration":"202.394597ms","start":"2026-07-12T01:45:38.271389Z","end":"2026-07-12T01:45:38.473784Z","steps":["trace[1192687561] 'process raft request' (duration: 202.226052ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:45:38.519155Z","caller":"traceutil/trace.go:171","msg":"trace[1763167816] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"246.61314ms","start":"2026-07-12T01:45:38.272511Z","end":"2026-07-12T01:45:38.519124Z","steps":["trace[1763167816] 'process raft request' (duration: 246.442405ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:45:40.215751Z","caller":"traceutil/trace.go:171","msg":"trace[78608585] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"130.790333ms","start":"2026-07-12T01:45:40.084939Z","end":"2026-07-12T01:45:40.215729Z","steps":["trace[78608585] 'process raft request' (duration: 130.674589ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:46:37.367011Z","caller":"traceutil/trace.go:171","msg":"trace[890909089] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"127.04334ms","start":"2026-07-12T01:46:37.239941Z","end":"2026-07-12T01:46:37.366984Z","steps":["trace[890909089] 'process raft request' (duration: 126.906097ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:46:38.698237Z","caller":"traceutil/trace.go:171","msg":"trace[1139200544] linearizableReadLoop","detail":"{readStateIndex:1270; appliedIndex:1269; }","duration":"144.52774ms","start":"2026-07-12T01:46:38.553686Z","end":"2026-07-12T01:46:38.698214Z","steps":["trace[1139200544] 'read index received' (duration: 144.309815ms)","trace[1139200544] 'applied index is now lower than readState.Index' (duration: 217.145µs)"],"step_count":2} {"level":"info","ts":"2026-07-12T01:46:38.6983Z","caller":"traceutil/trace.go:171","msg":"trace[60164578] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"167.646475ms","start":"2026-07-12T01:46:38.53061Z","end":"2026-07-12T01:46:38.698257Z","steps":["trace[60164578] 'process raft request' (duration: 167.44134ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:46:38.698379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.674222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-12T01:46:38.698414Z","caller":"traceutil/trace.go:171","msg":"trace[214159274] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1222; }","duration":"144.752645ms","start":"2026-07-12T01:46:38.553651Z","end":"2026-07-12T01:46:38.698403Z","steps":["trace[214159274] 'agreement among raft nodes before linearized reading' (duration: 144.657303ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:46:39.270202Z","caller":"traceutil/trace.go:171","msg":"trace[1488432964] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"164.445036ms","start":"2026-07-12T01:46:39.105729Z","end":"2026-07-12T01:46:39.270174Z","steps":["trace[1488432964] 'process raft request' (duration: 164.291023ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:46:39.48903Z","caller":"traceutil/trace.go:171","msg":"trace[1020529022] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"106.036005ms","start":"2026-07-12T01:46:39.382967Z","end":"2026-07-12T01:46:39.489003Z","steps":["trace[1020529022] 'process raft request' (duration: 105.892412ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:46:39.753691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.518405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:5 size:1050260"} {"level":"info","ts":"2026-07-12T01:46:39.753779Z","caller":"traceutil/trace.go:171","msg":"trace[303173875] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:1226; }","duration":"118.643108ms","start":"2026-07-12T01:46:39.635114Z","end":"2026-07-12T01:46:39.753758Z","steps":["trace[303173875] 'range keys from in-memory index tree' (duration: 117.449823ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:46:44.969852Z","caller":"traceutil/trace.go:171","msg":"trace[234545054] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"206.277925ms","start":"2026-07-12T01:46:44.763546Z","end":"2026-07-12T01:46:44.969824Z","steps":["trace[234545054] 'process raft request' (duration: 206.121862ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:46:45.132697Z","caller":"traceutil/trace.go:171","msg":"trace[2028495074] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"123.631724ms","start":"2026-07-12T01:46:45.009026Z","end":"2026-07-12T01:46:45.132657Z","steps":["trace[2028495074] 'process raft request' (duration: 42.029611ms)","trace[2028495074] 'compare' (duration: 81.262237ms)"],"step_count":2} {"level":"warn","ts":"2026-07-12T01:46:45.434096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.580364ms","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-07-12T01:46:45.434193Z","caller":"traceutil/trace.go:171","msg":"trace[1095645540] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1244; }","duration":"120.696346ms","start":"2026-07-12T01:46:45.313478Z","end":"2026-07-12T01:46:45.434175Z","steps":["trace[1095645540] 'range keys from in-memory index tree' (duration: 120.3815ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:46:45.434274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.781902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-12T01:46:45.434376Z","caller":"traceutil/trace.go:171","msg":"trace[854535921] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1244; }","duration":"199.929674ms","start":"2026-07-12T01:46:45.234426Z","end":"2026-07-12T01:46:45.434356Z","steps":["trace[854535921] 'count revisions from in-memory index tree' (duration: 199.70931ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:46:45.71637Z","caller":"traceutil/trace.go:171","msg":"trace[70637300] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"129.963948ms","start":"2026-07-12T01:46:45.586369Z","end":"2026-07-12T01:46:45.716333Z","steps":["trace[70637300] 'process raft request' (duration: 96.009916ms)","trace[70637300] 'compare' (duration: 33.735928ms)"],"step_count":2} {"level":"warn","ts":"2026-07-12T01:46:47.475451Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933267122539651075,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-12T01:46:47.732351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.803391ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-12T01:46:47.732639Z","caller":"traceutil/trace.go:171","msg":"trace[1327361083] linearizableReadLoop","detail":"{readStateIndex:1297; appliedIndex:1296; }","duration":"757.504612ms","start":"2026-07-12T01:46:46.9751Z","end":"2026-07-12T01:46:47.732605Z","steps":["trace[1327361083] 'read index received' (duration: 654.385425ms)","trace[1327361083] 'applied index is now lower than readState.Index' (duration: 103.118387ms)"],"step_count":2} {"level":"warn","ts":"2026-07-12T01:46:47.732774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"757.676235ms","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-07-12T01:46:47.732822Z","caller":"traceutil/trace.go:171","msg":"trace[1307340893] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1247; }","duration":"757.772357ms","start":"2026-07-12T01:46:46.97504Z","end":"2026-07-12T01:46:47.732812Z","steps":["trace[1307340893] 'agreement among raft nodes before linearized reading' (duration: 757.638765ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:46:47.732846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:46:46.975015Z","time spent":"757.824168ms","remote":"127.0.0.1:51186","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":"warn","ts":"2026-07-12T01:46:47.89292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.051564ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-12T01:46:47.893145Z","caller":"traceutil/trace.go:171","msg":"trace[1600567938] linearizableReadLoop","detail":"{readStateIndex:1299; appliedIndex:1298; }","duration":"160.456348ms","start":"2026-07-12T01:46:47.732664Z","end":"2026-07-12T01:46:47.89312Z","steps":["trace[1600567938] 'read index received' (duration: 39.088258ms)","trace[1600567938] 'applied index is now lower than readState.Index' (duration: 121.36457ms)"],"step_count":2} {"level":"info","ts":"2026-07-12T01:46:47.893213Z","caller":"traceutil/trace.go:171","msg":"trace[195574429] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"155.581573ms","start":"2026-07-12T01:46:47.7376Z","end":"2026-07-12T01:46:47.893182Z","steps":["trace[195574429] 'process raft request' (duration: 155.497572ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:46:47.893303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"824.548139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-12T01:46:47.893348Z","caller":"traceutil/trace.go:171","msg":"trace[1867748664] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1250; }","duration":"824.652371ms","start":"2026-07-12T01:46:47.068684Z","end":"2026-07-12T01:46:47.893336Z","steps":["trace[1867748664] 'agreement among raft nodes before linearized reading' (duration: 824.536459ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:46:47.89337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"718.924314ms","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-07-12T01:46:47.893421Z","caller":"traceutil/trace.go:171","msg":"trace[205384082] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1250; }","duration":"719.014346ms","start":"2026-07-12T01:46:47.174394Z","end":"2026-07-12T01:46:47.893408Z","steps":["trace[205384082] 'agreement among raft nodes before linearized reading' (duration: 718.792471ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:46:47.893454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"756.247256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-07-12T01:46:47.893468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:46:47.174369Z","time spent":"719.091068ms","remote":"127.0.0.1:51186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-12T01:46:47.893479Z","caller":"traceutil/trace.go:171","msg":"trace[388124928] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1250; }","duration":"756.313378ms","start":"2026-07-12T01:46:47.137158Z","end":"2026-07-12T01:46:47.893472Z","steps":["trace[388124928] 'agreement among raft nodes before linearized reading' (duration: 756.242216ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:46:47.893505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:46:47.137134Z","time spent":"756.365188ms","remote":"127.0.0.1:51186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-12T01:46:47.89353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.400017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-07-12T01:46:47.893385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:46:47.068665Z","time spent":"824.711582ms","remote":"127.0.0.1:50884","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-07-12T01:46:47.893603Z","caller":"traceutil/trace.go:171","msg":"trace[1393846849] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1250; }","duration":"413.496298ms","start":"2026-07-12T01:46:47.480082Z","end":"2026-07-12T01:46:47.893579Z","steps":["trace[1393846849] 'agreement among raft nodes before linearized reading' (duration: 413.371486ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:46:47.893402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.7937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:1 size:12755"} {"level":"warn","ts":"2026-07-12T01:46:47.893657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:46:47.48006Z","time spent":"413.5879ms","remote":"127.0.0.1:51186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-12T01:46:47.893691Z","caller":"traceutil/trace.go:171","msg":"trace[1472573397] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:1250; }","duration":"580.145966ms","start":"2026-07-12T01:46:47.313529Z","end":"2026-07-12T01:46:47.893675Z","steps":["trace[1472573397] 'agreement among raft nodes before linearized reading' (duration: 579.623686ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:46:47.893115Z","caller":"traceutil/trace.go:171","msg":"trace[1386891415] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"170.186346ms","start":"2026-07-12T01:46:47.722885Z","end":"2026-07-12T01:46:47.893071Z","steps":["trace[1386891415] 'process raft request' (duration: 48.849576ms)","trace[1386891415] 'compare' (duration: 120.687818ms)"],"step_count":2} {"level":"warn","ts":"2026-07-12T01:46:47.893737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:46:47.313504Z","time spent":"580.221888ms","remote":"127.0.0.1:50982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":12778,"request content":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" "} {"level":"info","ts":"2026-07-12T01:47:00.657425Z","caller":"traceutil/trace.go:171","msg":"trace[1742908565] transaction","detail":"{read_only:false; response_revision:1325; number_of_response:1; }","duration":"306.143355ms","start":"2026-07-12T01:47:00.351254Z","end":"2026-07-12T01:47:00.657397Z","steps":["trace[1742908565] 'process raft request' (duration: 305.35999ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:47:00.657642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:47:00.351232Z","time spent":"306.298497ms","remote":"127.0.0.1:51186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-12T01:47:00.65777Z","caller":"traceutil/trace.go:171","msg":"trace[1970980353] linearizableReadLoop","detail":"{readStateIndex:1378; appliedIndex:1378; }","duration":"255.43457ms","start":"2026-07-12T01:47:00.4023Z","end":"2026-07-12T01:47:00.657734Z","steps":["trace[1970980353] 'read index received' (duration: 255.42504ms)","trace[1970980353] 'applied index is now lower than readState.Index' (duration: 7.58µs)"],"step_count":2} {"level":"warn","ts":"2026-07-12T01:47:00.657958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.635993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-12T01:47:00.658006Z","caller":"traceutil/trace.go:171","msg":"trace[2070635472] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1325; }","duration":"255.742686ms","start":"2026-07-12T01:47:00.402246Z","end":"2026-07-12T01:47:00.657988Z","steps":["trace[2070635472] 'agreement among raft nodes before linearized reading' (duration: 255.624083ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:47:06.104611Z","caller":"traceutil/trace.go:171","msg":"trace[2079926039] linearizableReadLoop","detail":"{readStateIndex:1400; appliedIndex:1399; }","duration":"134.879139ms","start":"2026-07-12T01:47:05.969712Z","end":"2026-07-12T01:47:06.104591Z","steps":["trace[2079926039] 'read index received' (duration: 134.709686ms)","trace[2079926039] 'applied index is now lower than readState.Index' (duration: 168.903µs)"],"step_count":2} {"level":"info","ts":"2026-07-12T01:47:06.104668Z","caller":"traceutil/trace.go:171","msg":"trace[1619449481] transaction","detail":"{read_only:false; response_revision:1346; number_of_response:1; }","duration":"147.351875ms","start":"2026-07-12T01:47:05.957295Z","end":"2026-07-12T01:47:06.104647Z","steps":["trace[1619449481] 'process raft request' (duration: 147.127261ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:47:06.10485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.122373ms","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-07-12T01:47:06.104925Z","caller":"traceutil/trace.go:171","msg":"trace[152243512] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1346; }","duration":"135.244294ms","start":"2026-07-12T01:47:05.969661Z","end":"2026-07-12T01:47:06.104906Z","steps":["trace[152243512] 'agreement among raft nodes before linearized reading' (duration: 135.01664ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:47:06.476593Z","caller":"traceutil/trace.go:171","msg":"trace[1332813512] transaction","detail":"{read_only:false; response_revision:1347; number_of_response:1; }","duration":"368.642991ms","start":"2026-07-12T01:47:06.107921Z","end":"2026-07-12T01:47:06.476564Z","steps":["trace[1332813512] 'process raft request' (duration: 368.441827ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:47:06.476987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:47:06.107911Z","time spent":"368.778363ms","remote":"127.0.0.1:51186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-12T01:47:06.487019Z","caller":"traceutil/trace.go:171","msg":"trace[1691066162] transaction","detail":"{read_only:false; response_revision:1348; number_of_response:1; }","duration":"378.51064ms","start":"2026-07-12T01:47:06.108474Z","end":"2026-07-12T01:47:06.486985Z","steps":["trace[1691066162] 'process raft request' (duration: 378.259095ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:47:06.48732Z","caller":"traceutil/trace.go:171","msg":"trace[174069672] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"378.294116ms","start":"2026-07-12T01:47:06.10899Z","end":"2026-07-12T01:47:06.487284Z","steps":["trace[174069672] 'process raft request' (duration: 377.928379ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:47:06.487397Z","caller":"traceutil/trace.go:171","msg":"trace[2044104886] transaction","detail":"{read_only:false; response_revision:1349; number_of_response:1; }","duration":"378.136353ms","start":"2026-07-12T01:47:06.108817Z","end":"2026-07-12T01:47:06.486953Z","steps":["trace[2044104886] 'process raft request' (duration: 378.054931ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:47:06.487484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:47:06.108979Z","time spent":"378.421908ms","remote":"127.0.0.1:51186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-12T01:47:06.487525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:47:06.108796Z","time spent":"378.667132ms","remote":"127.0.0.1:51186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-12T01:47:06.487747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:47:06.108437Z","time spent":"378.719234ms","remote":"127.0.0.1:51186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"}