{"level":"warn","ts":"2026-05-20T21:10:47.643333Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-20T21:10:47.643996Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.140: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.140:2380","--initial-cluster=controller=https://199.204.45.140:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.140:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.140:2380","--name=controller","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-20T21:10:47.644089Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-20T21:10:47.644106Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.140:2380"]} {"level":"info","ts":"2026-05-20T21:10:47.644128Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-20T21:10:47.64506Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.140:2379"]} {"level":"info","ts":"2026-05-20T21:10:47.645273Z","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":"controller","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.140:2380"],"listen-peer-urls":["https://199.204.45.140:2380"],"advertise-client-urls":["https://199.204.45.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"controller=https://199.204.45.140:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-20T21:10:47.649371Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.691222ms"} {"level":"info","ts":"2026-05-20T21:10:47.656836Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"35b2766da46a76bb","cluster-id":"f5fd3aeb8d9f53dc"} {"level":"info","ts":"2026-05-20T21:10:47.656919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb switched to configuration voters=()"} {"level":"info","ts":"2026-05-20T21:10:47.656938Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became follower at term 0"} {"level":"info","ts":"2026-05-20T21:10:47.656955Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 35b2766da46a76bb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-20T21:10:47.656966Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became follower at term 1"} {"level":"info","ts":"2026-05-20T21:10:47.657024Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb switched to configuration voters=(3869285243146630843)"} {"level":"warn","ts":"2026-05-20T21:10:47.670395Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-20T21:10:47.673502Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-20T21:10:47.674629Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-20T21:10:47.678798Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"35b2766da46a76bb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-20T21:10:47.679067Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"35b2766da46a76bb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-20T21:10:47.679205Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-20T21:10:47.679259Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-20T21:10:47.679275Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-20T21:10:47.679966Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb switched to configuration voters=(3869285243146630843)"} {"level":"info","ts":"2026-05-20T21:10:47.681525Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f5fd3aeb8d9f53dc","local-member-id":"35b2766da46a76bb","added-peer-id":"35b2766da46a76bb","added-peer-peer-urls":["https://199.204.45.140:2380"]} {"level":"info","ts":"2026-05-20T21:10:47.683934Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-20T21:10:47.684265Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.140:2380"} {"level":"info","ts":"2026-05-20T21:10:47.684311Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.140:2380"} {"level":"info","ts":"2026-05-20T21:10:47.684653Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"35b2766da46a76bb","initial-advertise-peer-urls":["https://199.204.45.140:2380"],"listen-peer-urls":["https://199.204.45.140:2380"],"advertise-client-urls":["https://199.204.45.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-20T21:10:47.684709Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-20T21:10:48.657687Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb is starting a new election at term 1"} {"level":"info","ts":"2026-05-20T21:10:48.657752Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became pre-candidate at term 1"} {"level":"info","ts":"2026-05-20T21:10:48.657792Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb received MsgPreVoteResp from 35b2766da46a76bb at term 1"} {"level":"info","ts":"2026-05-20T21:10:48.65781Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became candidate at term 2"} {"level":"info","ts":"2026-05-20T21:10:48.657818Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb received MsgVoteResp from 35b2766da46a76bb at term 2"} {"level":"info","ts":"2026-05-20T21:10:48.657831Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became leader at term 2"} {"level":"info","ts":"2026-05-20T21:10:48.657841Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 35b2766da46a76bb elected leader 35b2766da46a76bb at term 2"} {"level":"info","ts":"2026-05-20T21:10:48.673965Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-20T21:10:48.721554Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"35b2766da46a76bb","local-member-attributes":"{Name:controller ClientURLs:[https://199.204.45.140:2379]}","request-path":"/0/members/35b2766da46a76bb/attributes","cluster-id":"f5fd3aeb8d9f53dc","publish-timeout":"7s"} {"level":"info","ts":"2026-05-20T21:10:48.721565Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-20T21:10:48.721651Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-20T21:10:48.722266Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-20T21:10:48.722368Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-20T21:10:48.725525Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-20T21:10:48.725907Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.140:2379"} {"level":"info","ts":"2026-05-20T21:10:48.743677Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f5fd3aeb8d9f53dc","local-member-id":"35b2766da46a76bb","cluster-version":"3.5"} {"level":"info","ts":"2026-05-20T21:10:48.743844Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-20T21:10:48.743885Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-05-20T21:10:50.327953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.326209ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-20T21:10:50.328354Z","caller":"traceutil/trace.go:171","msg":"trace[1033334592] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"238.739757ms","start":"2026-05-20T21:10:50.089573Z","end":"2026-05-20T21:10:50.328313Z","steps":["trace[1033334592] 'process raft request' (duration: 238.609265ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:10:50.328335Z","caller":"traceutil/trace.go:171","msg":"trace[1732822342] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"239.438514ms","start":"2026-05-20T21:10:50.088845Z","end":"2026-05-20T21:10:50.328284Z","steps":["trace[1732822342] 'process raft request' (duration: 37.200443ms)","trace[1732822342] 'compare' (duration: 201.153986ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:10:50.328519Z","caller":"traceutil/trace.go:171","msg":"trace[1736871246] linearizableReadLoop","detail":"{readStateIndex:16; appliedIndex:7; }","duration":"194.672644ms","start":"2026-05-20T21:10:50.133827Z","end":"2026-05-20T21:10:50.328499Z","steps":["trace[1736871246] 'read index received' (duration: 193.483928ms)","trace[1736871246] 'applied index is now lower than readState.Index' (duration: 1.186666ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:10:50.328609Z","caller":"traceutil/trace.go:171","msg":"trace[844918075] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"237.829746ms","start":"2026-05-20T21:10:50.090735Z","end":"2026-05-20T21:10:50.328564Z","steps":["trace[844918075] 'process raft request' (duration: 237.636331ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:10:50.328635Z","caller":"traceutil/trace.go:171","msg":"trace[1057725222] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"237.840257ms","start":"2026-05-20T21:10:50.090777Z","end":"2026-05-20T21:10:50.328617Z","steps":["trace[1057725222] 'process raft request' (duration: 237.614671ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:10:50.328753Z","caller":"traceutil/trace.go:171","msg":"trace[1900186366] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"237.97505ms","start":"2026-05-20T21:10:50.090769Z","end":"2026-05-20T21:10:50.328745Z","steps":["trace[1900186366] 'process raft request' (duration: 237.650862ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:10:50.328937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.085555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/controller\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-20T21:10:50.328951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.731561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-05-20T21:10:50.329013Z","caller":"traceutil/trace.go:171","msg":"trace[727253088] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:12; }","duration":"180.829723ms","start":"2026-05-20T21:10:50.148173Z","end":"2026-05-20T21:10:50.329003Z","steps":["trace[727253088] 'agreement among raft nodes before linearized reading' (duration: 180.651349ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:10:50.329009Z","caller":"traceutil/trace.go:171","msg":"trace[723010840] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"228.432878ms","start":"2026-05-20T21:10:50.100534Z","end":"2026-05-20T21:10:50.328967Z","steps":["trace[723010840] 'process raft request' (duration: 227.916245ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:10:50.329023Z","caller":"traceutil/trace.go:171","msg":"trace[1473750588] range","detail":"{range_begin:/registry/csinodes/controller; range_end:; response_count:0; response_revision:12; }","duration":"195.227068ms","start":"2026-05-20T21:10:50.133778Z","end":"2026-05-20T21:10:50.329005Z","steps":["trace[1473750588] 'agreement among raft nodes before linearized reading' (duration: 195.001434ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:10:50.329034Z","caller":"traceutil/trace.go:171","msg":"trace[835296354] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"238.725787ms","start":"2026-05-20T21:10:50.090287Z","end":"2026-05-20T21:10:50.329013Z","steps":["trace[835296354] 'process raft request' (duration: 237.961869ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:10:50.329206Z","caller":"traceutil/trace.go:171","msg":"trace[848075109] transaction","detail":"{read_only:false; number_of_response:0; response_revision:7; }","duration":"238.636694ms","start":"2026-05-20T21:10:50.090559Z","end":"2026-05-20T21:10:50.329196Z","steps":["trace[848075109] 'process raft request' (duration: 237.720333ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:10:50.329324Z","caller":"traceutil/trace.go:171","msg":"trace[781430530] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"238.599444ms","start":"2026-05-20T21:10:50.090708Z","end":"2026-05-20T21:10:50.329308Z","steps":["trace[781430530] 'process raft request' (duration: 237.60823ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:10:50.544349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.728955ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-20T21:10:50.544578Z","caller":"traceutil/trace.go:171","msg":"trace[134650033] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"166.202354ms","start":"2026-05-20T21:10:50.378314Z","end":"2026-05-20T21:10:50.544516Z","steps":["trace[134650033] 'process raft request' (duration: 50.213484ms)","trace[134650033] 'compare' (duration: 115.56622ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:10:50.544757Z","caller":"traceutil/trace.go:171","msg":"trace[18429948] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"123.638377ms","start":"2026-05-20T21:10:50.421098Z","end":"2026-05-20T21:10:50.544736Z","steps":["trace[18429948] 'process raft request' (duration: 123.599976ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:10:50.545057Z","caller":"traceutil/trace.go:171","msg":"trace[499212150] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"166.441471ms","start":"2026-05-20T21:10:50.378604Z","end":"2026-05-20T21:10:50.545045Z","steps":["trace[499212150] 'process raft request' (duration: 165.853377ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:10:50.545131Z","caller":"traceutil/trace.go:171","msg":"trace[1596890844] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"124.473337ms","start":"2026-05-20T21:10:50.420623Z","end":"2026-05-20T21:10:50.545096Z","steps":["trace[1596890844] 'process raft request' (duration: 123.963325ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:10:50.545199Z","caller":"traceutil/trace.go:171","msg":"trace[121637513] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"124.370745ms","start":"2026-05-20T21:10:50.420808Z","end":"2026-05-20T21:10:50.545179Z","steps":["trace[121637513] 'process raft request' (duration: 123.815211ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:10:50.545255Z","caller":"traceutil/trace.go:171","msg":"trace[2114546529] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"166.184214ms","start":"2026-05-20T21:10:50.379062Z","end":"2026-05-20T21:10:50.545246Z","steps":["trace[2114546529] 'process raft request' (duration: 165.458147ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:10:50.545307Z","caller":"traceutil/trace.go:171","msg":"trace[686199043] transaction","detail":"{read_only:false; response_revision:30; number_of_response:1; }","duration":"124.451777ms","start":"2026-05-20T21:10:50.420848Z","end":"2026-05-20T21:10:50.545299Z","steps":["trace[686199043] 'process raft request' (duration: 123.811752ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:10:50.545373Z","caller":"traceutil/trace.go:171","msg":"trace[413185559] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"125.161233ms","start":"2026-05-20T21:10:50.420188Z","end":"2026-05-20T21:10:50.54535Z","steps":["trace[413185559] 'process raft request' (duration: 124.369365ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:10:50.948283Z","caller":"traceutil/trace.go:171","msg":"trace[454746317] transaction","detail":"{read_only:false; response_revision:53; number_of_response:1; }","duration":"166.240127ms","start":"2026-05-20T21:10:50.782016Z","end":"2026-05-20T21:10:50.948256Z","steps":["trace[454746317] 'process raft request' (duration: 166.206966ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:10:50.948621Z","caller":"traceutil/trace.go:171","msg":"trace[2078940165] transaction","detail":"{read_only:false; response_revision:52; number_of_response:1; }","duration":"170.451863ms","start":"2026-05-20T21:10:50.778154Z","end":"2026-05-20T21:10:50.948605Z","steps":["trace[2078940165] 'process raft request' (duration: 122.305576ms)","trace[2078940165] 'compare' (duration: 47.653516ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:10:57.347885Z","caller":"traceutil/trace.go:171","msg":"trace[853159424] linearizableReadLoop","detail":"{readStateIndex:356; appliedIndex:355; }","duration":"146.407092ms","start":"2026-05-20T21:10:57.201453Z","end":"2026-05-20T21:10:57.347861Z","steps":["trace[853159424] 'read index received' (duration: 146.168017ms)","trace[853159424] 'applied index is now lower than readState.Index' (duration: 237.785µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:10:57.347939Z","caller":"traceutil/trace.go:171","msg":"trace[608303693] transaction","detail":"{read_only:false; response_revision:343; number_of_response:1; }","duration":"179.968248ms","start":"2026-05-20T21:10:57.167943Z","end":"2026-05-20T21:10:57.347912Z","steps":["trace[608303693] 'process raft request' (duration: 179.759584ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:10:57.348061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.595485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:10:57.348101Z","caller":"traceutil/trace.go:171","msg":"trace[1902569133] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:0; response_revision:343; }","duration":"146.691917ms","start":"2026-05-20T21:10:57.201397Z","end":"2026-05-20T21:10:57.348089Z","steps":["trace[1902569133] 'agreement among raft nodes before linearized reading' (duration: 146.570815ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:10:58.36636Z","caller":"traceutil/trace.go:171","msg":"trace[902883363] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"110.836403ms","start":"2026-05-20T21:10:58.255498Z","end":"2026-05-20T21:10:58.366334Z","steps":["trace[902883363] 'process raft request' (duration: 110.647178ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:10:58.366755Z","caller":"traceutil/trace.go:171","msg":"trace[1868387431] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"111.161059ms","start":"2026-05-20T21:10:58.25555Z","end":"2026-05-20T21:10:58.366711Z","steps":["trace[1868387431] 'process raft request' (duration: 110.741441ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:10:58.367147Z","caller":"traceutil/trace.go:171","msg":"trace[1112175741] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"106.703412ms","start":"2026-05-20T21:10:58.260432Z","end":"2026-05-20T21:10:58.367136Z","steps":["trace[1112175741] 'process raft request' (duration: 106.10549ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:10:58.493084Z","caller":"traceutil/trace.go:171","msg":"trace[2097107633] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"116.23971ms","start":"2026-05-20T21:10:58.376816Z","end":"2026-05-20T21:10:58.493056Z","steps":["trace[2097107633] 'process raft request' (duration: 115.966194ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:10:58.493584Z","caller":"traceutil/trace.go:171","msg":"trace[66081631] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"115.032035ms","start":"2026-05-20T21:10:58.378523Z","end":"2026-05-20T21:10:58.493555Z","steps":["trace[66081631] 'process raft request' (duration: 114.475535ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:10:58.493654Z","caller":"traceutil/trace.go:171","msg":"trace[864012591] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"113.842331ms","start":"2026-05-20T21:10:58.379787Z","end":"2026-05-20T21:10:58.49363Z","steps":["trace[864012591] 'process raft request' (duration: 113.693909ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:10:58.495288Z","caller":"traceutil/trace.go:171","msg":"trace[120449864] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"115.339442ms","start":"2026-05-20T21:10:58.379923Z","end":"2026-05-20T21:10:58.495262Z","steps":["trace[120449864] 'process raft request' (duration: 113.639308ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:10:58.495693Z","caller":"traceutil/trace.go:171","msg":"trace[1735809046] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"114.73022ms","start":"2026-05-20T21:10:58.380933Z","end":"2026-05-20T21:10:58.495663Z","steps":["trace[1735809046] 'process raft request' (duration: 113.71441ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:10:58.74464Z","caller":"traceutil/trace.go:171","msg":"trace[1426344959] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"114.289941ms","start":"2026-05-20T21:10:58.630285Z","end":"2026-05-20T21:10:58.744575Z","steps":["trace[1426344959] 'process raft request' (duration: 106.372845ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:10:58.77758Z","caller":"traceutil/trace.go:171","msg":"trace[643332253] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"108.146499ms","start":"2026-05-20T21:10:58.669406Z","end":"2026-05-20T21:10:58.777552Z","steps":["trace[643332253] 'process raft request' (duration: 108.059428ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:10:58.777651Z","caller":"traceutil/trace.go:171","msg":"trace[1414897628] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"110.487456ms","start":"2026-05-20T21:10:58.667129Z","end":"2026-05-20T21:10:58.777616Z","steps":["trace[1414897628] 'process raft request' (duration: 110.20952ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:10:59.162561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.242918ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-20T21:10:59.162682Z","caller":"traceutil/trace.go:171","msg":"trace[1230128468] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"190.362066ms","start":"2026-05-20T21:10:58.9723Z","end":"2026-05-20T21:10:59.162662Z","steps":["trace[1230128468] 'process raft request' (duration: 16.931325ms)","trace[1230128468] 'compare' (duration: 173.086225ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:10:59.520022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.384139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-20T21:10:59.52011Z","caller":"traceutil/trace.go:171","msg":"trace[115790581] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:397; }","duration":"168.271588ms","start":"2026-05-20T21:10:59.351819Z","end":"2026-05-20T21:10:59.52009Z","steps":["trace[115790581] 'range keys from in-memory index tree' (duration: 167.189525ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:10:59.763379Z","caller":"traceutil/trace.go:171","msg":"trace[634874924] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"238.242675ms","start":"2026-05-20T21:10:59.52511Z","end":"2026-05-20T21:10:59.763353Z","steps":["trace[634874924] 'process raft request' (duration: 238.050871ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:00.21551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.780128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/controller\" ","response":"range_response_count:1 size:4207"} {"level":"info","ts":"2026-05-20T21:11:00.2156Z","caller":"traceutil/trace.go:171","msg":"trace[807478414] range","detail":"{range_begin:/registry/minions/controller; range_end:; response_count:1; response_revision:398; }","duration":"325.922471ms","start":"2026-05-20T21:10:59.889655Z","end":"2026-05-20T21:11:00.215577Z","steps":["trace[807478414] 'range keys from in-memory index tree' (duration: 325.671595ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:00.215643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:10:59.889635Z","time spent":"325.999463ms","remote":"127.0.0.1:41560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":1,"response size":4230,"request content":"key:\"/registry/minions/controller\" "} {"level":"info","ts":"2026-05-20T21:11:00.487787Z","caller":"traceutil/trace.go:171","msg":"trace[1047745862] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"262.899731ms","start":"2026-05-20T21:11:00.224858Z","end":"2026-05-20T21:11:00.487758Z","steps":["trace[1047745862] 'process raft request' (duration: 262.734338ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:11:07.543294Z","caller":"traceutil/trace.go:171","msg":"trace[1741806902] transaction","detail":"{read_only:false; response_revision:440; number_of_response:1; }","duration":"133.852225ms","start":"2026-05-20T21:11:07.409416Z","end":"2026-05-20T21:11:07.543269Z","steps":["trace[1741806902] 'process raft request' (duration: 133.795844ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:07.543636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.562277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-5dd5756b68-lpmh5\" ","response":"range_response_count:1 size:3994"} {"level":"info","ts":"2026-05-20T21:11:07.543719Z","caller":"traceutil/trace.go:171","msg":"trace[1186739987] range","detail":"{range_begin:/registry/pods/kube-system/coredns-5dd5756b68-lpmh5; range_end:; response_count:1; response_revision:440; }","duration":"134.73331ms","start":"2026-05-20T21:11:07.408967Z","end":"2026-05-20T21:11:07.543701Z","steps":["trace[1186739987] 'agreement among raft nodes before linearized reading' (duration: 134.556867ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:11:07.543343Z","caller":"traceutil/trace.go:171","msg":"trace[1750995253] linearizableReadLoop","detail":"{readStateIndex:455; appliedIndex:454; }","duration":"134.262463ms","start":"2026-05-20T21:11:07.409048Z","end":"2026-05-20T21:11:07.54331Z","steps":["trace[1750995253] 'read index received' (duration: 50.118575ms)","trace[1750995253] 'applied index is now lower than readState.Index' (duration: 84.138867ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:11:07.544228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.395244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4173"} {"level":"info","ts":"2026-05-20T21:11:07.544266Z","caller":"traceutil/trace.go:171","msg":"trace[628433711] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:440; }","duration":"131.482386ms","start":"2026-05-20T21:11:07.41277Z","end":"2026-05-20T21:11:07.544252Z","steps":["trace[628433711] 'agreement among raft nodes before linearized reading' (duration: 131.378505ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:11:07.543329Z","caller":"traceutil/trace.go:171","msg":"trace[1657379925] transaction","detail":"{read_only:false; response_revision:439; number_of_response:1; }","duration":"167.498232ms","start":"2026-05-20T21:11:07.375788Z","end":"2026-05-20T21:11:07.543286Z","steps":["trace[1657379925] 'process raft request' (duration: 83.164271ms)","trace[1657379925] 'compare' (duration: 84.119288ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:11:07.821124Z","caller":"traceutil/trace.go:171","msg":"trace[1736477355] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"200.468089ms","start":"2026-05-20T21:11:07.620614Z","end":"2026-05-20T21:11:07.821082Z","steps":["trace[1736477355] 'process raft request' (duration: 120.079284ms)","trace[1736477355] 'compare' (duration: 75.443942ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:11:07.821095Z","caller":"traceutil/trace.go:171","msg":"trace[1098830452] transaction","detail":"{read_only:false; response_revision:448; number_of_response:1; }","duration":"198.597636ms","start":"2026-05-20T21:11:07.622271Z","end":"2026-05-20T21:11:07.820869Z","steps":["trace[1098830452] 'process raft request' (duration: 198.154889ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:11:07.821223Z","caller":"traceutil/trace.go:171","msg":"trace[577361626] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"197.424577ms","start":"2026-05-20T21:11:07.623774Z","end":"2026-05-20T21:11:07.821199Z","steps":["trace[577361626] 'process raft request' (duration: 196.712115ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:11:07.82112Z","caller":"traceutil/trace.go:171","msg":"trace[1066417868] transaction","detail":"{read_only:false; response_revision:446; number_of_response:1; }","duration":"200.0151ms","start":"2026-05-20T21:11:07.621075Z","end":"2026-05-20T21:11:07.82109Z","steps":["trace[1066417868] 'process raft request' (duration: 199.155595ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:11:07.821311Z","caller":"traceutil/trace.go:171","msg":"trace[111927291] transaction","detail":"{read_only:false; response_revision:447; number_of_response:1; }","duration":"199.603684ms","start":"2026-05-20T21:11:07.621647Z","end":"2026-05-20T21:11:07.82125Z","steps":["trace[111927291] 'process raft request' (duration: 198.691539ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:11:21.661677Z","caller":"traceutil/trace.go:171","msg":"trace[943067503] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"249.284038ms","start":"2026-05-20T21:11:21.412371Z","end":"2026-05-20T21:11:21.661655Z","steps":["trace[943067503] 'process raft request' (duration: 249.148226ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:11:21.661745Z","caller":"traceutil/trace.go:171","msg":"trace[344428234] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"250.257081ms","start":"2026-05-20T21:11:21.411441Z","end":"2026-05-20T21:11:21.661698Z","steps":["trace[344428234] 'process raft request' (duration: 210.861572ms)","trace[344428234] 'compare' (duration: 39.067824ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:11:21.949227Z","caller":"traceutil/trace.go:171","msg":"trace[410919049] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"520.90668ms","start":"2026-05-20T21:11:21.428192Z","end":"2026-05-20T21:11:21.949099Z","steps":["trace[410919049] 'process raft request' (duration: 520.573006ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:11:21.951392Z","caller":"traceutil/trace.go:171","msg":"trace[2066062653] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"521.715141ms","start":"2026-05-20T21:11:21.42949Z","end":"2026-05-20T21:11:21.951205Z","steps":["trace[2066062653] 'process raft request' (duration: 519.44218ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:21.951659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:11:21.429463Z","time spent":"522.131938ms","remote":"127.0.0.1:41940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T21:11:21.95244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:11:21.428172Z","time spent":"523.418365ms","remote":"127.0.0.1:41436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9125,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T21:11:21.953814Z","caller":"traceutil/trace.go:171","msg":"trace[1439891339] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"521.754982ms","start":"2026-05-20T21:11:21.432015Z","end":"2026-05-20T21:11:21.953769Z","steps":["trace[1439891339] 'process raft request' (duration: 517.066608ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:11:21.955407Z","caller":"traceutil/trace.go:171","msg":"trace[38435867] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"510.789272ms","start":"2026-05-20T21:11:21.444597Z","end":"2026-05-20T21:11:21.955387Z","steps":["trace[38435867] 'process raft request' (duration: 505.316527ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:21.955709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:11:21.444583Z","time spent":"510.864134ms","remote":"127.0.0.1:41436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T21:11:21.955826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:11:21.432003Z","time spent":"523.332135ms","remote":"127.0.0.1:41436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T21:11:21.957065Z","caller":"traceutil/trace.go:171","msg":"trace[1919140157] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"504.353113ms","start":"2026-05-20T21:11:21.452676Z","end":"2026-05-20T21:11:21.957029Z","steps":["trace[1919140157] 'process raft request' (duration: 504.158451ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:21.957138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:11:21.45266Z","time spent":"504.433235ms","remote":"127.0.0.1:41436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T21:11:21.959538Z","caller":"traceutil/trace.go:171","msg":"trace[421238927] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"478.42217ms","start":"2026-05-20T21:11:21.478841Z","end":"2026-05-20T21:11:21.957263Z","steps":["trace[421238927] 'process raft request' (duration: 478.233187ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:21.959674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:11:21.478816Z","time spent":"480.803132ms","remote":"127.0.0.1:41436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T21:11:21.960731Z","caller":"traceutil/trace.go:171","msg":"trace[276152298] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"279.766355ms","start":"2026-05-20T21:11:21.68095Z","end":"2026-05-20T21:11:21.960716Z","steps":["trace[276152298] 'process raft request' (duration: 279.712464ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:11:21.960898Z","caller":"traceutil/trace.go:171","msg":"trace[614380451] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"288.909389ms","start":"2026-05-20T21:11:21.671964Z","end":"2026-05-20T21:11:21.960874Z","steps":["trace[614380451] 'process raft request' (duration: 288.510264ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:11:21.960926Z","caller":"traceutil/trace.go:171","msg":"trace[211715651] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"285.895988ms","start":"2026-05-20T21:11:21.67502Z","end":"2026-05-20T21:11:21.960916Z","steps":["trace[211715651] 'process raft request' (duration: 285.510662ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:11:21.960932Z","caller":"traceutil/trace.go:171","msg":"trace[1806991303] linearizableReadLoop","detail":"{readStateIndex:562; appliedIndex:554; }","duration":"444.868602ms","start":"2026-05-20T21:11:21.516013Z","end":"2026-05-20T21:11:21.960882Z","steps":["trace[1806991303] 'read index received' (duration: 106.382424ms)","trace[1806991303] 'applied index is now lower than readState.Index' (duration: 338.484208ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:11:21.961151Z","caller":"traceutil/trace.go:171","msg":"trace[2011069542] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"370.568396ms","start":"2026-05-20T21:11:21.590557Z","end":"2026-05-20T21:11:21.961125Z","steps":["trace[2011069542] 'process raft request' (duration: 369.763575ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:21.961199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.019522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.140\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-20T21:11:21.961236Z","caller":"traceutil/trace.go:171","msg":"trace[1743949572] range","detail":"{range_begin:/registry/masterleases/199.204.45.140; range_end:; response_count:1; response_revision:547; }","duration":"167.100254ms","start":"2026-05-20T21:11:21.794126Z","end":"2026-05-20T21:11:21.961227Z","steps":["trace[1743949572] 'agreement among raft nodes before linearized reading' (duration: 167.016143ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:21.961305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.288067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:11:21.96136Z","caller":"traceutil/trace.go:171","msg":"trace[357362042] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:547; }","duration":"445.381809ms","start":"2026-05-20T21:11:21.515958Z","end":"2026-05-20T21:11:21.96134Z","steps":["trace[357362042] 'agreement among raft nodes before linearized reading' (duration: 445.310087ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:21.961427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:11:21.515943Z","time spent":"445.47027ms","remote":"127.0.0.1:38688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-20T21:11:21.961547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:11:21.59053Z","time spent":"370.638706ms","remote":"127.0.0.1:41436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T21:11:28.801036Z","caller":"traceutil/trace.go:171","msg":"trace[461766515] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:655; }","duration":"407.728891ms","start":"2026-05-20T21:11:28.393287Z","end":"2026-05-20T21:11:28.801016Z","steps":["trace[461766515] 'read index received' (duration: 406.499256ms)","trace[461766515] 'applied index is now lower than readState.Index' (duration: 1.228735ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:11:28.801914Z","caller":"traceutil/trace.go:171","msg":"trace[2082613451] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"421.504975ms","start":"2026-05-20T21:11:28.380396Z","end":"2026-05-20T21:11:28.801901Z","steps":["trace[2082613451] 'process raft request' (duration: 420.096637ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:28.802048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:11:28.380377Z","time spent":"421.576717ms","remote":"127.0.0.1:41482","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T21:11:28.802482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.169849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T21:11:28.802525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.17719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:11:28.802565Z","caller":"traceutil/trace.go:171","msg":"trace[814392134] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:634; }","duration":"409.291621ms","start":"2026-05-20T21:11:28.393257Z","end":"2026-05-20T21:11:28.802548Z","steps":["trace[814392134] 'agreement among raft nodes before linearized reading' (duration: 409.078719ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:11:28.802579Z","caller":"traceutil/trace.go:171","msg":"trace[1764676149] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:634; }","duration":"409.246451ms","start":"2026-05-20T21:11:28.393318Z","end":"2026-05-20T21:11:28.802565Z","steps":["trace[1764676149] 'agreement among raft nodes before linearized reading' (duration: 409.162739ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:28.802609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:11:28.393244Z","time spent":"409.354423ms","remote":"127.0.0.1:43724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"warn","ts":"2026-05-20T21:11:28.802621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:11:28.393313Z","time spent":"409.295912ms","remote":"127.0.0.1:43724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-05-20T21:11:28.803104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.067769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T21:11:28.803132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.278415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:11:28.803153Z","caller":"traceutil/trace.go:171","msg":"trace[1476473352] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:634; }","duration":"106.13111ms","start":"2026-05-20T21:11:28.697009Z","end":"2026-05-20T21:11:28.80314Z","steps":["trace[1476473352] 'agreement among raft nodes before linearized reading' (duration: 106.066909ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:11:28.803173Z","caller":"traceutil/trace.go:171","msg":"trace[294519355] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:634; }","duration":"119.332016ms","start":"2026-05-20T21:11:28.68383Z","end":"2026-05-20T21:11:28.803162Z","steps":["trace[294519355] 'agreement among raft nodes before linearized reading' (duration: 119.274145ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:28.803345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.005521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:11:28.803383Z","caller":"traceutil/trace.go:171","msg":"trace[2026870883] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:634; }","duration":"410.065531ms","start":"2026-05-20T21:11:28.393309Z","end":"2026-05-20T21:11:28.803374Z","steps":["trace[2026870883] 'agreement among raft nodes before linearized reading' (duration: 410.013171ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:28.803415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:11:28.393296Z","time spent":"410.110962ms","remote":"127.0.0.1:43724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"warn","ts":"2026-05-20T21:11:28.803445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.585194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:11:28.803466Z","caller":"traceutil/trace.go:171","msg":"trace[1055839644] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:634; }","duration":"105.621654ms","start":"2026-05-20T21:11:28.697839Z","end":"2026-05-20T21:11:28.803461Z","steps":["trace[1055839644] 'agreement among raft nodes before linearized reading' (duration: 105.589844ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:28.803439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.937639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:11:28.803526Z","caller":"traceutil/trace.go:171","msg":"trace[189855372] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:634; }","duration":"244.06231ms","start":"2026-05-20T21:11:28.559445Z","end":"2026-05-20T21:11:28.803507Z","steps":["trace[189855372] 'agreement among raft nodes before linearized reading' (duration: 243.889418ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:28.803928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.804118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:11:28.803989Z","caller":"traceutil/trace.go:171","msg":"trace[2029884747] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:634; }","duration":"106.87466ms","start":"2026-05-20T21:11:28.697086Z","end":"2026-05-20T21:11:28.80396Z","steps":["trace[2029884747] 'agreement among raft nodes before linearized reading' (duration: 106.802138ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:28.804031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.521704ms","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":"warn","ts":"2026-05-20T21:11:28.804052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.391227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-kx5kb\" ","response":"range_response_count:1 size:16660"} {"level":"info","ts":"2026-05-20T21:11:28.804081Z","caller":"traceutil/trace.go:171","msg":"trace[938149276] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:634; }","duration":"121.594685ms","start":"2026-05-20T21:11:28.682476Z","end":"2026-05-20T21:11:28.804071Z","steps":["trace[938149276] 'agreement among raft nodes before linearized reading' (duration: 121.520574ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:11:28.804095Z","caller":"traceutil/trace.go:171","msg":"trace[1520104175] range","detail":"{range_begin:/registry/pods/kube-system/cilium-kx5kb; range_end:; response_count:1; response_revision:634; }","duration":"127.456178ms","start":"2026-05-20T21:11:28.676631Z","end":"2026-05-20T21:11:28.804088Z","steps":["trace[1520104175] 'agreement among raft nodes before linearized reading' (duration: 127.380937ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:28.804096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.583504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:11:28.804119Z","caller":"traceutil/trace.go:171","msg":"trace[978182592] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:634; }","duration":"121.608364ms","start":"2026-05-20T21:11:28.682505Z","end":"2026-05-20T21:11:28.804113Z","steps":["trace[978182592] 'agreement among raft nodes before linearized reading' (duration: 121.573004ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:28.804052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.563907ms","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-05-20T21:11:28.80425Z","caller":"traceutil/trace.go:171","msg":"trace[2132383193] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:634; }","duration":"244.665538ms","start":"2026-05-20T21:11:28.559473Z","end":"2026-05-20T21:11:28.804138Z","steps":["trace[2132383193] 'agreement among raft nodes before linearized reading' (duration: 244.556547ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:29.428811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:11:29.082485Z","time spent":"346.315823ms","remote":"127.0.0.1:55938","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-05-20T21:11:29.429042Z","caller":"traceutil/trace.go:171","msg":"trace[779450089] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:658; }","duration":"338.605086ms","start":"2026-05-20T21:11:29.090402Z","end":"2026-05-20T21:11:29.429007Z","steps":["trace[779450089] 'read index received' (duration: 286.733123ms)","trace[779450089] 'applied index is now lower than readState.Index' (duration: 51.870673ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:11:29.429184Z","caller":"traceutil/trace.go:171","msg":"trace[1291270214] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"530.298948ms","start":"2026-05-20T21:11:28.898853Z","end":"2026-05-20T21:11:29.429152Z","steps":["trace[1291270214] 'process raft request' (duration: 478.334373ms)","trace[1291270214] 'compare' (duration: 51.56716ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:11:29.429311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:11:28.898842Z","time spent":"530.406329ms","remote":"127.0.0.1:41576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T21:11:29.429371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.04485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-20T21:11:29.429432Z","caller":"traceutil/trace.go:171","msg":"trace[652395501] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:637; }","duration":"338.144292ms","start":"2026-05-20T21:11:29.091271Z","end":"2026-05-20T21:11:29.429416Z","steps":["trace[652395501] 'agreement among raft nodes before linearized reading' (duration: 337.96105ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:29.429471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:11:29.09125Z","time spent":"338.212912ms","remote":"127.0.0.1:41656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-20T21:11:29.430238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.309026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-20T21:11:29.43025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.827382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-20T21:11:29.430315Z","caller":"traceutil/trace.go:171","msg":"trace[1565470880] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:637; }","duration":"339.434617ms","start":"2026-05-20T21:11:29.090859Z","end":"2026-05-20T21:11:29.430294Z","steps":["trace[1565470880] 'agreement among raft nodes before linearized reading' (duration: 338.307774ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:11:29.430343Z","caller":"traceutil/trace.go:171","msg":"trace[1990950972] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:637; }","duration":"339.959294ms","start":"2026-05-20T21:11:29.090363Z","end":"2026-05-20T21:11:29.430322Z","steps":["trace[1990950972] 'agreement among raft nodes before linearized reading' (duration: 338.78907ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:29.430366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:11:29.090847Z","time spent":"339.505718ms","remote":"127.0.0.1:41656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-20T21:11:29.430401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:11:29.090344Z","time spent":"340.048214ms","remote":"127.0.0.1:41656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-20T21:11:41.899412Z","caller":"traceutil/trace.go:171","msg":"trace[944505058] linearizableReadLoop","detail":"{readStateIndex:805; appliedIndex:804; }","duration":"104.186906ms","start":"2026-05-20T21:11:41.795206Z","end":"2026-05-20T21:11:41.899393Z","steps":["trace[944505058] 'read index received' (duration: 104.037775ms)","trace[944505058] 'applied index is now lower than readState.Index' (duration: 148.001µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:11:41.899499Z","caller":"traceutil/trace.go:171","msg":"trace[643839337] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"130.291363ms","start":"2026-05-20T21:11:41.769182Z","end":"2026-05-20T21:11:41.899473Z","steps":["trace[643839337] 'process raft request' (duration: 130.01866ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:41.899719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.501069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.140\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-20T21:11:41.899773Z","caller":"traceutil/trace.go:171","msg":"trace[657717285] range","detail":"{range_begin:/registry/masterleases/199.204.45.140; range_end:; response_count:1; response_revision:779; }","duration":"104.575271ms","start":"2026-05-20T21:11:41.795189Z","end":"2026-05-20T21:11:41.899764Z","steps":["trace[657717285] 'agreement among raft nodes before linearized reading' (duration: 104.353837ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:11:42.109147Z","caller":"traceutil/trace.go:171","msg":"trace[1725466169] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"123.765431ms","start":"2026-05-20T21:11:41.985356Z","end":"2026-05-20T21:11:42.109122Z","steps":["trace[1725466169] 'process raft request' (duration: 123.538928ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:11:42.311402Z","caller":"traceutil/trace.go:171","msg":"trace[1304566965] transaction","detail":"{read_only:false; response_revision:788; number_of_response:1; }","duration":"117.792054ms","start":"2026-05-20T21:11:42.193585Z","end":"2026-05-20T21:11:42.311377Z","steps":["trace[1304566965] 'process raft request' (duration: 117.628523ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:46.015143Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8555605945874280333,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-20T21:11:46.024873Z","caller":"traceutil/trace.go:171","msg":"trace[2078054445] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"537.825381ms","start":"2026-05-20T21:11:45.487024Z","end":"2026-05-20T21:11:46.02485Z","steps":["trace[2078054445] 'process raft request' (duration: 537.686749ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:46.025077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:11:45.486955Z","time spent":"537.988703ms","remote":"127.0.0.1:41656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":479,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T21:11:46.046947Z","caller":"traceutil/trace.go:171","msg":"trace[2103234978] linearizableReadLoop","detail":"{readStateIndex:832; appliedIndex:830; }","duration":"532.36993ms","start":"2026-05-20T21:11:45.514553Z","end":"2026-05-20T21:11:46.046923Z","steps":["trace[2103234978] 'read index received' (duration: 510.167346ms)","trace[2103234978] 'applied index is now lower than readState.Index' (duration: 22.201424ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:11:46.047101Z","caller":"traceutil/trace.go:171","msg":"trace[651017888] transaction","detail":"{read_only:false; response_revision:805; number_of_response:1; }","duration":"251.26193ms","start":"2026-05-20T21:11:45.795828Z","end":"2026-05-20T21:11:46.04709Z","steps":["trace[651017888] 'process raft request' (duration: 250.923906ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:46.047297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.645422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-20T21:11:46.047346Z","caller":"traceutil/trace.go:171","msg":"trace[972205716] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:805; }","duration":"484.717333ms","start":"2026-05-20T21:11:45.562616Z","end":"2026-05-20T21:11:46.047334Z","steps":["trace[972205716] 'agreement among raft nodes before linearized reading' (duration: 484.578362ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:46.047381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:11:45.562605Z","time spent":"484.768043ms","remote":"127.0.0.1:41656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-20T21:11:46.047627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.59254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-20T21:11:46.047659Z","caller":"traceutil/trace.go:171","msg":"trace[2018016949] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:805; }","duration":"482.627421ms","start":"2026-05-20T21:11:45.565022Z","end":"2026-05-20T21:11:46.04765Z","steps":["trace[2018016949] 'agreement among raft nodes before linearized reading' (duration: 482.53432ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:46.047664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.342087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"warn","ts":"2026-05-20T21:11:46.047688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:11:45.565012Z","time spent":"482.669251ms","remote":"127.0.0.1:41656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-20T21:11:46.047706Z","caller":"traceutil/trace.go:171","msg":"trace[162825778] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:805; }","duration":"480.437237ms","start":"2026-05-20T21:11:45.567256Z","end":"2026-05-20T21:11:46.047694Z","steps":["trace[162825778] 'agreement among raft nodes before linearized reading' (duration: 480.287096ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:46.047742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:11:45.567232Z","time spent":"480.50041ms","remote":"127.0.0.1:41656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-20T21:11:46.047856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.304931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:11:46.047887Z","caller":"traceutil/trace.go:171","msg":"trace[2045581415] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:805; }","duration":"533.358411ms","start":"2026-05-20T21:11:45.51452Z","end":"2026-05-20T21:11:46.047878Z","steps":["trace[2045581415] 'agreement among raft nodes before linearized reading' (duration: 533.314841ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:46.047913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:11:45.514453Z","time spent":"533.454862ms","remote":"127.0.0.1:38688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-20T21:11:53.947369Z","caller":"traceutil/trace.go:171","msg":"trace[1892890141] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"108.976594ms","start":"2026-05-20T21:11:53.838362Z","end":"2026-05-20T21:11:53.947339Z","steps":["trace[1892890141] 'process raft request' (duration: 101.170576ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:11:53.947409Z","caller":"traceutil/trace.go:171","msg":"trace[108524749] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"106.118175ms","start":"2026-05-20T21:11:53.841269Z","end":"2026-05-20T21:11:53.947387Z","steps":["trace[108524749] 'process raft request' (duration: 105.951153ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:11:53.947466Z","caller":"traceutil/trace.go:171","msg":"trace[179382253] transaction","detail":"{read_only:false; response_revision:909; number_of_response:1; }","duration":"106.161015ms","start":"2026-05-20T21:11:53.841272Z","end":"2026-05-20T21:11:53.947433Z","steps":["trace[179382253] 'process raft request' (duration: 106.027234ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:11:53.947675Z","caller":"traceutil/trace.go:171","msg":"trace[1362874587] linearizableReadLoop","detail":"{readStateIndex:939; appliedIndex:935; }","duration":"106.293398ms","start":"2026-05-20T21:11:53.841349Z","end":"2026-05-20T21:11:53.947643Z","steps":["trace[1362874587] 'read index received' (duration: 21.730918ms)","trace[1362874587] 'applied index is now lower than readState.Index' (duration: 84.56114ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:11:53.947736Z","caller":"traceutil/trace.go:171","msg":"trace[193174303] transaction","detail":"{read_only:false; response_revision:910; number_of_response:1; }","duration":"106.299338ms","start":"2026-05-20T21:11:53.841427Z","end":"2026-05-20T21:11:53.947727Z","steps":["trace[193174303] 'process raft request' (duration: 105.940584ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:53.947873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.49375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/secretgen-controller-cluster-role\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:11:53.94792Z","caller":"traceutil/trace.go:171","msg":"trace[325721392] range","detail":"{range_begin:/registry/clusterroles/secretgen-controller-cluster-role; range_end:; response_count:0; response_revision:910; }","duration":"106.60265ms","start":"2026-05-20T21:11:53.841304Z","end":"2026-05-20T21:11:53.947907Z","steps":["trace[325721392] 'agreement among raft nodes before linearized reading' (duration: 106.465569ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:11:54.110728Z","caller":"traceutil/trace.go:171","msg":"trace[1073380189] linearizableReadLoop","detail":"{readStateIndex:941; appliedIndex:940; }","duration":"156.414174ms","start":"2026-05-20T21:11:53.954291Z","end":"2026-05-20T21:11:54.110705Z","steps":["trace[1073380189] 'read index received' (duration: 148.576585ms)","trace[1073380189] 'applied index is now lower than readState.Index' (duration: 7.836669ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:11:54.110835Z","caller":"traceutil/trace.go:171","msg":"trace[1937283470] transaction","detail":"{read_only:false; response_revision:911; number_of_response:1; }","duration":"157.050339ms","start":"2026-05-20T21:11:53.953776Z","end":"2026-05-20T21:11:54.110826Z","steps":["trace[1937283470] 'process raft request' (duration: 149.11184ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:54.111149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.839518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/secretgen-controller/secretgen-controller-ffb97c6dc-djm7r\" ","response":"range_response_count:1 size:2071"} {"level":"info","ts":"2026-05-20T21:11:54.11121Z","caller":"traceutil/trace.go:171","msg":"trace[178675274] range","detail":"{range_begin:/registry/pods/secretgen-controller/secretgen-controller-ffb97c6dc-djm7r; range_end:; response_count:1; response_revision:911; }","duration":"156.934758ms","start":"2026-05-20T21:11:53.954259Z","end":"2026-05-20T21:11:54.111194Z","steps":["trace[178675274] 'agreement among raft nodes before linearized reading' (duration: 156.700426ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:54.14033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.917138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/secretgen-controller/secretgen-controller-ffb97c6dc\" ","response":"range_response_count:1 size:2799"} {"level":"info","ts":"2026-05-20T21:11:54.140392Z","caller":"traceutil/trace.go:171","msg":"trace[1542016692] range","detail":"{range_begin:/registry/replicasets/secretgen-controller/secretgen-controller-ffb97c6dc; range_end:; response_count:1; response_revision:912; }","duration":"186.021349ms","start":"2026-05-20T21:11:53.954355Z","end":"2026-05-20T21:11:54.140376Z","steps":["trace[1542016692] 'agreement among raft nodes before linearized reading' (duration: 185.871038ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:11:54.140938Z","caller":"traceutil/trace.go:171","msg":"trace[463711653] transaction","detail":"{read_only:false; response_revision:912; number_of_response:1; }","duration":"186.10882ms","start":"2026-05-20T21:11:53.954805Z","end":"2026-05-20T21:11:54.140914Z","steps":["trace[463711653] 'process raft request' (duration: 185.343452ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:54.141142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.541912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:11:54.141204Z","caller":"traceutil/trace.go:171","msg":"trace[552361912] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:912; }","duration":"150.656403ms","start":"2026-05-20T21:11:53.990533Z","end":"2026-05-20T21:11:54.141189Z","steps":["trace[552361912] 'agreement among raft nodes before linearized reading' (duration: 150.562392ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:11:54.141511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.510044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/secretgen-controller/secretgen-controller\" ","response":"range_response_count:1 size:3017"} {"level":"info","ts":"2026-05-20T21:11:54.141557Z","caller":"traceutil/trace.go:171","msg":"trace[390938252] range","detail":"{range_begin:/registry/deployments/secretgen-controller/secretgen-controller; range_end:; response_count:1; response_revision:912; }","duration":"185.583404ms","start":"2026-05-20T21:11:53.955959Z","end":"2026-05-20T21:11:54.141542Z","steps":["trace[390938252] 'agreement among raft nodes before linearized reading' (duration: 185.453203ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:11:55.117048Z","caller":"traceutil/trace.go:171","msg":"trace[1414171075] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"173.866708ms","start":"2026-05-20T21:11:54.943145Z","end":"2026-05-20T21:11:55.117012Z","steps":["trace[1414171075] 'process raft request' (duration: 173.349973ms)"],"step_count":1}