{"level":"warn","ts":"2026-07-29T06:32:16.987827Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-29T06:32:16.987923Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.144:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.144:2380","--initial-cluster=instance=https://199.204.45.144:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.144:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.144:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-07-29T06:32:16.987997Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-29T06:32:16.988006Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.144:2380"]} {"level":"info","ts":"2026-07-29T06:32:16.988027Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-29T06:32:16.988743Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"]} {"level":"info","ts":"2026-07-29T06:32:16.988838Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.144:2380"],"listen-peer-urls":["https://199.204.45.144:2380"],"advertise-client-urls":["https://199.204.45.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.144:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-07-29T06:32:16.991305Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.182396ms"} {"level":"info","ts":"2026-07-29T06:32:16.996367Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4594e5f716bad646","cluster-id":"ff2e51b364668606"} {"level":"info","ts":"2026-07-29T06:32:16.996452Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=()"} {"level":"info","ts":"2026-07-29T06:32:16.996472Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became follower at term 0"} {"level":"info","ts":"2026-07-29T06:32:16.996484Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4594e5f716bad646 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-29T06:32:16.996512Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became follower at term 1"} {"level":"info","ts":"2026-07-29T06:32:16.996553Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=(5013885134571230790)"} {"level":"warn","ts":"2026-07-29T06:32:17.003014Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-29T06:32:17.005374Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-29T06:32:17.006364Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-07-29T06:32:17.009632Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4594e5f716bad646","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-29T06:32:17.009788Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-29T06:32:17.009911Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-29T06:32:17.009929Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-29T06:32:17.010172Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4594e5f716bad646","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-29T06:32:17.01321Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=(5013885134571230790)"} {"level":"info","ts":"2026-07-29T06:32:17.013355Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ff2e51b364668606","local-member-id":"4594e5f716bad646","added-peer-id":"4594e5f716bad646","added-peer-peer-urls":["https://199.204.45.144:2380"]} {"level":"info","ts":"2026-07-29T06:32:17.015001Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-29T06:32:17.015186Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4594e5f716bad646","initial-advertise-peer-urls":["https://199.204.45.144:2380"],"listen-peer-urls":["https://199.204.45.144:2380"],"advertise-client-urls":["https://199.204.45.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-29T06:32:17.015216Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-29T06:32:17.015306Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.144:2380"} {"level":"info","ts":"2026-07-29T06:32:17.015322Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.144:2380"} {"level":"info","ts":"2026-07-29T06:32:17.19701Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 is starting a new election at term 1"} {"level":"info","ts":"2026-07-29T06:32:17.197074Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-29T06:32:17.197113Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 received MsgPreVoteResp from 4594e5f716bad646 at term 1"} {"level":"info","ts":"2026-07-29T06:32:17.197138Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became candidate at term 2"} {"level":"info","ts":"2026-07-29T06:32:17.197153Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 received MsgVoteResp from 4594e5f716bad646 at term 2"} {"level":"info","ts":"2026-07-29T06:32:17.197173Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became leader at term 2"} {"level":"info","ts":"2026-07-29T06:32:17.197195Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4594e5f716bad646 elected leader 4594e5f716bad646 at term 2"} {"level":"info","ts":"2026-07-29T06:32:17.203878Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-29T06:32:17.206571Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4594e5f716bad646","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.144:2379]}","request-path":"/0/members/4594e5f716bad646/attributes","cluster-id":"ff2e51b364668606","publish-timeout":"7s"} {"level":"info","ts":"2026-07-29T06:32:17.206803Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-29T06:32:17.206863Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-29T06:32:17.207145Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ff2e51b364668606","local-member-id":"4594e5f716bad646","cluster-version":"3.5"} {"level":"info","ts":"2026-07-29T06:32:17.207353Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-29T06:32:17.207392Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-29T06:32:17.211217Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.144:2379"} {"level":"info","ts":"2026-07-29T06:32:17.212011Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-29T06:32:17.212063Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-29T06:32:17.212474Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-29T06:32:18.989902Z","caller":"traceutil/trace.go:171","msg":"trace[946342936] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"133.187964ms","start":"2026-07-29T06:32:18.856687Z","end":"2026-07-29T06:32:18.989875Z","steps":["trace[946342936] 'read index received' (duration: 133.04482ms)","trace[946342936] 'applied index is now lower than readState.Index' (duration: 141.453µs)"],"step_count":2} {"level":"info","ts":"2026-07-29T06:32:18.990057Z","caller":"traceutil/trace.go:171","msg":"trace[789847288] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"133.709557ms","start":"2026-07-29T06:32:18.85619Z","end":"2026-07-29T06:32:18.9899Z","steps":["trace[789847288] 'process raft request' (duration: 133.466181ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T06:32:18.990324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.592554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-29T06:32:18.990587Z","caller":"traceutil/trace.go:171","msg":"trace[39909099] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:2; }","duration":"133.882832ms","start":"2026-07-29T06:32:18.856678Z","end":"2026-07-29T06:32:18.990561Z","steps":["trace[39909099] 'agreement among raft nodes before linearized reading' (duration: 133.284806ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T06:32:19.020573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.68642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-29T06:32:19.020638Z","caller":"traceutil/trace.go:171","msg":"trace[951451772] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:10; }","duration":"162.774943ms","start":"2026-07-29T06:32:18.857849Z","end":"2026-07-29T06:32:19.020624Z","steps":["trace[951451772] 'agreement among raft nodes before linearized reading' (duration: 162.66816ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T06:32:20.449898Z","caller":"traceutil/trace.go:171","msg":"trace[476637872] transaction","detail":"{read_only:false; response_revision:130; number_of_response:1; }","duration":"249.679297ms","start":"2026-07-29T06:32:20.200187Z","end":"2026-07-29T06:32:20.449866Z","steps":["trace[476637872] 'process raft request' (duration: 205.317237ms)","trace[476637872] 'compare' (duration: 44.204316ms)"],"step_count":2} {"level":"info","ts":"2026-07-29T06:32:28.319073Z","caller":"traceutil/trace.go:171","msg":"trace[1395923846] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"159.962689ms","start":"2026-07-29T06:32:28.159071Z","end":"2026-07-29T06:32:28.319034Z","steps":["trace[1395923846] 'process raft request' (duration: 86.791903ms)","trace[1395923846] 'compare' (duration: 72.967921ms)"],"step_count":2} {"level":"info","ts":"2026-07-29T06:32:51.381603Z","caller":"traceutil/trace.go:171","msg":"trace[1868109868] transaction","detail":"{read_only:false; response_revision:447; number_of_response:1; }","duration":"224.326941ms","start":"2026-07-29T06:32:51.157234Z","end":"2026-07-29T06:32:51.381561Z","steps":["trace[1868109868] 'process raft request' (duration: 224.136716ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T06:32:55.189418Z","caller":"traceutil/trace.go:171","msg":"trace[1744957763] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"290.903128ms","start":"2026-07-29T06:32:54.898488Z","end":"2026-07-29T06:32:55.189391Z","steps":["trace[1744957763] 'process raft request' (duration: 279.877857ms)","trace[1744957763] 'compare' (duration: 10.929999ms)"],"step_count":2} {"level":"info","ts":"2026-07-29T06:32:55.189817Z","caller":"traceutil/trace.go:171","msg":"trace[1626356709] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"290.923568ms","start":"2026-07-29T06:32:54.898864Z","end":"2026-07-29T06:32:55.189788Z","steps":["trace[1626356709] 'process raft request' (duration: 290.719183ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T06:32:55.189972Z","caller":"traceutil/trace.go:171","msg":"trace[1815550234] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"193.521696ms","start":"2026-07-29T06:32:54.996443Z","end":"2026-07-29T06:32:55.189965Z","steps":["trace[1815550234] 'process raft request' (duration: 193.476364ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T06:32:55.190185Z","caller":"traceutil/trace.go:171","msg":"trace[1078427114] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"289.664067ms","start":"2026-07-29T06:32:54.900516Z","end":"2026-07-29T06:32:55.19018Z","steps":["trace[1078427114] 'process raft request' (duration: 289.138673ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T06:32:55.190198Z","caller":"traceutil/trace.go:171","msg":"trace[2141057215] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"283.864539ms","start":"2026-07-29T06:32:54.906323Z","end":"2026-07-29T06:32:55.190187Z","steps":["trace[2141057215] 'process raft request' (duration: 283.485879ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T06:32:55.190299Z","caller":"traceutil/trace.go:171","msg":"trace[1045546963] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"288.183179ms","start":"2026-07-29T06:32:54.902111Z","end":"2026-07-29T06:32:55.190294Z","steps":["trace[1045546963] 'process raft request' (duration: 287.604853ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T06:33:00.778934Z","caller":"traceutil/trace.go:171","msg":"trace[800928610] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"100.165355ms","start":"2026-07-29T06:33:00.678741Z","end":"2026-07-29T06:33:00.778906Z","steps":["trace[800928610] 'read index received' (duration: 99.568309ms)","trace[800928610] 'applied index is now lower than readState.Index' (duration: 596.266µs)"],"step_count":2} {"level":"warn","ts":"2026-07-29T06:33:00.779079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.332899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-dkntd\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-29T06:33:00.779101Z","caller":"traceutil/trace.go:171","msg":"trace[1824627083] range","detail":"{range_begin:/registry/pods/kube-system/cilium-dkntd; range_end:; response_count:1; response_revision:592; }","duration":"100.4069ms","start":"2026-07-29T06:33:00.678686Z","end":"2026-07-29T06:33:00.779093Z","steps":["trace[1824627083] 'agreement among raft nodes before linearized reading' (duration: 100.316578ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T06:33:00.779083Z","caller":"traceutil/trace.go:171","msg":"trace[1366385264] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"131.010271ms","start":"2026-07-29T06:33:00.648011Z","end":"2026-07-29T06:33:00.779021Z","steps":["trace[1366385264] 'process raft request' (duration: 130.396455ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T06:33:01.159878Z","caller":"traceutil/trace.go:171","msg":"trace[983908200] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"358.594375ms","start":"2026-07-29T06:33:00.801249Z","end":"2026-07-29T06:33:01.159843Z","steps":["trace[983908200] 'process raft request' (duration: 358.396239ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T06:33:01.160542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T06:33:00.801205Z","time spent":"358.764229ms","remote":"127.0.0.1:54964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T06:33:01.402112Z","caller":"traceutil/trace.go:171","msg":"trace[980922353] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:613; }","duration":"464.488015ms","start":"2026-07-29T06:33:00.937584Z","end":"2026-07-29T06:33:01.402072Z","steps":["trace[980922353] 'read index received' (duration: 222.094564ms)","trace[980922353] 'applied index is now lower than readState.Index' (duration: 242.392401ms)"],"step_count":2} {"level":"info","ts":"2026-07-29T06:33:01.4023Z","caller":"traceutil/trace.go:171","msg":"trace[281721674] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"572.51447ms","start":"2026-07-29T06:33:00.829768Z","end":"2026-07-29T06:33:01.402283Z","steps":["trace[281721674] 'process raft request' (duration: 504.067355ms)","trace[281721674] 'compare' (duration: 68.011834ms)"],"step_count":2} {"level":"warn","ts":"2026-07-29T06:33:01.402439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T06:33:00.829736Z","time spent":"572.596191ms","remote":"127.0.0.1:55126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-29T06:33:01.402503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.721603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-29T06:33:01.402595Z","caller":"traceutil/trace.go:171","msg":"trace[429668944] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:594; }","duration":"179.844196ms","start":"2026-07-29T06:33:01.222728Z","end":"2026-07-29T06:33:01.402573Z","steps":["trace[429668944] 'agreement among raft nodes before linearized reading' (duration: 179.573399ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T06:33:01.402576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.972118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.144\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-29T06:33:01.402759Z","caller":"traceutil/trace.go:171","msg":"trace[719478768] range","detail":"{range_begin:/registry/masterleases/199.204.45.144; range_end:; response_count:1; response_revision:594; }","duration":"465.218914ms","start":"2026-07-29T06:33:00.937513Z","end":"2026-07-29T06:33:01.402732Z","steps":["trace[719478768] 'agreement among raft nodes before linearized reading' (duration: 464.795273ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T06:33:01.402824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T06:33:00.937479Z","time spent":"465.332076ms","remote":"127.0.0.1:54818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.144\" "} {"level":"warn","ts":"2026-07-29T06:33:02.201669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"593.439753ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-29T06:33:02.201883Z","caller":"traceutil/trace.go:171","msg":"trace[1407934134] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"794.562463ms","start":"2026-07-29T06:33:01.407282Z","end":"2026-07-29T06:33:02.201844Z","steps":["trace[1407934134] 'process raft request' (duration: 200.670978ms)","trace[1407934134] 'compare' (duration: 593.153056ms)"],"step_count":2} {"level":"info","ts":"2026-07-29T06:33:02.201973Z","caller":"traceutil/trace.go:171","msg":"trace[2029726218] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"785.536333ms","start":"2026-07-29T06:33:01.416413Z","end":"2026-07-29T06:33:02.20195Z","steps":["trace[2029726218] 'process raft request' (duration: 785.41145ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T06:33:02.202062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T06:33:01.407254Z","time spent":"794.705996ms","remote":"127.0.0.1:55044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T06:33:02.202117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T06:33:01.416389Z","time spent":"785.644975ms","remote":"127.0.0.1:54818","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T06:33:02.202288Z","caller":"traceutil/trace.go:171","msg":"trace[1415449893] linearizableReadLoop","detail":"{readStateIndex:617; appliedIndex:615; }","duration":"789.37214ms","start":"2026-07-29T06:33:01.412739Z","end":"2026-07-29T06:33:02.202112Z","steps":["trace[1415449893] 'read index received' (duration: 2.443562ms)","trace[1415449893] 'applied index is now lower than readState.Index' (duration: 786.925578ms)"],"step_count":2} {"level":"warn","ts":"2026-07-29T06:33:02.202511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"789.735609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-29T06:33:02.202584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"757.299263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-29T06:33:02.2026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.906232ms","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-07-29T06:33:02.202636Z","caller":"traceutil/trace.go:171","msg":"trace[117402057] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:596; }","duration":"789.897563ms","start":"2026-07-29T06:33:01.412712Z","end":"2026-07-29T06:33:02.20261Z","steps":["trace[117402057] 'agreement among raft nodes before linearized reading' (duration: 789.625507ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T06:33:02.202642Z","caller":"traceutil/trace.go:171","msg":"trace[1534902649] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:596; }","duration":"757.356675ms","start":"2026-07-29T06:33:01.445268Z","end":"2026-07-29T06:33:02.202624Z","steps":["trace[1534902649] 'agreement among raft nodes before linearized reading' (duration: 757.18346ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T06:33:02.202649Z","caller":"traceutil/trace.go:171","msg":"trace[1129785747] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:596; }","duration":"236.999464ms","start":"2026-07-29T06:33:01.965637Z","end":"2026-07-29T06:33:02.202637Z","steps":["trace[1129785747] 'agreement among raft nodes before linearized reading' (duration: 236.816509ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T06:33:02.202683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"641.963461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-29T06:33:02.202724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.927856ms","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-07-29T06:33:02.202785Z","caller":"traceutil/trace.go:171","msg":"trace[1459853254] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:596; }","duration":"642.107304ms","start":"2026-07-29T06:33:01.560665Z","end":"2026-07-29T06:33:02.202772Z","steps":["trace[1459853254] 'agreement among raft nodes before linearized reading' (duration: 641.955571ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T06:33:02.202816Z","caller":"traceutil/trace.go:171","msg":"trace[1285994818] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:596; }","duration":"205.08129ms","start":"2026-07-29T06:33:01.997712Z","end":"2026-07-29T06:33:02.202793Z","steps":["trace[1285994818] 'agreement among raft nodes before linearized reading' (duration: 204.856014ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T06:33:02.202692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T06:33:01.445218Z","time spent":"757.463167ms","remote":"127.0.0.1:55044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-29T06:33:02.202691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T06:33:01.412701Z","time spent":"789.978625ms","remote":"127.0.0.1:55284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" "} {"level":"warn","ts":"2026-07-29T06:33:02.20301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T06:33:01.560638Z","time spent":"642.361791ms","remote":"127.0.0.1:54782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-29T06:33:05.012087Z","caller":"traceutil/trace.go:171","msg":"trace[1067285375] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"174.302696ms","start":"2026-07-29T06:33:04.837708Z","end":"2026-07-29T06:33:05.01201Z","steps":["trace[1067285375] 'process raft request' (duration: 173.178217ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T06:33:19.517273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.539437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-29T06:33:19.517436Z","caller":"traceutil/trace.go:171","msg":"trace[941275008] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:765; }","duration":"393.779192ms","start":"2026-07-29T06:33:19.123626Z","end":"2026-07-29T06:33:19.517405Z","steps":["trace[941275008] 'range keys from in-memory index tree' (duration: 393.273009ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T06:33:19.517517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T06:33:19.12359Z","time spent":"393.898515ms","remote":"127.0.0.1:55044","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-07-29T06:33:19.649681Z","caller":"traceutil/trace.go:171","msg":"trace[1384671714] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"128.118597ms","start":"2026-07-29T06:33:19.521519Z","end":"2026-07-29T06:33:19.649637Z","steps":["trace[1384671714] 'process raft request' (duration: 127.757638ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T06:33:52.56622Z","caller":"traceutil/trace.go:171","msg":"trace[1169747292] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"109.080975ms","start":"2026-07-29T06:33:52.457097Z","end":"2026-07-29T06:33:52.566178Z","steps":["trace[1169747292] 'process raft request' (duration: 108.802248ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T06:34:17.416436Z","caller":"traceutil/trace.go:171","msg":"trace[147253461] linearizableReadLoop","detail":"{readStateIndex:1099; appliedIndex:1098; }","duration":"279.036396ms","start":"2026-07-29T06:34:17.137373Z","end":"2026-07-29T06:34:17.41641Z","steps":["trace[147253461] 'read index received' (duration: 278.80508ms)","trace[147253461] 'applied index is now lower than readState.Index' (duration: 229.806µs)"],"step_count":2} {"level":"warn","ts":"2026-07-29T06:34:17.416583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.19073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T06:34:17.416545Z","caller":"traceutil/trace.go:171","msg":"trace[794736897] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"288.026627ms","start":"2026-07-29T06:34:17.128486Z","end":"2026-07-29T06:34:17.416512Z","steps":["trace[794736897] 'process raft request' (duration: 287.714929ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T06:34:17.416622Z","caller":"traceutil/trace.go:171","msg":"trace[1570538079] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1058; }","duration":"279.285612ms","start":"2026-07-29T06:34:17.137325Z","end":"2026-07-29T06:34:17.41661Z","steps":["trace[1570538079] 'agreement among raft nodes before linearized reading' (duration: 279.19938ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T06:34:17.734401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.541506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T06:34:17.734497Z","caller":"traceutil/trace.go:171","msg":"trace[1042138969] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1058; }","duration":"191.681859ms","start":"2026-07-29T06:34:17.542793Z","end":"2026-07-29T06:34:17.734475Z","steps":["trace[1042138969] 'count revisions from in-memory index tree' (duration: 191.408081ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T06:34:17.734303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.905627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T06:34:17.735012Z","caller":"traceutil/trace.go:171","msg":"trace[205228089] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1058; }","duration":"175.678627ms","start":"2026-07-29T06:34:17.559296Z","end":"2026-07-29T06:34:17.734974Z","steps":["trace[205228089] 'range keys from in-memory index tree' (duration: 174.810905ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T06:34:18.857947Z","caller":"traceutil/trace.go:171","msg":"trace[965396299] linearizableReadLoop","detail":"{readStateIndex:1101; appliedIndex:1100; }","duration":"156.118935ms","start":"2026-07-29T06:34:18.701797Z","end":"2026-07-29T06:34:18.857916Z","steps":["trace[965396299] 'read index received' (duration: 155.92554ms)","trace[965396299] 'applied index is now lower than readState.Index' (duration: 192.045µs)"],"step_count":2} {"level":"info","ts":"2026-07-29T06:34:18.858051Z","caller":"traceutil/trace.go:171","msg":"trace[1674723185] transaction","detail":"{read_only:false; response_revision:1060; number_of_response:1; }","duration":"165.644659ms","start":"2026-07-29T06:34:18.692362Z","end":"2026-07-29T06:34:18.858007Z","steps":["trace[1674723185] 'process raft request' (duration: 165.384082ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T06:34:18.858252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.523521ms","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-07-29T06:34:18.858381Z","caller":"traceutil/trace.go:171","msg":"trace[718959326] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1060; }","duration":"152.678416ms","start":"2026-07-29T06:34:18.705682Z","end":"2026-07-29T06:34:18.85836Z","steps":["trace[718959326] 'agreement among raft nodes before linearized reading' (duration: 152.410169ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T06:34:18.858306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.490655ms","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-07-29T06:34:18.858481Z","caller":"traceutil/trace.go:171","msg":"trace[2143936213] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1060; }","duration":"156.72594ms","start":"2026-07-29T06:34:18.701737Z","end":"2026-07-29T06:34:18.858463Z","steps":["trace[2143936213] 'agreement among raft nodes before linearized reading' (duration: 156.352011ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T06:34:18.858677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.075329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-29T06:34:18.858814Z","caller":"traceutil/trace.go:171","msg":"trace[129906887] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1060; }","duration":"150.266745ms","start":"2026-07-29T06:34:18.708524Z","end":"2026-07-29T06:34:18.858791Z","steps":["trace[129906887] 'agreement among raft nodes before linearized reading' (duration: 149.661188ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T06:34:35.623229Z","caller":"traceutil/trace.go:171","msg":"trace[1218130517] transaction","detail":"{read_only:false; response_revision:1168; number_of_response:1; }","duration":"137.470187ms","start":"2026-07-29T06:34:35.485721Z","end":"2026-07-29T06:34:35.623191Z","steps":["trace[1218130517] 'process raft request' (duration: 137.228859ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T06:34:36.068176Z","caller":"traceutil/trace.go:171","msg":"trace[1734890400] transaction","detail":"{read_only:false; response_revision:1169; number_of_response:1; }","duration":"527.588185ms","start":"2026-07-29T06:34:35.540552Z","end":"2026-07-29T06:34:36.06814Z","steps":["trace[1734890400] 'process raft request' (duration: 526.013137ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T06:34:36.068337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T06:34:35.540523Z","time spent":"527.734259ms","remote":"127.0.0.1:55044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T06:34:52.54823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.741117ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-29T06:34:52.54853Z","caller":"traceutil/trace.go:171","msg":"trace[1189658115] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"352.333645ms","start":"2026-07-29T06:34:52.196123Z","end":"2026-07-29T06:34:52.548457Z","steps":["trace[1189658115] 'process raft request' (duration: 31.182027ms)","trace[1189658115] 'compare' (duration: 320.522292ms)"],"step_count":2} {"level":"warn","ts":"2026-07-29T06:34:52.548707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T06:34:52.196103Z","time spent":"352.51757ms","remote":"127.0.0.1:55060","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1508,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T06:34:53.231237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.895714ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-29T06:34:53.231408Z","caller":"traceutil/trace.go:171","msg":"trace[1293645420] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"1.035081604s","start":"2026-07-29T06:34:52.196308Z","end":"2026-07-29T06:34:53.23139Z","steps":["trace[1293645420] 'process raft request' (duration: 511.949264ms)","trace[1293645420] 'compare' (duration: 521.980291ms)"],"step_count":2} {"level":"warn","ts":"2026-07-29T06:34:53.231487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T06:34:52.196269Z","time spent":"1.035194817s","remote":"127.0.0.1:54954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":915,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T06:34:53.231774Z","caller":"traceutil/trace.go:171","msg":"trace[973639999] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"422.268042ms","start":"2026-07-29T06:34:52.809483Z","end":"2026-07-29T06:34:53.231751Z","steps":["trace[973639999] 'process raft request' (duration: 422.151259ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T06:34:53.231754Z","caller":"traceutil/trace.go:171","msg":"trace[191046189] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"1.029352208s","start":"2026-07-29T06:34:52.202347Z","end":"2026-07-29T06:34:53.231699Z","steps":["trace[191046189] 'process raft request' (duration: 1.028978298s)"],"step_count":1} {"level":"info","ts":"2026-07-29T06:34:53.231815Z","caller":"traceutil/trace.go:171","msg":"trace[832669860] linearizableReadLoop","detail":"{readStateIndex:1291; appliedIndex:1288; }","duration":"1.013895712s","start":"2026-07-29T06:34:52.217908Z","end":"2026-07-29T06:34:53.231804Z","steps":["trace[832669860] 'read index received' (duration: 9.41322ms)","trace[832669860] 'applied index is now lower than readState.Index' (duration: 1.004481412s)"],"step_count":2} {"level":"warn","ts":"2026-07-29T06:34:53.231914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T06:34:52.809449Z","time spent":"422.384666ms","remote":"127.0.0.1:55044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T06:34:53.231954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T06:34:52.202307Z","time spent":"1.029547423s","remote":"127.0.0.1:55260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9375,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T06:34:53.232016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.014118788s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-29T06:34:53.232038Z","caller":"traceutil/trace.go:171","msg":"trace[1920930417] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1242; }","duration":"1.014195051s","start":"2026-07-29T06:34:52.217836Z","end":"2026-07-29T06:34:53.232031Z","steps":["trace[1920930417] 'agreement among raft nodes before linearized reading' (duration: 1.014053087s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T06:34:53.232073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T06:34:52.217808Z","time spent":"1.014260952s","remote":"127.0.0.1:55044","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":"warn","ts":"2026-07-29T06:34:53.232196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.367359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-29T06:34:53.23223Z","caller":"traceutil/trace.go:171","msg":"trace[984865068] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1242; }","duration":"106.438351ms","start":"2026-07-29T06:34:53.125786Z","end":"2026-07-29T06:34:53.232224Z","steps":["trace[984865068] 'agreement among raft nodes before linearized reading' (duration: 106.363529ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T06:34:55.308588Z","caller":"traceutil/trace.go:171","msg":"trace[1817013477] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"139.829543ms","start":"2026-07-29T06:34:55.168725Z","end":"2026-07-29T06:34:55.308555Z","steps":["trace[1817013477] 'process raft request' (duration: 139.652399ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T06:35:05.185339Z","caller":"traceutil/trace.go:171","msg":"trace[14615922] transaction","detail":"{read_only:false; response_revision:1329; number_of_response:1; }","duration":"178.525272ms","start":"2026-07-29T06:35:05.006744Z","end":"2026-07-29T06:35:05.185269Z","steps":["trace[14615922] 'process raft request' (duration: 178.323597ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T06:35:06.007752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"608.522542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-29T06:35:06.007942Z","caller":"traceutil/trace.go:171","msg":"trace[168553808] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1329; }","duration":"608.778708ms","start":"2026-07-29T06:35:05.399136Z","end":"2026-07-29T06:35:06.007915Z","steps":["trace[168553808] 'range keys from in-memory index tree' (duration: 608.331747ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T06:35:06.008006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T06:35:05.399128Z","time spent":"608.862191ms","remote":"127.0.0.1:55044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-29T06:35:06.008088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"608.958973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-29T06:35:06.008172Z","caller":"traceutil/trace.go:171","msg":"trace[969981126] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1329; }","duration":"609.078346ms","start":"2026-07-29T06:35:05.399072Z","end":"2026-07-29T06:35:06.00815Z","steps":["trace[969981126] 'range keys from in-memory index tree' (duration: 608.717747ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T06:35:06.008226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T06:35:05.399064Z","time spent":"609.153338ms","remote":"127.0.0.1:55044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-29T06:35:06.008313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.36332ms","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-07-29T06:35:06.008627Z","caller":"traceutil/trace.go:171","msg":"trace[364032637] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1329; }","duration":"612.543594ms","start":"2026-07-29T06:35:05.395863Z","end":"2026-07-29T06:35:06.008406Z","steps":["trace[364032637] 'range keys from in-memory index tree' (duration: 612.055792ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T06:35:06.008624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.792524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-07-29T06:35:06.00871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T06:35:05.395837Z","time spent":"612.861153ms","remote":"127.0.0.1:55044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-29T06:35:06.008771Z","caller":"traceutil/trace.go:171","msg":"trace[1206812958] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1329; }","duration":"610.164504ms","start":"2026-07-29T06:35:05.398578Z","end":"2026-07-29T06:35:06.008743Z","steps":["trace[1206812958] 'range keys from in-memory index tree' (duration: 609.59817ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T06:35:06.008827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T06:35:05.398567Z","time spent":"610.248836ms","remote":"127.0.0.1:55044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-29T06:35:06.010099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"619.216406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-29T06:35:06.010585Z","caller":"traceutil/trace.go:171","msg":"trace[428612327] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1329; }","duration":"619.37693ms","start":"2026-07-29T06:35:05.390797Z","end":"2026-07-29T06:35:06.010174Z","steps":["trace[428612327] 'range keys from in-memory index tree' (duration: 616.910256ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T06:35:06.010663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T06:35:05.39077Z","time spent":"619.877522ms","remote":"127.0.0.1:55044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-29T06:35:06.012025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.938333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T06:35:06.012085Z","caller":"traceutil/trace.go:171","msg":"trace[1647206477] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1329; }","duration":"451.509001ms","start":"2026-07-29T06:35:05.56056Z","end":"2026-07-29T06:35:06.012069Z","steps":["trace[1647206477] 'range keys from in-memory index tree' (duration: 446.748917ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T06:35:06.012118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T06:35:05.560529Z","time spent":"451.578722ms","remote":"127.0.0.1:54794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-29T06:35:06.052069Z","caller":"traceutil/trace.go:171","msg":"trace[430220229] transaction","detail":"{read_only:false; response_revision:1330; number_of_response:1; }","duration":"290.71803ms","start":"2026-07-29T06:35:05.761329Z","end":"2026-07-29T06:35:06.052047Z","steps":["trace[430220229] 'process raft request' (duration: 290.522976ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T06:35:06.276414Z","caller":"traceutil/trace.go:171","msg":"trace[2126336200] transaction","detail":"{read_only:false; response_revision:1331; number_of_response:1; }","duration":"261.7571ms","start":"2026-07-29T06:35:06.014586Z","end":"2026-07-29T06:35:06.276343Z","steps":["trace[2126336200] 'process raft request' (duration: 259.80803ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T06:35:06.276737Z","caller":"traceutil/trace.go:171","msg":"trace[1899648769] transaction","detail":"{read_only:false; response_revision:1334; number_of_response:1; }","duration":"260.105528ms","start":"2026-07-29T06:35:06.016597Z","end":"2026-07-29T06:35:06.276702Z","steps":["trace[1899648769] 'process raft request' (duration: 260.006086ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T06:35:06.277013Z","caller":"traceutil/trace.go:171","msg":"trace[9613765] transaction","detail":"{read_only:false; response_revision:1335; number_of_response:1; }","duration":"260.094668ms","start":"2026-07-29T06:35:06.016888Z","end":"2026-07-29T06:35:06.276983Z","steps":["trace[9613765] 'process raft request' (duration: 259.76606ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T06:35:06.277038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.196815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-07-29T06:35:06.277108Z","caller":"traceutil/trace.go:171","msg":"trace[465931296] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1335; }","duration":"234.313268ms","start":"2026-07-29T06:35:06.042778Z","end":"2026-07-29T06:35:06.277091Z","steps":["trace[465931296] 'agreement among raft nodes before linearized reading' (duration: 234.039191ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T06:35:06.277116Z","caller":"traceutil/trace.go:171","msg":"trace[364821372] transaction","detail":"{read_only:false; response_revision:1332; number_of_response:1; }","duration":"262.476178ms","start":"2026-07-29T06:35:06.014622Z","end":"2026-07-29T06:35:06.277098Z","steps":["trace[364821372] 'process raft request' (duration: 261.672628ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T06:35:06.276787Z","caller":"traceutil/trace.go:171","msg":"trace[674187138] linearizableReadLoop","detail":"{readStateIndex:1387; appliedIndex:1381; }","duration":"233.955759ms","start":"2026-07-29T06:35:06.042816Z","end":"2026-07-29T06:35:06.276772Z","steps":["trace[674187138] 'read index received' (duration: 9.100292ms)","trace[674187138] 'applied index is now lower than readState.Index' (duration: 224.854117ms)"],"step_count":2} {"level":"info","ts":"2026-07-29T06:35:06.277249Z","caller":"traceutil/trace.go:171","msg":"trace[2104126035] transaction","detail":"{read_only:false; response_revision:1333; number_of_response:1; }","duration":"260.704093ms","start":"2026-07-29T06:35:06.016532Z","end":"2026-07-29T06:35:06.277237Z","steps":["trace[2104126035] 'process raft request' (duration: 259.937174ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T06:35:06.321513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.641686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T06:35:06.321583Z","caller":"traceutil/trace.go:171","msg":"trace[1842743315] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1335; }","duration":"178.77603ms","start":"2026-07-29T06:35:06.142789Z","end":"2026-07-29T06:35:06.321565Z","steps":["trace[1842743315] 'agreement among raft nodes before linearized reading' (duration: 178.644266ms)"],"step_count":1}