{"level":"warn","ts":"2026-08-20T01:13:20.840034Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-20T01:13:20.840162Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.59:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.59:2380","--initial-cluster=instance=https://199.19.213.59:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.59:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.59:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-08-20T01:13:20.840248Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-20T01:13:20.840257Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.59:2380"]} {"level":"info","ts":"2026-08-20T01:13:20.840275Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-20T01:13:20.840976Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.59:2379"]} {"level":"info","ts":"2026-08-20T01:13:20.841053Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.59:2380"],"listen-peer-urls":["https://199.19.213.59:2380"],"advertise-client-urls":["https://199.19.213.59:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.59:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.59:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-08-20T01:13:20.847096Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.809527ms"} {"level":"info","ts":"2026-08-20T01:13:20.858018Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"41c06612bf92f90","cluster-id":"7f792254ff9520b"} {"level":"info","ts":"2026-08-20T01:13:20.858106Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"41c06612bf92f90 switched to configuration voters=()"} {"level":"info","ts":"2026-08-20T01:13:20.858129Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"41c06612bf92f90 became follower at term 0"} {"level":"info","ts":"2026-08-20T01:13:20.858143Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 41c06612bf92f90 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-20T01:13:20.858152Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"41c06612bf92f90 became follower at term 1"} {"level":"info","ts":"2026-08-20T01:13:20.8582Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"41c06612bf92f90 switched to configuration voters=(296118689918955408)"} {"level":"warn","ts":"2026-08-20T01:13:20.863807Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-20T01:13:20.867456Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-20T01:13:20.868613Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-08-20T01:13:20.870875Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"41c06612bf92f90","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-20T01:13:20.871196Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-20T01:13:20.871313Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-20T01:13:20.871324Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-20T01:13:20.871414Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"41c06612bf92f90","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-20T01:13:20.875744Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"41c06612bf92f90 switched to configuration voters=(296118689918955408)"} {"level":"info","ts":"2026-08-20T01:13:20.87592Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"7f792254ff9520b","local-member-id":"41c06612bf92f90","added-peer-id":"41c06612bf92f90","added-peer-peer-urls":["https://199.19.213.59:2380"]} {"level":"info","ts":"2026-08-20T01:13:20.879223Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-20T01:13:20.879287Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.59:2380"} {"level":"info","ts":"2026-08-20T01:13:20.879309Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.59:2380"} {"level":"info","ts":"2026-08-20T01:13:20.879531Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"41c06612bf92f90","initial-advertise-peer-urls":["https://199.19.213.59:2380"],"listen-peer-urls":["https://199.19.213.59:2380"],"advertise-client-urls":["https://199.19.213.59:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.59:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-20T01:13:20.879577Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-20T01:13:21.458561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"41c06612bf92f90 is starting a new election at term 1"} {"level":"info","ts":"2026-08-20T01:13:21.458638Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"41c06612bf92f90 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-20T01:13:21.458663Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"41c06612bf92f90 received MsgPreVoteResp from 41c06612bf92f90 at term 1"} {"level":"info","ts":"2026-08-20T01:13:21.458679Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"41c06612bf92f90 became candidate at term 2"} {"level":"info","ts":"2026-08-20T01:13:21.458686Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"41c06612bf92f90 received MsgVoteResp from 41c06612bf92f90 at term 2"} {"level":"info","ts":"2026-08-20T01:13:21.458697Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"41c06612bf92f90 became leader at term 2"} {"level":"info","ts":"2026-08-20T01:13:21.458707Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 41c06612bf92f90 elected leader 41c06612bf92f90 at term 2"} {"level":"info","ts":"2026-08-20T01:13:21.460907Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-20T01:13:21.463144Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"41c06612bf92f90","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.59:2379]}","request-path":"/0/members/41c06612bf92f90/attributes","cluster-id":"7f792254ff9520b","publish-timeout":"7s"} {"level":"info","ts":"2026-08-20T01:13:21.463342Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-20T01:13:21.463373Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-20T01:13:21.463991Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"7f792254ff9520b","local-member-id":"41c06612bf92f90","cluster-version":"3.5"} {"level":"info","ts":"2026-08-20T01:13:21.464089Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-20T01:13:21.464118Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-20T01:13:21.466133Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.59:2379"} {"level":"info","ts":"2026-08-20T01:13:21.466457Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-20T01:13:21.466705Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-20T01:13:21.466735Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-20T01:13:47.276269Z","caller":"traceutil/trace.go:171","msg":"trace[339491841] linearizableReadLoop","detail":"{readStateIndex:443; appliedIndex:442; }","duration":"295.640539ms","start":"2026-08-20T01:13:46.980605Z","end":"2026-08-20T01:13:47.276245Z","steps":["trace[339491841] 'read index received' (duration: 295.486735ms)","trace[339491841] 'applied index is now lower than readState.Index' (duration: 152.744µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T01:13:47.276405Z","caller":"traceutil/trace.go:171","msg":"trace[334432207] transaction","detail":"{read_only:false; response_revision:426; number_of_response:1; }","duration":"451.049636ms","start":"2026-08-20T01:13:46.825341Z","end":"2026-08-20T01:13:47.27639Z","steps":["trace[334432207] 'process raft request' (duration: 450.718859ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:13:47.276525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.809534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-20T01:13:47.276656Z","caller":"traceutil/trace.go:171","msg":"trace[253715766] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:426; }","duration":"295.991038ms","start":"2026-08-20T01:13:46.980645Z","end":"2026-08-20T01:13:47.276636Z","steps":["trace[253715766] 'agreement among raft nodes before linearized reading' (duration: 295.770573ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:13:47.276655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.460868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-08-20T01:13:47.276703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.07549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-20T01:13:47.27679Z","caller":"traceutil/trace.go:171","msg":"trace[669346541] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:426; }","duration":"116.648833ms","start":"2026-08-20T01:13:47.160111Z","end":"2026-08-20T01:13:47.276759Z","steps":["trace[669346541] 'agreement among raft nodes before linearized reading' (duration: 116.400067ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:13:47.276821Z","caller":"traceutil/trace.go:171","msg":"trace[1504905508] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:426; }","duration":"296.221263ms","start":"2026-08-20T01:13:46.980572Z","end":"2026-08-20T01:13:47.276793Z","steps":["trace[1504905508] 'agreement among raft nodes before linearized reading' (duration: 296.059749ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:13:47.277096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:13:46.825319Z","time spent":"451.124918ms","remote":"127.0.0.1:58034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T01:13:47.566233Z","caller":"traceutil/trace.go:171","msg":"trace[633387560] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"284.916663ms","start":"2026-08-20T01:13:47.281283Z","end":"2026-08-20T01:13:47.5662Z","steps":["trace[633387560] 'process raft request' (duration: 284.739499ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:13:47.567169Z","caller":"traceutil/trace.go:171","msg":"trace[1425822731] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"285.731632ms","start":"2026-08-20T01:13:47.281382Z","end":"2026-08-20T01:13:47.567113Z","steps":["trace[1425822731] 'process raft request' (duration: 285.566328ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:13:47.567284Z","caller":"traceutil/trace.go:171","msg":"trace[307023817] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"285.742762ms","start":"2026-08-20T01:13:47.281516Z","end":"2026-08-20T01:13:47.567258Z","steps":["trace[307023817] 'process raft request' (duration: 285.521047ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:13:47.567225Z","caller":"traceutil/trace.go:171","msg":"trace[1694051214] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"285.772983ms","start":"2026-08-20T01:13:47.281431Z","end":"2026-08-20T01:13:47.567204Z","steps":["trace[1694051214] 'process raft request' (duration: 285.581499ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:13:57.878817Z","caller":"traceutil/trace.go:171","msg":"trace[215828447] linearizableReadLoop","detail":"{readStateIndex:468; appliedIndex:467; }","duration":"231.19199ms","start":"2026-08-20T01:13:57.647597Z","end":"2026-08-20T01:13:57.878789Z","steps":["trace[215828447] 'read index received' (duration: 231.024796ms)","trace[215828447] 'applied index is now lower than readState.Index' (duration: 165.594µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T01:13:57.87885Z","caller":"traceutil/trace.go:171","msg":"trace[400514503] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"241.029504ms","start":"2026-08-20T01:13:57.637783Z","end":"2026-08-20T01:13:57.878813Z","steps":["trace[400514503] 'process raft request' (duration: 240.852ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:13:57.879013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.403514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-20T01:13:57.879075Z","caller":"traceutil/trace.go:171","msg":"trace[492465498] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:449; }","duration":"231.477626ms","start":"2026-08-20T01:13:57.647582Z","end":"2026-08-20T01:13:57.87906Z","steps":["trace[492465498] 'agreement among raft nodes before linearized reading' (duration: 231.302022ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:13:57.879199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.375043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-20T01:13:57.87923Z","caller":"traceutil/trace.go:171","msg":"trace[394580625] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:449; }","duration":"210.426155ms","start":"2026-08-20T01:13:57.668794Z","end":"2026-08-20T01:13:57.87922Z","steps":["trace[394580625] 'agreement among raft nodes before linearized reading' (duration: 210.376184ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:13:57.879354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.152304ms","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-08-20T01:13:57.879353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.874584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-20T01:13:57.879446Z","caller":"traceutil/trace.go:171","msg":"trace[238008160] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:449; }","duration":"212.248297ms","start":"2026-08-20T01:13:57.667184Z","end":"2026-08-20T01:13:57.879432Z","steps":["trace[238008160] 'agreement among raft nodes before linearized reading' (duration: 211.993981ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:13:57.87948Z","caller":"traceutil/trace.go:171","msg":"trace[1864769124] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:449; }","duration":"214.121489ms","start":"2026-08-20T01:13:57.665341Z","end":"2026-08-20T01:13:57.879463Z","steps":["trace[1864769124] 'agreement among raft nodes before linearized reading' (duration: 213.832983ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:13:58.051714Z","caller":"traceutil/trace.go:171","msg":"trace[808787532] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"169.079358ms","start":"2026-08-20T01:13:57.88261Z","end":"2026-08-20T01:13:58.051689Z","steps":["trace[808787532] 'process raft request' (duration: 164.853132ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:13:58.066038Z","caller":"traceutil/trace.go:171","msg":"trace[1109405091] transaction","detail":"{read_only:false; response_revision:453; number_of_response:1; }","duration":"178.901433ms","start":"2026-08-20T01:13:57.887098Z","end":"2026-08-20T01:13:58.066Z","steps":["trace[1109405091] 'process raft request' (duration: 178.702738ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:13:58.066212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.23599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T01:13:58.066299Z","caller":"traceutil/trace.go:171","msg":"trace[872990708] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:0; response_revision:453; }","duration":"106.395283ms","start":"2026-08-20T01:13:57.95989Z","end":"2026-08-20T01:13:58.066285Z","steps":["trace[872990708] 'agreement among raft nodes before linearized reading' (duration: 106.194799ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:13:58.065857Z","caller":"traceutil/trace.go:171","msg":"trace[1595450162] linearizableReadLoop","detail":"{readStateIndex:472; appliedIndex:468; }","duration":"105.902102ms","start":"2026-08-20T01:13:57.959933Z","end":"2026-08-20T01:13:58.065835Z","steps":["trace[1595450162] 'read index received' (duration: 87.544382ms)","trace[1595450162] 'applied index is now lower than readState.Index' (duration: 18.35664ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T01:13:58.066593Z","caller":"traceutil/trace.go:171","msg":"trace[166101392] transaction","detail":"{read_only:false; response_revision:452; number_of_response:1; }","duration":"182.929595ms","start":"2026-08-20T01:13:57.883639Z","end":"2026-08-20T01:13:58.066568Z","steps":["trace[166101392] 'process raft request' (duration: 182.129937ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:13:58.065968Z","caller":"traceutil/trace.go:171","msg":"trace[199699678] transaction","detail":"{read_only:false; response_revision:451; number_of_response:1; }","duration":"182.371752ms","start":"2026-08-20T01:13:57.883541Z","end":"2026-08-20T01:13:58.065913Z","steps":["trace[199699678] 'process raft request' (duration: 182.102686ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:00.12214Z","caller":"traceutil/trace.go:171","msg":"trace[566903038] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"261.180359ms","start":"2026-08-20T01:13:59.860934Z","end":"2026-08-20T01:14:00.122115Z","steps":["trace[566903038] 'process raft request' (duration: 260.966604ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:00.129604Z","caller":"traceutil/trace.go:171","msg":"trace[463962528] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"256.243466ms","start":"2026-08-20T01:13:59.873322Z","end":"2026-08-20T01:14:00.129565Z","steps":["trace[463962528] 'process raft request' (duration: 255.835247ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:00.129651Z","caller":"traceutil/trace.go:171","msg":"trace[1144554275] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"253.570385ms","start":"2026-08-20T01:13:59.876046Z","end":"2026-08-20T01:14:00.129616Z","steps":["trace[1144554275] 'process raft request' (duration: 253.263968ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:00.12968Z","caller":"traceutil/trace.go:171","msg":"trace[1967119308] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"258.507238ms","start":"2026-08-20T01:13:59.871151Z","end":"2026-08-20T01:14:00.129658Z","steps":["trace[1967119308] 'process raft request' (duration: 257.862223ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:00.1298Z","caller":"traceutil/trace.go:171","msg":"trace[1813105951] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"262.596811ms","start":"2026-08-20T01:13:59.867196Z","end":"2026-08-20T01:14:00.129793Z","steps":["trace[1813105951] 'process raft request' (duration: 261.694291ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:00.129827Z","caller":"traceutil/trace.go:171","msg":"trace[1157684184] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"256.447731ms","start":"2026-08-20T01:13:59.873363Z","end":"2026-08-20T01:14:00.129811Z","steps":["trace[1157684184] 'process raft request' (duration: 255.909978ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:00.129941Z","caller":"traceutil/trace.go:171","msg":"trace[568776245] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"258.752483ms","start":"2026-08-20T01:13:59.871181Z","end":"2026-08-20T01:14:00.129934Z","steps":["trace[568776245] 'process raft request' (duration: 257.888984ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:00.129941Z","caller":"traceutil/trace.go:171","msg":"trace[681094246] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"238.535811ms","start":"2026-08-20T01:13:59.891396Z","end":"2026-08-20T01:14:00.129932Z","steps":["trace[681094246] 'process raft request' (duration: 237.977699ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:00.130005Z","caller":"traceutil/trace.go:171","msg":"trace[1404795992] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"223.534369ms","start":"2026-08-20T01:13:59.906464Z","end":"2026-08-20T01:14:00.129998Z","steps":["trace[1404795992] 'process raft request' (duration: 222.970476ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:00.130097Z","caller":"traceutil/trace.go:171","msg":"trace[210192907] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"256.690626ms","start":"2026-08-20T01:13:59.873275Z","end":"2026-08-20T01:14:00.129966Z","steps":["trace[210192907] 'process raft request' (duration: 255.837047ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:00.145536Z","caller":"traceutil/trace.go:171","msg":"trace[524829059] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"224.435088ms","start":"2026-08-20T01:13:59.921085Z","end":"2026-08-20T01:14:00.14552Z","steps":["trace[524829059] 'process raft request' (duration: 223.999808ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:00.145624Z","caller":"traceutil/trace.go:171","msg":"trace[1919016935] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"129.148671ms","start":"2026-08-20T01:14:00.016471Z","end":"2026-08-20T01:14:00.14562Z","steps":["trace[1919016935] 'process raft request' (duration: 128.715261ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:02.992342Z","caller":"traceutil/trace.go:171","msg":"trace[1072699836] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"257.425666ms","start":"2026-08-20T01:14:02.734885Z","end":"2026-08-20T01:14:02.992311Z","steps":["trace[1072699836] 'process raft request' (duration: 257.13183ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:02.992469Z","caller":"traceutil/trace.go:171","msg":"trace[751263810] linearizableReadLoop","detail":"{readStateIndex:596; appliedIndex:595; }","duration":"256.746011ms","start":"2026-08-20T01:14:02.735489Z","end":"2026-08-20T01:14:02.992235Z","steps":["trace[751263810] 'read index received' (duration: 256.447874ms)","trace[751263810] 'applied index is now lower than readState.Index' (duration: 296.877µs)"],"step_count":2} {"level":"warn","ts":"2026-08-20T01:14:02.992737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.181946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T01:14:02.992785Z","caller":"traceutil/trace.go:171","msg":"trace[1507964219] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:571; }","duration":"227.247708ms","start":"2026-08-20T01:14:02.765524Z","end":"2026-08-20T01:14:02.992772Z","steps":["trace[1507964219] 'agreement among raft nodes before linearized reading' (duration: 227.129255ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:02.992811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.544936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T01:14:02.992876Z","caller":"traceutil/trace.go:171","msg":"trace[748813489] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:571; }","duration":"242.635999ms","start":"2026-08-20T01:14:02.750225Z","end":"2026-08-20T01:14:02.992861Z","steps":["trace[748813489] 'agreement among raft nodes before linearized reading' (duration: 242.529356ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:02.992871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.178306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T01:14:02.993005Z","caller":"traceutil/trace.go:171","msg":"trace[462460502] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:571; }","duration":"227.376121ms","start":"2026-08-20T01:14:02.765603Z","end":"2026-08-20T01:14:02.992979Z","steps":["trace[462460502] 'agreement among raft nodes before linearized reading' (duration: 227.132305ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:02.993099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.740061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T01:14:02.993125Z","caller":"traceutil/trace.go:171","msg":"trace[699589056] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:571; }","duration":"242.770422ms","start":"2026-08-20T01:14:02.750347Z","end":"2026-08-20T01:14:02.993118Z","steps":["trace[699589056] 'agreement among raft nodes before linearized reading' (duration: 242.725521ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:02.993404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.190222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-20T01:14:02.993593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.495648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T01:14:02.993609Z","caller":"traceutil/trace.go:171","msg":"trace[2142563363] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:571; }","duration":"258.03299ms","start":"2026-08-20T01:14:02.735553Z","end":"2026-08-20T01:14:02.993586Z","steps":["trace[2142563363] 'agreement among raft nodes before linearized reading' (duration: 257.094279ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:02.993876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.00968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-20T01:14:02.993715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.457313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T01:14:02.99404Z","caller":"traceutil/trace.go:171","msg":"trace[1949227311] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:571; }","duration":"258.173304ms","start":"2026-08-20T01:14:02.735469Z","end":"2026-08-20T01:14:02.993643Z","steps":["trace[1949227311] 'agreement among raft nodes before linearized reading' (duration: 256.976216ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:02.99407Z","caller":"traceutil/trace.go:171","msg":"trace[808914953] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:571; }","duration":"244.099012ms","start":"2026-08-20T01:14:02.749799Z","end":"2026-08-20T01:14:02.993898Z","steps":["trace[808914953] 'agreement among raft nodes before linearized reading' (duration: 243.439707ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:02.994043Z","caller":"traceutil/trace.go:171","msg":"trace[401624336] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:571; }","duration":"227.765389ms","start":"2026-08-20T01:14:02.766218Z","end":"2026-08-20T01:14:02.993983Z","steps":["trace[401624336] 'agreement among raft nodes before linearized reading' (duration: 227.398901ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:03.15624Z","caller":"traceutil/trace.go:171","msg":"trace[812674309] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"158.23126ms","start":"2026-08-20T01:14:02.997977Z","end":"2026-08-20T01:14:03.156208Z","steps":["trace[812674309] 'process raft request' (duration: 72.381751ms)","trace[812674309] 'compare' (duration: 85.703336ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T01:14:04.052692Z","caller":"traceutil/trace.go:171","msg":"trace[1924867442] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"149.696495ms","start":"2026-08-20T01:14:03.902961Z","end":"2026-08-20T01:14:04.052658Z","steps":["trace[1924867442] 'process raft request' (duration: 149.119362ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:04.583323Z","caller":"traceutil/trace.go:171","msg":"trace[391801191] linearizableReadLoop","detail":"{readStateIndex:602; appliedIndex:601; }","duration":"394.826984ms","start":"2026-08-20T01:14:04.188462Z","end":"2026-08-20T01:14:04.583289Z","steps":["trace[391801191] 'read index received' (duration: 379.526756ms)","trace[391801191] 'applied index is now lower than readState.Index' (duration: 15.298658ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T01:14:04.583621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.147882ms","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-08-20T01:14:04.583667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.074555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-20T01:14:04.583704Z","caller":"traceutil/trace.go:171","msg":"trace[2043916394] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:577; }","duration":"395.274535ms","start":"2026-08-20T01:14:04.188409Z","end":"2026-08-20T01:14:04.583683Z","steps":["trace[2043916394] 'agreement among raft nodes before linearized reading' (duration: 395.01673ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:04.583703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.757427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.59\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-08-20T01:14:04.583725Z","caller":"traceutil/trace.go:171","msg":"trace[2136234001] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:577; }","duration":"386.179618ms","start":"2026-08-20T01:14:04.197526Z","end":"2026-08-20T01:14:04.583705Z","steps":["trace[2136234001] 'agreement among raft nodes before linearized reading' (duration: 385.927482ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:04.583765Z","caller":"traceutil/trace.go:171","msg":"trace[1979399250] range","detail":"{range_begin:/registry/masterleases/199.19.213.59; range_end:; response_count:1; response_revision:577; }","duration":"171.86052ms","start":"2026-08-20T01:14:04.41189Z","end":"2026-08-20T01:14:04.58375Z","steps":["trace[1979399250] 'agreement among raft nodes before linearized reading' (duration: 171.726497ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:04.58375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:04.18839Z","time spent":"395.351517ms","remote":"127.0.0.1:58034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-20T01:14:04.583778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:04.197512Z","time spent":"386.253139ms","remote":"127.0.0.1:58034","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":"info","ts":"2026-08-20T01:14:04.583377Z","caller":"traceutil/trace.go:171","msg":"trace[577072952] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"478.954414ms","start":"2026-08-20T01:14:04.10439Z","end":"2026-08-20T01:14:04.583344Z","steps":["trace[577072952] 'process raft request' (duration: 463.692266ms)","trace[577072952] 'compare' (duration: 14.901239ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T01:14:04.58398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.446522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-20T01:14:04.583995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.403059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-08-20T01:14:04.584004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.82757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-20T01:14:04.584018Z","caller":"traceutil/trace.go:171","msg":"trace[1633399089] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:577; }","duration":"111.530944ms","start":"2026-08-20T01:14:04.472477Z","end":"2026-08-20T01:14:04.584008Z","steps":["trace[1633399089] 'agreement among raft nodes before linearized reading' (duration: 111.474233ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:04.584045Z","caller":"traceutil/trace.go:171","msg":"trace[117244717] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:577; }","duration":"378.889892ms","start":"2026-08-20T01:14:04.205144Z","end":"2026-08-20T01:14:04.584034Z","steps":["trace[117244717] 'agreement among raft nodes before linearized reading' (duration: 378.793219ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:04.584046Z","caller":"traceutil/trace.go:171","msg":"trace[1473133131] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:577; }","duration":"367.469111ms","start":"2026-08-20T01:14:04.216561Z","end":"2026-08-20T01:14:04.58403Z","steps":["trace[1473133131] 'agreement among raft nodes before linearized reading' (duration: 367.340398ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:04.584079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:04.205134Z","time spent":"378.938902ms","remote":"127.0.0.1:58034","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":"warn","ts":"2026-08-20T01:14:04.584092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:04.21655Z","time spent":"367.530793ms","remote":"127.0.0.1:58034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-20T01:14:04.584192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:04.10437Z","time spent":"479.597558ms","remote":"127.0.0.1:57970","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T01:14:05.31739Z","caller":"traceutil/trace.go:171","msg":"trace[187819445] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"188.664782ms","start":"2026-08-20T01:14:05.128688Z","end":"2026-08-20T01:14:05.317353Z","steps":["trace[187819445] 'process raft request' (duration: 188.214961ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:05.838704Z","caller":"traceutil/trace.go:171","msg":"trace[196260470] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"115.893442ms","start":"2026-08-20T01:14:05.722778Z","end":"2026-08-20T01:14:05.838671Z","steps":["trace[196260470] 'process raft request' (duration: 115.34172ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:09.140072Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3427415361682857810,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-20T01:14:09.41338Z","caller":"traceutil/trace.go:171","msg":"trace[1646417737] linearizableReadLoop","detail":"{readStateIndex:634; appliedIndex:633; }","duration":"774.050641ms","start":"2026-08-20T01:14:08.639302Z","end":"2026-08-20T01:14:09.413353Z","steps":["trace[1646417737] 'read index received' (duration: 773.788495ms)","trace[1646417737] 'applied index is now lower than readState.Index' (duration: 260.846µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T01:14:09.413448Z","caller":"traceutil/trace.go:171","msg":"trace[1591085760] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"917.837734ms","start":"2026-08-20T01:14:08.495577Z","end":"2026-08-20T01:14:09.413415Z","steps":["trace[1591085760] 'process raft request' (duration: 917.612359ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:09.413579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:08.495553Z","time spent":"917.960077ms","remote":"127.0.0.1:57950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T01:14:09.41364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"773.653292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-20T01:14:09.413686Z","caller":"traceutil/trace.go:171","msg":"trace[2041874769] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:608; }","duration":"773.736433ms","start":"2026-08-20T01:14:08.639938Z","end":"2026-08-20T01:14:09.413674Z","steps":["trace[2041874769] 'agreement among raft nodes before linearized reading' (duration: 773.556929ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:09.413759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:08.639905Z","time spent":"773.816975ms","remote":"127.0.0.1:58034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-20T01:14:09.413754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"773.651411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-08-20T01:14:09.413853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"773.831025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-20T01:14:09.413871Z","caller":"traceutil/trace.go:171","msg":"trace[2124843480] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:608; }","duration":"773.818095ms","start":"2026-08-20T01:14:08.640026Z","end":"2026-08-20T01:14:09.413844Z","steps":["trace[2124843480] 'agreement among raft nodes before linearized reading' (duration: 773.540599ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:09.413892Z","caller":"traceutil/trace.go:171","msg":"trace[908243758] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:608; }","duration":"773.883347ms","start":"2026-08-20T01:14:08.639998Z","end":"2026-08-20T01:14:09.413881Z","steps":["trace[908243758] 'agreement among raft nodes before linearized reading' (duration: 773.677352ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:09.413916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:08.639989Z","time spent":"773.921887ms","remote":"127.0.0.1:58034","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-08-20T01:14:09.413925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:08.64002Z","time spent":"773.891816ms","remote":"127.0.0.1:58034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-20T01:14:09.413772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"774.407729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-20T01:14:09.41401Z","caller":"traceutil/trace.go:171","msg":"trace[254427570] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:608; }","duration":"774.738366ms","start":"2026-08-20T01:14:08.639259Z","end":"2026-08-20T01:14:09.413997Z","steps":["trace[254427570] 'agreement among raft nodes before linearized reading' (duration: 774.267526ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:09.414074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:08.63924Z","time spent":"774.824498ms","remote":"127.0.0.1:58034","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-08-20T01:14:09.971477Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3427415361682857813,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-20T01:14:11.000964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"749.729148ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-20T01:14:11.001225Z","caller":"traceutil/trace.go:171","msg":"trace[1365639124] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"1.582828465s","start":"2026-08-20T01:14:09.418373Z","end":"2026-08-20T01:14:11.001201Z","steps":["trace[1365639124] 'process raft request' (duration: 832.639498ms)","trace[1365639124] 'compare' (duration: 749.567063ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T01:14:11.001236Z","caller":"traceutil/trace.go:171","msg":"trace[973600884] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"1.58258632s","start":"2026-08-20T01:14:09.418622Z","end":"2026-08-20T01:14:11.001209Z","steps":["trace[973600884] 'process raft request' (duration: 1.582432297s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:11.00133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:09.418349Z","time spent":"1.582935908s","remote":"127.0.0.1:58034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T01:14:11.001324Z","caller":"traceutil/trace.go:171","msg":"trace[1860779860] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"1.582452166s","start":"2026-08-20T01:14:09.418852Z","end":"2026-08-20T01:14:11.001304Z","steps":["trace[1860779860] 'process raft request' (duration: 1.582265082s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:11.001392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:09.418613Z","time spent":"1.582691122s","remote":"127.0.0.1:58034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T01:14:11.001425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:09.418843Z","time spent":"1.582537369s","remote":"127.0.0.1:58034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T01:14:11.085974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.614948385s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T01:14:11.086068Z","caller":"traceutil/trace.go:171","msg":"trace[1566769898] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:612; }","duration":"1.615088708s","start":"2026-08-20T01:14:09.470956Z","end":"2026-08-20T01:14:11.086045Z","steps":["trace[1566769898] 'agreement among raft nodes before linearized reading' (duration: 1.614919294s)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:11.085733Z","caller":"traceutil/trace.go:171","msg":"trace[1864037141] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:635; }","duration":"1.614692649s","start":"2026-08-20T01:14:09.471008Z","end":"2026-08-20T01:14:11.085701Z","steps":["trace[1864037141] 'read index received' (duration: 779.977979ms)","trace[1864037141] 'applied index is now lower than readState.Index' (duration: 834.71294ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T01:14:11.086119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:09.470918Z","time spent":"1.61518802s","remote":"127.0.0.1:57778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-20T01:14:12.859305Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.39595952s","expected-duration":"1s"} {"level":"info","ts":"2026-08-20T01:14:12.859817Z","caller":"traceutil/trace.go:171","msg":"trace[1387297605] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:639; }","duration":"390.088788ms","start":"2026-08-20T01:14:12.46971Z","end":"2026-08-20T01:14:12.859798Z","steps":["trace[1387297605] 'read index received' (duration: 389.849303ms)","trace[1387297605] 'applied index is now lower than readState.Index' (duration: 238.845µs)"],"step_count":2} {"level":"warn","ts":"2026-08-20T01:14:12.8599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.17267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T01:14:12.859924Z","caller":"traceutil/trace.go:171","msg":"trace[1920688397] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:613; }","duration":"390.247662ms","start":"2026-08-20T01:14:12.46967Z","end":"2026-08-20T01:14:12.859918Z","steps":["trace[1920688397] 'agreement among raft nodes before linearized reading' (duration: 390.1767ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:12.859947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:12.469651Z","time spent":"390.290542ms","remote":"127.0.0.1:57778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-20T01:14:12.859964Z","caller":"traceutil/trace.go:171","msg":"trace[1904733764] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"1.396705086s","start":"2026-08-20T01:14:11.463227Z","end":"2026-08-20T01:14:12.859932Z","steps":["trace[1904733764] 'process raft request' (duration: 1.39643573s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:12.86015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:11.463193Z","time spent":"1.39686545s","remote":"127.0.0.1:58034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T01:14:13.972563Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3427415361682857827,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-20T01:14:14.170777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.164708565s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-20T01:14:14.170868Z","caller":"traceutil/trace.go:171","msg":"trace[1890521432] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:613; }","duration":"1.164866179s","start":"2026-08-20T01:14:13.005984Z","end":"2026-08-20T01:14:14.17085Z","steps":["trace[1890521432] 'range keys from in-memory index tree' (duration: 1.164520331s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:14.170917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:13.005963Z","time spent":"1.16494054s","remote":"127.0.0.1:58034","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-08-20T01:14:14.170952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.164844698s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-20T01:14:14.171025Z","caller":"traceutil/trace.go:171","msg":"trace[556456980] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:613; }","duration":"1.164996342s","start":"2026-08-20T01:14:13.006015Z","end":"2026-08-20T01:14:14.171012Z","steps":["trace[556456980] 'range keys from in-memory index tree' (duration: 1.164708966s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:14.171032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.164977131s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-08-20T01:14:14.171068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:13.005995Z","time spent":"1.165062473s","remote":"127.0.0.1:58034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-20T01:14:14.171124Z","caller":"traceutil/trace.go:171","msg":"trace[1116677035] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:613; }","duration":"1.165114865s","start":"2026-08-20T01:14:13.005984Z","end":"2026-08-20T01:14:14.171099Z","steps":["trace[1116677035] 'range keys from in-memory index tree' (duration: 1.164731856s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:14.171192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:13.00597Z","time spent":"1.165208057s","remote":"127.0.0.1:58034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-20T01:14:14.20882Z","caller":"traceutil/trace.go:171","msg":"trace[2045733939] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:640; }","duration":"736.606497ms","start":"2026-08-20T01:14:13.47219Z","end":"2026-08-20T01:14:14.208796Z","steps":["trace[2045733939] 'read index received' (duration: 736.415243ms)","trace[2045733939] 'applied index is now lower than readState.Index' (duration: 189.874µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T01:14:14.208876Z","caller":"traceutil/trace.go:171","msg":"trace[1404518690] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"940.95901ms","start":"2026-08-20T01:14:13.267888Z","end":"2026-08-20T01:14:14.208847Z","steps":["trace[1404518690] 'process raft request' (duration: 940.739265ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:14.20895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"736.74368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T01:14:14.208998Z","caller":"traceutil/trace.go:171","msg":"trace[1265851115] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:614; }","duration":"736.840042ms","start":"2026-08-20T01:14:13.472149Z","end":"2026-08-20T01:14:14.208989Z","steps":["trace[1265851115] 'agreement among raft nodes before linearized reading' (duration: 736.7464ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:14.209043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:13.472128Z","time spent":"736.906244ms","remote":"127.0.0.1:57778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-20T01:14:14.209044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:13.267856Z","time spent":"941.097804ms","remote":"127.0.0.1:58034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T01:14:14.565894Z","caller":"traceutil/trace.go:171","msg":"trace[174481782] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"104.76581ms","start":"2026-08-20T01:14:14.461104Z","end":"2026-08-20T01:14:14.56587Z","steps":["trace[174481782] 'compare' (duration: 97.411653ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:14.821775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.386976ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T01:14:14.821893Z","caller":"traceutil/trace.go:171","msg":"trace[18046097] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:619; }","duration":"139.516159ms","start":"2026-08-20T01:14:14.68236Z","end":"2026-08-20T01:14:14.821876Z","steps":["trace[18046097] 'range keys from in-memory index tree' (duration: 139.368456ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:14.822114Z","caller":"traceutil/trace.go:171","msg":"trace[1240408806] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"242.350255ms","start":"2026-08-20T01:14:14.579754Z","end":"2026-08-20T01:14:14.822104Z","steps":["trace[1240408806] 'process raft request' (duration: 235.673314ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:16.123934Z","caller":"traceutil/trace.go:171","msg":"trace[795307645] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"333.017761ms","start":"2026-08-20T01:14:15.790892Z","end":"2026-08-20T01:14:16.123909Z","steps":["trace[795307645] 'process raft request' (duration: 332.876188ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:16.124077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:15.790868Z","time spent":"333.143194ms","remote":"127.0.0.1:57850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":700,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T01:14:16.353563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.337134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-08-20T01:14:16.353566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.597489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-20T01:14:16.353663Z","caller":"traceutil/trace.go:171","msg":"trace[1097118236] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:623; }","duration":"110.495848ms","start":"2026-08-20T01:14:16.243144Z","end":"2026-08-20T01:14:16.35364Z","steps":["trace[1097118236] 'range keys from in-memory index tree' (duration: 110.101729ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:16.3537Z","caller":"traceutil/trace.go:171","msg":"trace[424873865] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:623; }","duration":"106.828405ms","start":"2026-08-20T01:14:16.246824Z","end":"2026-08-20T01:14:16.353652Z","steps":["trace[424873865] 'range keys from in-memory index tree' (duration: 106.333004ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:16.353579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.680731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-20T01:14:16.353759Z","caller":"traceutil/trace.go:171","msg":"trace[353627019] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:623; }","duration":"106.908407ms","start":"2026-08-20T01:14:16.246831Z","end":"2026-08-20T01:14:16.35374Z","steps":["trace[353627019] 'range keys from in-memory index tree' (duration: 106.429926ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:18.478891Z","caller":"traceutil/trace.go:171","msg":"trace[1941179896] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"168.959293ms","start":"2026-08-20T01:14:18.309907Z","end":"2026-08-20T01:14:18.478867Z","steps":["trace[1941179896] 'process raft request' (duration: 168.770339ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:20.281129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.751243ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-08-20T01:14:20.281264Z","caller":"traceutil/trace.go:171","msg":"trace[1808542985] linearizableReadLoop","detail":"{readStateIndex:671; appliedIndex:670; }","duration":"154.057012ms","start":"2026-08-20T01:14:20.127183Z","end":"2026-08-20T01:14:20.28124Z","steps":["trace[1808542985] 'read index received' (duration: 28.941µs)","trace[1808542985] 'applied index is now lower than readState.Index' (duration: 154.025721ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T01:14:20.281455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.248886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-08-20T01:14:20.281552Z","caller":"traceutil/trace.go:171","msg":"trace[1524758076] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:642; }","duration":"154.38348ms","start":"2026-08-20T01:14:20.127146Z","end":"2026-08-20T01:14:20.281529Z","steps":["trace[1524758076] 'agreement among raft nodes before linearized reading' (duration: 154.151384ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:28.816746Z","caller":"traceutil/trace.go:171","msg":"trace[479282190] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"171.205851ms","start":"2026-08-20T01:14:28.645512Z","end":"2026-08-20T01:14:28.816718Z","steps":["trace[479282190] 'process raft request' (duration: 125.58949ms)","trace[479282190] 'compare' (duration: 45.496509ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T01:14:29.085114Z","caller":"traceutil/trace.go:171","msg":"trace[4173274] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"400.363192ms","start":"2026-08-20T01:14:28.684726Z","end":"2026-08-20T01:14:29.085089Z","steps":["trace[4173274] 'process raft request' (duration: 400.309831ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:29.085156Z","caller":"traceutil/trace.go:171","msg":"trace[556653287] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"430.935354ms","start":"2026-08-20T01:14:28.654185Z","end":"2026-08-20T01:14:29.08512Z","steps":["trace[556653287] 'process raft request' (duration: 430.715719ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:29.085353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:28.654168Z","time spent":"431.094047ms","remote":"127.0.0.1:57950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18694,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T01:14:29.085423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:28.684708Z","time spent":"400.527315ms","remote":"127.0.0.1:58034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T01:14:29.124922Z","caller":"traceutil/trace.go:171","msg":"trace[658196183] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"174.399573ms","start":"2026-08-20T01:14:28.950502Z","end":"2026-08-20T01:14:29.124901Z","steps":["trace[658196183] 'process raft request' (duration: 174.309411ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:29.308457Z","caller":"traceutil/trace.go:171","msg":"trace[1790271405] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"161.142302ms","start":"2026-08-20T01:14:29.147291Z","end":"2026-08-20T01:14:29.308433Z","steps":["trace[1790271405] 'process raft request' (duration: 160.905337ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:34.74165Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3427415361682858163,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-20T01:14:35.242272Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3427415361682858163,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-20T01:14:35.328273Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.723121453s","expected-duration":"1s"} {"level":"info","ts":"2026-08-20T01:14:35.328757Z","caller":"traceutil/trace.go:171","msg":"trace[626539500] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"1.723687666s","start":"2026-08-20T01:14:33.60504Z","end":"2026-08-20T01:14:35.328728Z","steps":["trace[626539500] 'process raft request' (duration: 1.723431281s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:35.328893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:33.605014Z","time spent":"1.723802338s","remote":"127.0.0.1:57950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T01:14:35.336951Z","caller":"traceutil/trace.go:171","msg":"trace[1351481356] linearizableReadLoop","detail":"{readStateIndex:814; appliedIndex:812; }","duration":"1.095801331s","start":"2026-08-20T01:14:34.241134Z","end":"2026-08-20T01:14:35.336935Z","steps":["trace[1351481356] 'read index received' (duration: 1.0873462s)","trace[1351481356] 'applied index is now lower than readState.Index' (duration: 8.453711ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T01:14:35.337025Z","caller":"traceutil/trace.go:171","msg":"trace[1468190341] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"968.267712ms","start":"2026-08-20T01:14:34.368737Z","end":"2026-08-20T01:14:35.337005Z","steps":["trace[1468190341] 'process raft request' (duration: 968.102728ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:35.33711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.095954075s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-20T01:14:35.337148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.636219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T01:14:35.337183Z","caller":"traceutil/trace.go:171","msg":"trace[2016864909] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:781; }","duration":"1.096070577s","start":"2026-08-20T01:14:34.241097Z","end":"2026-08-20T01:14:35.337168Z","steps":["trace[2016864909] 'agreement among raft nodes before linearized reading' (duration: 1.095937264s)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:35.337191Z","caller":"traceutil/trace.go:171","msg":"trace[1776980345] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:781; }","duration":"154.68821ms","start":"2026-08-20T01:14:35.182493Z","end":"2026-08-20T01:14:35.337181Z","steps":["trace[1776980345] 'agreement among raft nodes before linearized reading' (duration: 154.617699ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:35.337223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:34.241081Z","time spent":"1.096134119s","remote":"127.0.0.1:57862","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":9,"response size":29,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"warn","ts":"2026-08-20T01:14:35.337228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"737.572315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-08-20T01:14:35.337225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.901369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-20T01:14:35.337325Z","caller":"traceutil/trace.go:171","msg":"trace[220590500] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:781; }","duration":"503.057893ms","start":"2026-08-20T01:14:34.83425Z","end":"2026-08-20T01:14:35.337308Z","steps":["trace[220590500] 'agreement among raft nodes before linearized reading' (duration: 502.829178ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:35.337401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:34.834229Z","time spent":"503.161145ms","remote":"127.0.0.1:58034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-20T01:14:35.337278Z","caller":"traceutil/trace.go:171","msg":"trace[2125378173] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:781; }","duration":"737.641687ms","start":"2026-08-20T01:14:34.599617Z","end":"2026-08-20T01:14:35.337258Z","steps":["trace[2125378173] 'agreement among raft nodes before linearized reading' (duration: 737.516574ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:35.337499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:34.599593Z","time spent":"737.899133ms","remote":"127.0.0.1:58034","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-08-20T01:14:35.337526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"669.307015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-08-20T01:14:35.337467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.550556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T01:14:35.337639Z","caller":"traceutil/trace.go:171","msg":"trace[1346760286] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:781; }","duration":"500.798752ms","start":"2026-08-20T01:14:34.836823Z","end":"2026-08-20T01:14:35.337622Z","steps":["trace[1346760286] 'agreement among raft nodes before linearized reading' (duration: 500.445044ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:35.337649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"923.437731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.59\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-08-20T01:14:35.337714Z","caller":"traceutil/trace.go:171","msg":"trace[1364598174] range","detail":"{range_begin:/registry/masterleases/199.19.213.59; range_end:; response_count:1; response_revision:781; }","duration":"923.521172ms","start":"2026-08-20T01:14:34.414182Z","end":"2026-08-20T01:14:35.337704Z","steps":["trace[1364598174] 'agreement among raft nodes before linearized reading' (duration: 922.855207ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:35.337725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:34.8368Z","time spent":"500.913504ms","remote":"127.0.0.1:58068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"warn","ts":"2026-08-20T01:14:35.33775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:34.414171Z","time spent":"923.571624ms","remote":"127.0.0.1:57802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":155,"request content":"key:\"/registry/masterleases/199.19.213.59\" "} {"level":"info","ts":"2026-08-20T01:14:35.337584Z","caller":"traceutil/trace.go:171","msg":"trace[1196514973] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:781; }","duration":"669.409437ms","start":"2026-08-20T01:14:34.668162Z","end":"2026-08-20T01:14:35.337572Z","steps":["trace[1196514973] 'agreement among raft nodes before linearized reading' (duration: 669.140771ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:35.33804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:34.668134Z","time spent":"669.890797ms","remote":"127.0.0.1:58034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-20T01:14:35.337536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"866.228679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T01:14:35.338163Z","caller":"traceutil/trace.go:171","msg":"trace[1815266257] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:781; }","duration":"866.875714ms","start":"2026-08-20T01:14:34.47127Z","end":"2026-08-20T01:14:35.338146Z","steps":["trace[1815266257] 'agreement among raft nodes before linearized reading' (duration: 866.229699ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:35.337669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:34.368716Z","time spent":"968.367555ms","remote":"127.0.0.1:58034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T01:14:35.338212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:34.471252Z","time spent":"866.947335ms","remote":"127.0.0.1:57778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-20T01:14:35.337572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"911.944461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-20T01:14:35.338372Z","caller":"traceutil/trace.go:171","msg":"trace[1824211867] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:781; }","duration":"912.79198ms","start":"2026-08-20T01:14:34.425568Z","end":"2026-08-20T01:14:35.33836Z","steps":["trace[1824211867] 'agreement among raft nodes before linearized reading' (duration: 911.93387ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:14:35.338413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:14:34.425538Z","time spent":"912.864312ms","remote":"127.0.0.1:58034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-20T01:14:49.604835Z","caller":"traceutil/trace.go:171","msg":"trace[1151775363] transaction","detail":"{read_only:false; number_of_response:1; response_revision:939; }","duration":"114.906164ms","start":"2026-08-20T01:14:49.489902Z","end":"2026-08-20T01:14:49.604808Z","steps":["trace[1151775363] 'process raft request' (duration: 101.501303ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:49.604962Z","caller":"traceutil/trace.go:171","msg":"trace[1584066407] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"115.013556ms","start":"2026-08-20T01:14:49.489936Z","end":"2026-08-20T01:14:49.60495Z","steps":["trace[1584066407] 'process raft request' (duration: 114.815692ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:49.605096Z","caller":"traceutil/trace.go:171","msg":"trace[1288694326] transaction","detail":"{read_only:false; response_revision:940; number_of_response:1; }","duration":"115.170291ms","start":"2026-08-20T01:14:49.48992Z","end":"2026-08-20T01:14:49.60509Z","steps":["trace[1288694326] 'process raft request' (duration: 114.777892ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:49.605156Z","caller":"traceutil/trace.go:171","msg":"trace[1294318940] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"114.631219ms","start":"2026-08-20T01:14:49.490505Z","end":"2026-08-20T01:14:49.605136Z","steps":["trace[1294318940] 'process raft request' (duration: 114.278361ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:49.605314Z","caller":"traceutil/trace.go:171","msg":"trace[311197829] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"111.666691ms","start":"2026-08-20T01:14:49.49364Z","end":"2026-08-20T01:14:49.605307Z","steps":["trace[311197829] 'process raft request' (duration: 111.185981ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:50.284037Z","caller":"traceutil/trace.go:171","msg":"trace[331543897] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"177.188524ms","start":"2026-08-20T01:14:50.106826Z","end":"2026-08-20T01:14:50.284014Z","steps":["trace[331543897] 'process raft request' (duration: 177.037871ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:55.809874Z","caller":"traceutil/trace.go:171","msg":"trace[1633142577] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"131.028793ms","start":"2026-08-20T01:14:55.678822Z","end":"2026-08-20T01:14:55.80985Z","steps":["trace[1633142577] 'process raft request' (duration: 130.982352ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:14:55.809925Z","caller":"traceutil/trace.go:171","msg":"trace[1392587559] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"132.62672ms","start":"2026-08-20T01:14:55.677258Z","end":"2026-08-20T01:14:55.809885Z","steps":["trace[1392587559] 'process raft request' (duration: 115.434103ms)","trace[1392587559] 'compare' (duration: 16.921581ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T01:14:55.809969Z","caller":"traceutil/trace.go:171","msg":"trace[775484591] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"131.154176ms","start":"2026-08-20T01:14:55.678797Z","end":"2026-08-20T01:14:55.809951Z","steps":["trace[775484591] 'process raft request' (duration: 130.957882ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:15:02.049182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.135084ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-20T01:15:02.049419Z","caller":"traceutil/trace.go:171","msg":"trace[27975555] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"199.136607ms","start":"2026-08-20T01:15:01.850261Z","end":"2026-08-20T01:15:02.049398Z","steps":["trace[27975555] 'process raft request' (duration: 54.670857ms)","trace[27975555] 'compare' (duration: 143.839976ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T01:15:02.049481Z","caller":"traceutil/trace.go:171","msg":"trace[508488094] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"199.014805ms","start":"2026-08-20T01:15:01.850445Z","end":"2026-08-20T01:15:02.04946Z","steps":["trace[508488094] 'process raft request' (duration: 198.876492ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:15:02.049771Z","caller":"traceutil/trace.go:171","msg":"trace[1278713364] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"199.009995ms","start":"2026-08-20T01:15:01.850727Z","end":"2026-08-20T01:15:02.049737Z","steps":["trace[1278713364] 'process raft request' (duration: 198.677348ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:15:38.547552Z","caller":"traceutil/trace.go:171","msg":"trace[284478341] transaction","detail":"{read_only:false; response_revision:1121; number_of_response:1; }","duration":"174.933355ms","start":"2026-08-20T01:15:38.372548Z","end":"2026-08-20T01:15:38.547481Z","steps":["trace[284478341] 'process raft request' (duration: 168.804289ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:15:49.940904Z","caller":"traceutil/trace.go:171","msg":"trace[513474210] transaction","detail":"{read_only:false; response_revision:1155; number_of_response:1; }","duration":"121.066441ms","start":"2026-08-20T01:15:49.819801Z","end":"2026-08-20T01:15:49.940868Z","steps":["trace[513474210] 'process raft request' (duration: 120.839796ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:15:50.048539Z","caller":"traceutil/trace.go:171","msg":"trace[154543905] transaction","detail":"{read_only:false; response_revision:1156; number_of_response:1; }","duration":"120.051776ms","start":"2026-08-20T01:15:49.928427Z","end":"2026-08-20T01:15:50.048479Z","steps":["trace[154543905] 'process raft request' (duration: 66.937642ms)","trace[154543905] 'compare' (duration: 52.711985ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T01:15:50.82107Z","caller":"traceutil/trace.go:171","msg":"trace[1509307662] transaction","detail":"{read_only:false; response_revision:1161; number_of_response:1; }","duration":"151.035468ms","start":"2026-08-20T01:15:50.670004Z","end":"2026-08-20T01:15:50.821039Z","steps":["trace[1509307662] 'process raft request' (duration: 150.867495ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:16:03.075926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.681279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-20T01:16:03.076042Z","caller":"traceutil/trace.go:171","msg":"trace[2136944734] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1198; }","duration":"195.839803ms","start":"2026-08-20T01:16:02.880174Z","end":"2026-08-20T01:16:03.076014Z","steps":["trace[2136944734] 'range keys from in-memory index tree' (duration: 195.515995ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:16:03.076164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.749339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-20T01:16:03.076211Z","caller":"traceutil/trace.go:171","msg":"trace[1199873002] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1198; }","duration":"462.829451ms","start":"2026-08-20T01:16:02.613368Z","end":"2026-08-20T01:16:03.076197Z","steps":["trace[1199873002] 'range keys from in-memory index tree' (duration: 462.612257ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:16:03.076245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:16:02.613349Z","time spent":"462.887982ms","remote":"127.0.0.1:58034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-20T01:16:10.625615Z","caller":"traceutil/trace.go:171","msg":"trace[2000462354] linearizableReadLoop","detail":"{readStateIndex:1277; appliedIndex:1276; }","duration":"153.78445ms","start":"2026-08-20T01:16:10.471759Z","end":"2026-08-20T01:16:10.625543Z","steps":["trace[2000462354] 'read index received' (duration: 152.796227ms)","trace[2000462354] 'applied index is now lower than readState.Index' (duration: 986.563µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T01:16:10.62593Z","caller":"traceutil/trace.go:171","msg":"trace[1741519508] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"205.648647ms","start":"2026-08-20T01:16:10.420232Z","end":"2026-08-20T01:16:10.625881Z","steps":["trace[1741519508] 'process raft request' (duration: 204.384037ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:16:10.62621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.431434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-20T01:16:10.626258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.402109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-20T01:16:10.626339Z","caller":"traceutil/trace.go:171","msg":"trace[498890999] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1224; }","duration":"154.584768ms","start":"2026-08-20T01:16:10.471704Z","end":"2026-08-20T01:16:10.626289Z","steps":["trace[498890999] 'agreement among raft nodes before linearized reading' (duration: 154.21872ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:16:10.626351Z","caller":"traceutil/trace.go:171","msg":"trace[743148995] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1224; }","duration":"131.523042ms","start":"2026-08-20T01:16:10.494786Z","end":"2026-08-20T01:16:10.626309Z","steps":["trace[743148995] 'agreement among raft nodes before linearized reading' (duration: 131.260125ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:16:11.352948Z","caller":"traceutil/trace.go:171","msg":"trace[592989282] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"108.162397ms","start":"2026-08-20T01:16:11.244752Z","end":"2026-08-20T01:16:11.352914Z","steps":["trace[592989282] 'process raft request' (duration: 24.692565ms)","trace[592989282] 'compare' (duration: 83.352369ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T01:16:13.399527Z","caller":"traceutil/trace.go:171","msg":"trace[312434773] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"152.165278ms","start":"2026-08-20T01:16:13.247331Z","end":"2026-08-20T01:16:13.399496Z","steps":["trace[312434773] 'process raft request' (duration: 151.951783ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:16:24.856571Z","caller":"traceutil/trace.go:171","msg":"trace[1315113050] transaction","detail":"{read_only:false; response_revision:1304; number_of_response:1; }","duration":"126.266376ms","start":"2026-08-20T01:16:24.730278Z","end":"2026-08-20T01:16:24.856544Z","steps":["trace[1315113050] 'process raft request' (duration: 126.102553ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:16:30.606724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.3111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-20T01:16:30.606812Z","caller":"traceutil/trace.go:171","msg":"trace[29587719] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1324; }","duration":"224.490933ms","start":"2026-08-20T01:16:30.382294Z","end":"2026-08-20T01:16:30.606785Z","steps":["trace[29587719] 'range keys from in-memory index tree' (duration: 224.087885ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:16:30.609342Z","caller":"traceutil/trace.go:171","msg":"trace[363008558] transaction","detail":"{read_only:false; response_revision:1325; number_of_response:1; }","duration":"225.546268ms","start":"2026-08-20T01:16:30.383771Z","end":"2026-08-20T01:16:30.609318Z","steps":["trace[363008558] 'process raft request' (duration: 225.395555ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:16:33.658539Z","caller":"traceutil/trace.go:171","msg":"trace[1551914233] linearizableReadLoop","detail":"{readStateIndex:1397; appliedIndex:1396; }","duration":"126.33728ms","start":"2026-08-20T01:16:33.532184Z","end":"2026-08-20T01:16:33.658522Z","steps":["trace[1551914233] 'read index received' (duration: 126.159546ms)","trace[1551914233] 'applied index is now lower than readState.Index' (duration: 177.004µs)"],"step_count":2} {"level":"warn","ts":"2026-08-20T01:16:33.658683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.483843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-20T01:16:33.658703Z","caller":"traceutil/trace.go:171","msg":"trace[1021481965] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1338; }","duration":"126.541545ms","start":"2026-08-20T01:16:33.532155Z","end":"2026-08-20T01:16:33.658696Z","steps":["trace[1021481965] 'agreement among raft nodes before linearized reading' (duration: 126.434983ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:16:33.658825Z","caller":"traceutil/trace.go:171","msg":"trace[1510686864] transaction","detail":"{read_only:false; response_revision:1338; number_of_response:1; }","duration":"147.550851ms","start":"2026-08-20T01:16:33.511223Z","end":"2026-08-20T01:16:33.658774Z","steps":["trace[1510686864] 'process raft request' (duration: 147.142582ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:16:33.877935Z","caller":"traceutil/trace.go:171","msg":"trace[657104151] linearizableReadLoop","detail":"{readStateIndex:1398; appliedIndex:1397; }","duration":"211.845717ms","start":"2026-08-20T01:16:33.666066Z","end":"2026-08-20T01:16:33.877912Z","steps":["trace[657104151] 'read index received' (duration: 211.647272ms)","trace[657104151] 'applied index is now lower than readState.Index' (duration: 197.525µs)"],"step_count":2} {"level":"warn","ts":"2026-08-20T01:16:33.878056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.96984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T01:16:33.87805Z","caller":"traceutil/trace.go:171","msg":"trace[938785998] transaction","detail":"{read_only:false; response_revision:1339; number_of_response:1; }","duration":"215.045801ms","start":"2026-08-20T01:16:33.662972Z","end":"2026-08-20T01:16:33.878017Z","steps":["trace[938785998] 'process raft request' (duration: 214.809216ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:16:33.878088Z","caller":"traceutil/trace.go:171","msg":"trace[2089092501] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1339; }","duration":"212.040602ms","start":"2026-08-20T01:16:33.666037Z","end":"2026-08-20T01:16:33.878078Z","steps":["trace[2089092501] 'agreement among raft nodes before linearized reading' (duration: 211.97335ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:16:58.922995Z","caller":"traceutil/trace.go:171","msg":"trace[906142874] transaction","detail":"{read_only:false; response_revision:1426; number_of_response:1; }","duration":"130.990279ms","start":"2026-08-20T01:16:58.791978Z","end":"2026-08-20T01:16:58.922968Z","steps":["trace[906142874] 'process raft request' (duration: 128.43425ms)"],"step_count":1}