{"level":"warn","ts":"2026-05-19T15:39:45.069836Z","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-19T15:39:45.069953Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.174:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.174:2380","--initial-cluster=instance=https://199.19.213.174:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.174:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.174:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-19T15:39:45.070042Z","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-19T15:39:45.070058Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.174:2380"]} {"level":"info","ts":"2026-05-19T15:39:45.070086Z","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-19T15:39:45.070852Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.174:2379"]} {"level":"info","ts":"2026-05-19T15:39:45.070957Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.174:2380"],"listen-peer-urls":["https://199.19.213.174:2380"],"advertise-client-urls":["https://199.19.213.174:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.174:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.174: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-19T15:39:45.076419Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.181202ms"} {"level":"info","ts":"2026-05-19T15:39:45.08285Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b3617fc4a93ad58b","cluster-id":"2f224b65169306de"} {"level":"info","ts":"2026-05-19T15:39:45.082937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3617fc4a93ad58b switched to configuration voters=()"} {"level":"info","ts":"2026-05-19T15:39:45.082959Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3617fc4a93ad58b became follower at term 0"} {"level":"info","ts":"2026-05-19T15:39:45.082978Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b3617fc4a93ad58b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-19T15:39:45.082987Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3617fc4a93ad58b became follower at term 1"} {"level":"info","ts":"2026-05-19T15:39:45.083027Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3617fc4a93ad58b switched to configuration voters=(12925752888159557003)"} {"level":"warn","ts":"2026-05-19T15:39:45.08985Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-19T15:39:45.091156Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-19T15:39:45.093666Z","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-19T15:39:45.096807Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b3617fc4a93ad58b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-19T15:39:45.097285Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b3617fc4a93ad58b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-19T15:39:45.097855Z","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-19T15:39:45.098319Z","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-19T15:39:45.098384Z","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-19T15:39:45.098878Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3617fc4a93ad58b switched to configuration voters=(12925752888159557003)"} {"level":"info","ts":"2026-05-19T15:39:45.099057Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2f224b65169306de","local-member-id":"b3617fc4a93ad58b","added-peer-id":"b3617fc4a93ad58b","added-peer-peer-urls":["https://199.19.213.174:2380"]} {"level":"info","ts":"2026-05-19T15:39:45.102251Z","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-19T15:39:45.102407Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.174:2380"} {"level":"info","ts":"2026-05-19T15:39:45.102469Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.174:2380"} {"level":"info","ts":"2026-05-19T15:39:45.102533Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b3617fc4a93ad58b","initial-advertise-peer-urls":["https://199.19.213.174:2380"],"listen-peer-urls":["https://199.19.213.174:2380"],"advertise-client-urls":["https://199.19.213.174:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.174:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-19T15:39:45.102582Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-19T15:39:46.083733Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3617fc4a93ad58b is starting a new election at term 1"} {"level":"info","ts":"2026-05-19T15:39:46.083816Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3617fc4a93ad58b became pre-candidate at term 1"} {"level":"info","ts":"2026-05-19T15:39:46.08385Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3617fc4a93ad58b received MsgPreVoteResp from b3617fc4a93ad58b at term 1"} {"level":"info","ts":"2026-05-19T15:39:46.083871Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3617fc4a93ad58b became candidate at term 2"} {"level":"info","ts":"2026-05-19T15:39:46.083884Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3617fc4a93ad58b received MsgVoteResp from b3617fc4a93ad58b at term 2"} {"level":"info","ts":"2026-05-19T15:39:46.083901Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3617fc4a93ad58b became leader at term 2"} {"level":"info","ts":"2026-05-19T15:39:46.08392Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b3617fc4a93ad58b elected leader b3617fc4a93ad58b at term 2"} {"level":"info","ts":"2026-05-19T15:39:46.084949Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T15:39:46.086264Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T15:39:46.086261Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b3617fc4a93ad58b","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.174:2379]}","request-path":"/0/members/b3617fc4a93ad58b/attributes","cluster-id":"2f224b65169306de","publish-timeout":"7s"} {"level":"info","ts":"2026-05-19T15:39:46.086328Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T15:39:46.08672Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-19T15:39:46.086857Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-19T15:39:46.089582Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-19T15:39:46.089952Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.174:2379"} {"level":"info","ts":"2026-05-19T15:39:46.096247Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2f224b65169306de","local-member-id":"b3617fc4a93ad58b","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T15:39:46.096389Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T15:39:46.096438Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T15:40:12.885052Z","caller":"traceutil/trace.go:171","msg":"trace[1198797445] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"113.479419ms","start":"2026-05-19T15:40:12.771545Z","end":"2026-05-19T15:40:12.885025Z","steps":["trace[1198797445] 'process raft request' (duration: 112.853285ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:40:14.681094Z","caller":"traceutil/trace.go:171","msg":"trace[1504331026] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"204.735053ms","start":"2026-05-19T15:40:14.476331Z","end":"2026-05-19T15:40:14.681066Z","steps":["trace[1504331026] 'process raft request' (duration: 204.526068ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:40:14.68755Z","caller":"traceutil/trace.go:171","msg":"trace[1573030125] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"193.013844ms","start":"2026-05-19T15:40:14.494505Z","end":"2026-05-19T15:40:14.687519Z","steps":["trace[1573030125] 'process raft request' (duration: 192.788739ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:40:14.6877Z","caller":"traceutil/trace.go:171","msg":"trace[45128024] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"179.192714ms","start":"2026-05-19T15:40:14.508484Z","end":"2026-05-19T15:40:14.687677Z","steps":["trace[45128024] 'process raft request' (duration: 178.969429ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:40:14.687731Z","caller":"traceutil/trace.go:171","msg":"trace[750112492] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"173.820801ms","start":"2026-05-19T15:40:14.513882Z","end":"2026-05-19T15:40:14.687703Z","steps":["trace[750112492] 'process raft request' (duration: 173.679028ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:40:14.687568Z","caller":"traceutil/trace.go:171","msg":"trace[798893705] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"192.992243ms","start":"2026-05-19T15:40:14.494552Z","end":"2026-05-19T15:40:14.687544Z","steps":["trace[798893705] 'process raft request' (duration: 192.86381ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:40:14.68798Z","caller":"traceutil/trace.go:171","msg":"trace[1424261257] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"172.285205ms","start":"2026-05-19T15:40:14.515681Z","end":"2026-05-19T15:40:14.687966Z","steps":["trace[1424261257] 'process raft request' (duration: 171.926347ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:40:14.688244Z","caller":"traceutil/trace.go:171","msg":"trace[1299934487] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"166.399429ms","start":"2026-05-19T15:40:14.521828Z","end":"2026-05-19T15:40:14.688227Z","steps":["trace[1299934487] 'process raft request' (duration: 165.814616ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:40:14.688337Z","caller":"traceutil/trace.go:171","msg":"trace[50644140] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"153.4568ms","start":"2026-05-19T15:40:14.534869Z","end":"2026-05-19T15:40:14.688325Z","steps":["trace[50644140] 'process raft request' (duration: 153.301647ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:40:14.688422Z","caller":"traceutil/trace.go:171","msg":"trace[2102448243] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"147.872272ms","start":"2026-05-19T15:40:14.540539Z","end":"2026-05-19T15:40:14.688411Z","steps":["trace[2102448243] 'process raft request' (duration: 147.692037ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:40:14.68849Z","caller":"traceutil/trace.go:171","msg":"trace[2038044340] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"163.979344ms","start":"2026-05-19T15:40:14.5245Z","end":"2026-05-19T15:40:14.688479Z","steps":["trace[2038044340] 'process raft request' (duration: 163.576173ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:40:14.688565Z","caller":"traceutil/trace.go:171","msg":"trace[1502594995] linearizableReadLoop","detail":"{readStateIndex:490; appliedIndex:481; }","duration":"149.256635ms","start":"2026-05-19T15:40:14.53923Z","end":"2026-05-19T15:40:14.688487Z","steps":["trace[1502594995] 'read index received' (duration: 141.737711ms)","trace[1502594995] 'applied index is now lower than readState.Index' (duration: 7.517844ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T15:40:14.688647Z","caller":"traceutil/trace.go:171","msg":"trace[157114330] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"134.37467ms","start":"2026-05-19T15:40:14.554261Z","end":"2026-05-19T15:40:14.688636Z","steps":["trace[157114330] 'process raft request' (duration: 134.023471ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:40:14.688678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.428219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T15:40:14.688738Z","caller":"traceutil/trace.go:171","msg":"trace[596947392] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:478; }","duration":"149.535831ms","start":"2026-05-19T15:40:14.539192Z","end":"2026-05-19T15:40:14.688728Z","steps":["trace[596947392] 'agreement among raft nodes before linearized reading' (duration: 149.419879ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:40:17.718275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.760542ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-19T15:40:17.71838Z","caller":"traceutil/trace.go:171","msg":"trace[87397622] linearizableReadLoop","detail":"{readStateIndex:567; appliedIndex:566; }","duration":"240.379225ms","start":"2026-05-19T15:40:17.477985Z","end":"2026-05-19T15:40:17.718364Z","steps":["trace[87397622] 'read index received' (duration: 114.085762ms)","trace[87397622] 'applied index is now lower than readState.Index' (duration: 126.292353ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T15:40:17.718449Z","caller":"traceutil/trace.go:171","msg":"trace[1840543300] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"273.708414ms","start":"2026-05-19T15:40:17.444696Z","end":"2026-05-19T15:40:17.718404Z","steps":["trace[1840543300] 'process raft request' (duration: 147.361349ms)","trace[1840543300] 'compare' (duration: 125.325722ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T15:40:17.718558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.56634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-19T15:40:17.718602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.362876ms","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-19T15:40:17.718778Z","caller":"traceutil/trace.go:171","msg":"trace[1116851926] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:550; }","duration":"185.580931ms","start":"2026-05-19T15:40:17.53317Z","end":"2026-05-19T15:40:17.718751Z","steps":["trace[1116851926] 'agreement among raft nodes before linearized reading' (duration: 185.328536ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:40:17.71862Z","caller":"traceutil/trace.go:171","msg":"trace[539473152] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:550; }","duration":"240.657362ms","start":"2026-05-19T15:40:17.477947Z","end":"2026-05-19T15:40:17.718605Z","steps":["trace[539473152] 'agreement among raft nodes before linearized reading' (duration: 240.520669ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:40:20.800974Z","caller":"traceutil/trace.go:171","msg":"trace[260832029] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"226.675459ms","start":"2026-05-19T15:40:20.574263Z","end":"2026-05-19T15:40:20.800938Z","steps":["trace[260832029] 'process raft request' (duration: 226.079236ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:40:21.479747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.708825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-96fld\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-05-19T15:40:21.479671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.983403ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T15:40:21.479854Z","caller":"traceutil/trace.go:171","msg":"trace[881683928] range","detail":"{range_begin:/registry/pods/kube-system/cilium-96fld; range_end:; response_count:1; response_revision:574; }","duration":"498.864159ms","start":"2026-05-19T15:40:20.980966Z","end":"2026-05-19T15:40:21.47983Z","steps":["trace[881683928] 'range keys from in-memory index tree' (duration: 498.496121ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:40:21.479902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:40:20.980949Z","time spent":"498.943911ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-96fld\" "} {"level":"info","ts":"2026-05-19T15:40:21.480036Z","caller":"traceutil/trace.go:171","msg":"trace[570429914] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:574; }","duration":"392.2597ms","start":"2026-05-19T15:40:21.087593Z","end":"2026-05-19T15:40:21.479853Z","steps":["trace[570429914] 'range keys from in-memory index tree' (duration: 391.965123ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:40:21.480608Z","caller":"traceutil/trace.go:171","msg":"trace[803609058] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"166.598563ms","start":"2026-05-19T15:40:21.313977Z","end":"2026-05-19T15:40:21.480575Z","steps":["trace[803609058] 'process raft request' (duration: 165.784145ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:40:36.705824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.121239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T15:40:36.705917Z","caller":"traceutil/trace.go:171","msg":"trace[1225787431] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:739; }","duration":"165.228001ms","start":"2026-05-19T15:40:36.540668Z","end":"2026-05-19T15:40:36.705896Z","steps":["trace[1225787431] 'range keys from in-memory index tree' (duration: 164.994036ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:41:10.08557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.038689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-19T15:41:10.08558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.554197ms","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-19T15:41:10.085638Z","caller":"traceutil/trace.go:171","msg":"trace[398119076] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:954; }","duration":"102.154982ms","start":"2026-05-19T15:41:09.983466Z","end":"2026-05-19T15:41:10.085621Z","steps":["trace[398119076] 'range keys from in-memory index tree' (duration: 101.900625ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:41:10.085665Z","caller":"traceutil/trace.go:171","msg":"trace[1186468287] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:954; }","duration":"104.67164ms","start":"2026-05-19T15:41:09.980971Z","end":"2026-05-19T15:41:10.085643Z","steps":["trace[1186468287] 'range keys from in-memory index tree' (duration: 104.395683ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:41:10.085722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.68227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T15:41:10.085803Z","caller":"traceutil/trace.go:171","msg":"trace[1227932487] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:954; }","duration":"128.817243ms","start":"2026-05-19T15:41:09.956962Z","end":"2026-05-19T15:41:10.085779Z","steps":["trace[1227932487] 'count revisions from in-memory index tree' (duration: 128.596018ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:41:10.284463Z","caller":"traceutil/trace.go:171","msg":"trace[723013895] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"189.730808ms","start":"2026-05-19T15:41:10.094715Z","end":"2026-05-19T15:41:10.284446Z","steps":["trace[723013895] 'process raft request' (duration: 189.614655ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:41:10.459528Z","caller":"traceutil/trace.go:171","msg":"trace[2063385300] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"364.722499ms","start":"2026-05-19T15:41:10.094773Z","end":"2026-05-19T15:41:10.459495Z","steps":["trace[2063385300] 'process raft request' (duration: 330.815231ms)","trace[2063385300] 'compare' (duration: 33.57007ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T15:41:10.459885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:41:10.094758Z","time spent":"364.859322ms","remote":"127.0.0.1:37860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T15:41:10.46026Z","caller":"traceutil/trace.go:171","msg":"trace[965262748] linearizableReadLoop","detail":"{readStateIndex:987; appliedIndex:985; }","duration":"317.412105ms","start":"2026-05-19T15:41:10.142832Z","end":"2026-05-19T15:41:10.460244Z","steps":["trace[965262748] 'read index received' (duration: 141.551644ms)","trace[965262748] 'applied index is now lower than readState.Index' (duration: 175.859491ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T15:41:10.460378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.551357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-19T15:41:10.460415Z","caller":"traceutil/trace.go:171","msg":"trace[580719742] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:957; }","duration":"317.617549ms","start":"2026-05-19T15:41:10.142788Z","end":"2026-05-19T15:41:10.460406Z","steps":["trace[580719742] 'agreement among raft nodes before linearized reading' (duration: 317.503137ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:41:10.460398Z","caller":"traceutil/trace.go:171","msg":"trace[1801069491] transaction","detail":"{read_only:false; response_revision:957; number_of_response:1; }","duration":"195.93453ms","start":"2026-05-19T15:41:10.264436Z","end":"2026-05-19T15:41:10.46037Z","steps":["trace[1801069491] 'process raft request' (duration: 194.963519ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:41:10.460446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:41:10.142756Z","time spent":"317.683051ms","remote":"127.0.0.1:37860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-19T15:41:31.207644Z","caller":"traceutil/trace.go:171","msg":"trace[820516961] linearizableReadLoop","detail":"{readStateIndex:1060; appliedIndex:1059; }","duration":"116.929109ms","start":"2026-05-19T15:41:31.090696Z","end":"2026-05-19T15:41:31.207625Z","steps":["trace[820516961] 'read index received' (duration: 116.799846ms)","trace[820516961] 'applied index is now lower than readState.Index' (duration: 128.163µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T15:41:31.207709Z","caller":"traceutil/trace.go:171","msg":"trace[910363411] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"173.146237ms","start":"2026-05-19T15:41:31.034534Z","end":"2026-05-19T15:41:31.20768Z","steps":["trace[910363411] 'process raft request' (duration: 172.981664ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:41:31.207764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.044952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T15:41:31.207795Z","caller":"traceutil/trace.go:171","msg":"trace[895833526] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:1025; }","duration":"117.113144ms","start":"2026-05-19T15:41:31.090671Z","end":"2026-05-19T15:41:31.207785Z","steps":["trace[895833526] 'agreement among raft nodes before linearized reading' (duration: 117.026432ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:41:32.74224Z","caller":"traceutil/trace.go:171","msg":"trace[613269368] transaction","detail":"{read_only:false; response_revision:1030; number_of_response:1; }","duration":"173.968137ms","start":"2026-05-19T15:41:32.568244Z","end":"2026-05-19T15:41:32.742212Z","steps":["trace[613269368] 'process raft request' (duration: 109.54436ms)","trace[613269368] 'compare' (duration: 64.302674ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T15:41:44.979426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.257096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T15:41:44.979517Z","caller":"traceutil/trace.go:171","msg":"trace[1616713932] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1118; }","duration":"439.40236ms","start":"2026-05-19T15:41:44.540102Z","end":"2026-05-19T15:41:44.979505Z","steps":["trace[1616713932] 'range keys from in-memory index tree' (duration: 439.207735ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:41:44.979542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:41:44.540086Z","time spent":"439.450691ms","remote":"127.0.0.1:37596","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-19T15:41:44.979853Z","caller":"traceutil/trace.go:171","msg":"trace[752013519] linearizableReadLoop","detail":"{readStateIndex:1159; appliedIndex:1158; }","duration":"372.100659ms","start":"2026-05-19T15:41:44.60772Z","end":"2026-05-19T15:41:44.97982Z","steps":["trace[752013519] 'read index received' (duration: 324.115549ms)","trace[752013519] 'applied index is now lower than readState.Index' (duration: 47.98379ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T15:41:44.979885Z","caller":"traceutil/trace.go:171","msg":"trace[1101150621] transaction","detail":"{read_only:false; response_revision:1119; number_of_response:1; }","duration":"393.889108ms","start":"2026-05-19T15:41:44.585977Z","end":"2026-05-19T15:41:44.979866Z","steps":["trace[1101150621] 'process raft request' (duration: 345.849436ms)","trace[1101150621] 'compare' (duration: 47.516059ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T15:41:44.979991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:41:44.585959Z","time spent":"393.967279ms","remote":"127.0.0.1:37860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T15:41:44.980073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.206074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-19T15:41:44.980108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.376225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-19T15:41:44.980175Z","caller":"traceutil/trace.go:171","msg":"trace[1768792953] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1119; }","duration":"372.473466ms","start":"2026-05-19T15:41:44.607689Z","end":"2026-05-19T15:41:44.980162Z","steps":["trace[1768792953] 'agreement among raft nodes before linearized reading' (duration: 372.297752ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:41:44.980204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:41:44.607672Z","time spent":"372.525278ms","remote":"127.0.0.1:37860","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":"info","ts":"2026-05-19T15:41:44.980138Z","caller":"traceutil/trace.go:171","msg":"trace[1872548090] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1119; }","duration":"195.284996ms","start":"2026-05-19T15:41:44.784825Z","end":"2026-05-19T15:41:44.98011Z","steps":["trace[1872548090] 'agreement among raft nodes before linearized reading' (duration: 195.140633ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:41:45.115082Z","caller":"traceutil/trace.go:171","msg":"trace[968929664] transaction","detail":"{read_only:false; response_revision:1120; number_of_response:1; }","duration":"132.376203ms","start":"2026-05-19T15:41:44.98269Z","end":"2026-05-19T15:41:45.115066Z","steps":["trace[968929664] 'process raft request' (duration: 117.164744ms)","trace[968929664] 'compare' (duration: 14.83388ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T15:41:45.115195Z","caller":"traceutil/trace.go:171","msg":"trace[1244405925] transaction","detail":"{read_only:false; response_revision:1121; number_of_response:1; }","duration":"131.800481ms","start":"2026-05-19T15:41:44.98339Z","end":"2026-05-19T15:41:45.11519Z","steps":["trace[1244405925] 'process raft request' (duration: 131.392272ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:42:00.219675Z","caller":"traceutil/trace.go:171","msg":"trace[106686016] transaction","detail":"{read_only:false; response_revision:1189; number_of_response:1; }","duration":"137.995113ms","start":"2026-05-19T15:42:00.081636Z","end":"2026-05-19T15:42:00.219631Z","steps":["trace[106686016] 'process raft request' (duration: 137.8486ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:42:03.213289Z","caller":"traceutil/trace.go:171","msg":"trace[776381632] transaction","detail":"{read_only:false; response_revision:1212; number_of_response:1; }","duration":"163.074418ms","start":"2026-05-19T15:42:03.050194Z","end":"2026-05-19T15:42:03.213269Z","steps":["trace[776381632] 'process raft request' (duration: 162.951345ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:42:04.448618Z","caller":"traceutil/trace.go:171","msg":"trace[870868429] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"214.032765ms","start":"2026-05-19T15:42:04.234551Z","end":"2026-05-19T15:42:04.448584Z","steps":["trace[870868429] 'process raft request' (duration: 213.81957ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:42:04.602607Z","caller":"traceutil/trace.go:171","msg":"trace[770902570] linearizableReadLoop","detail":"{readStateIndex:1263; appliedIndex:1259; }","duration":"225.868146ms","start":"2026-05-19T15:42:04.376712Z","end":"2026-05-19T15:42:04.602581Z","steps":["trace[770902570] 'read index received' (duration: 71.650752ms)","trace[770902570] 'applied index is now lower than readState.Index' (duration: 154.215544ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T15:42:04.602665Z","caller":"traceutil/trace.go:171","msg":"trace[450954060] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"324.438265ms","start":"2026-05-19T15:42:04.278178Z","end":"2026-05-19T15:42:04.602617Z","steps":["trace[450954060] 'process raft request' (duration: 324.319653ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:42:04.602782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.0411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T15:42:04.602824Z","caller":"traceutil/trace.go:171","msg":"trace[1545050400] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1219; }","duration":"226.150363ms","start":"2026-05-19T15:42:04.37666Z","end":"2026-05-19T15:42:04.60281Z","steps":["trace[1545050400] 'agreement among raft nodes before linearized reading' (duration: 226.057561ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:42:04.602813Z","caller":"traceutil/trace.go:171","msg":"trace[1197479419] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"324.677391ms","start":"2026-05-19T15:42:04.27811Z","end":"2026-05-19T15:42:04.602788Z","steps":["trace[1197479419] 'process raft request' (duration: 324.215101ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:42:04.602888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:42:04.27817Z","time spent":"324.596389ms","remote":"127.0.0.1:37860","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-05-19T15:42:04.60294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:42:04.278096Z","time spent":"324.779044ms","remote":"127.0.0.1:37666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T15:42:05.352684Z","caller":"traceutil/trace.go:171","msg":"trace[861603247] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"135.062425ms","start":"2026-05-19T15:42:05.217601Z","end":"2026-05-19T15:42:05.352663Z","steps":["trace[861603247] 'process raft request' (duration: 134.703107ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:42:15.592112Z","caller":"traceutil/trace.go:171","msg":"trace[2075231896] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"160.868403ms","start":"2026-05-19T15:42:15.431217Z","end":"2026-05-19T15:42:15.592086Z","steps":["trace[2075231896] 'process raft request' (duration: 160.056054ms)"],"step_count":1}