{"level":"warn","ts":"2026-07-16T06:43:18.120738Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-16T06:43:18.120815Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.73: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.73:2380","--initial-cluster=instance=https://199.19.213.73:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.73:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.73:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-07-16T06:43:18.120913Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-16T06:43:18.120927Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.73:2380"]} {"level":"info","ts":"2026-07-16T06:43:18.120975Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-16T06:43:18.121638Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.73:2379"]} {"level":"info","ts":"2026-07-16T06:43:18.121762Z","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.73:2380"],"listen-peer-urls":["https://199.19.213.73:2380"],"advertise-client-urls":["https://199.19.213.73:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.73:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.73:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-07-16T06:43:18.126175Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.129541ms"} {"level":"info","ts":"2026-07-16T06:43:18.13472Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"34a8f480fa9ab6cb","cluster-id":"4820536600e0938e"} {"level":"info","ts":"2026-07-16T06:43:18.134786Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"34a8f480fa9ab6cb switched to configuration voters=()"} {"level":"info","ts":"2026-07-16T06:43:18.134809Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"34a8f480fa9ab6cb became follower at term 0"} {"level":"info","ts":"2026-07-16T06:43:18.134861Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 34a8f480fa9ab6cb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-16T06:43:18.13488Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"34a8f480fa9ab6cb became follower at term 1"} {"level":"info","ts":"2026-07-16T06:43:18.134948Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"34a8f480fa9ab6cb switched to configuration voters=(3794551520857077451)"} {"level":"warn","ts":"2026-07-16T06:43:18.143415Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-16T06:43:18.145006Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-16T06:43:18.146262Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-07-16T06:43:18.148452Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"34a8f480fa9ab6cb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-16T06:43:18.148668Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"34a8f480fa9ab6cb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-16T06:43:18.14885Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-16T06:43:18.148945Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-16T06:43:18.148967Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-16T06:43:18.150961Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"34a8f480fa9ab6cb switched to configuration voters=(3794551520857077451)"} {"level":"info","ts":"2026-07-16T06:43:18.15154Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4820536600e0938e","local-member-id":"34a8f480fa9ab6cb","added-peer-id":"34a8f480fa9ab6cb","added-peer-peer-urls":["https://199.19.213.73:2380"]} {"level":"info","ts":"2026-07-16T06:43:18.153925Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-16T06:43:18.154224Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.73:2380"} {"level":"info","ts":"2026-07-16T06:43:18.154272Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.73:2380"} {"level":"info","ts":"2026-07-16T06:43:18.154616Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"34a8f480fa9ab6cb","initial-advertise-peer-urls":["https://199.19.213.73:2380"],"listen-peer-urls":["https://199.19.213.73:2380"],"advertise-client-urls":["https://199.19.213.73:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.73:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-16T06:43:18.154684Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-16T06:43:19.135695Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"34a8f480fa9ab6cb is starting a new election at term 1"} {"level":"info","ts":"2026-07-16T06:43:19.135761Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"34a8f480fa9ab6cb became pre-candidate at term 1"} {"level":"info","ts":"2026-07-16T06:43:19.135811Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"34a8f480fa9ab6cb received MsgPreVoteResp from 34a8f480fa9ab6cb at term 1"} {"level":"info","ts":"2026-07-16T06:43:19.135831Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"34a8f480fa9ab6cb became candidate at term 2"} {"level":"info","ts":"2026-07-16T06:43:19.135842Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"34a8f480fa9ab6cb received MsgVoteResp from 34a8f480fa9ab6cb at term 2"} {"level":"info","ts":"2026-07-16T06:43:19.135858Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"34a8f480fa9ab6cb became leader at term 2"} {"level":"info","ts":"2026-07-16T06:43:19.135873Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 34a8f480fa9ab6cb elected leader 34a8f480fa9ab6cb at term 2"} {"level":"info","ts":"2026-07-16T06:43:19.136881Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-16T06:43:19.137764Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"34a8f480fa9ab6cb","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.73:2379]}","request-path":"/0/members/34a8f480fa9ab6cb/attributes","cluster-id":"4820536600e0938e","publish-timeout":"7s"} {"level":"info","ts":"2026-07-16T06:43:19.137782Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-16T06:43:19.138331Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4820536600e0938e","local-member-id":"34a8f480fa9ab6cb","cluster-version":"3.5"} {"level":"info","ts":"2026-07-16T06:43:19.138327Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-16T06:43:19.138381Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-16T06:43:19.138425Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-16T06:43:19.138444Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-16T06:43:19.138584Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-16T06:43:19.141972Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-16T06:43:19.142029Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.73:2379"} {"level":"info","ts":"2026-07-16T06:43:35.263465Z","caller":"traceutil/trace.go:171","msg":"trace[1177493033] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"407.19815ms","start":"2026-07-16T06:43:34.856231Z","end":"2026-07-16T06:43:35.26343Z","steps":["trace[1177493033] 'process raft request' (duration: 406.96465ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:43:35.264714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:43:34.856197Z","time spent":"407.387939ms","remote":"127.0.0.1:48024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T06:43:59.187447Z","caller":"traceutil/trace.go:171","msg":"trace[1561275714] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"103.981009ms","start":"2026-07-16T06:43:59.083433Z","end":"2026-07-16T06:43:59.187414Z","steps":["trace[1561275714] 'compare' (duration: 93.821045ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:43:59.187542Z","caller":"traceutil/trace.go:171","msg":"trace[1702198789] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"100.070941ms","start":"2026-07-16T06:43:59.087452Z","end":"2026-07-16T06:43:59.187523Z","steps":["trace[1702198789] 'process raft request' (duration: 99.842813ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:43:59.196827Z","caller":"traceutil/trace.go:171","msg":"trace[1991418821] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"103.519304ms","start":"2026-07-16T06:43:59.093288Z","end":"2026-07-16T06:43:59.196808Z","steps":["trace[1991418821] 'process raft request' (duration: 102.976297ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:43:59.196922Z","caller":"traceutil/trace.go:171","msg":"trace[643324148] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"102.581553ms","start":"2026-07-16T06:43:59.094335Z","end":"2026-07-16T06:43:59.196917Z","steps":["trace[643324148] 'process raft request' (duration: 102.034755ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:43:59.19732Z","caller":"traceutil/trace.go:171","msg":"trace[1948870584] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"101.821718ms","start":"2026-07-16T06:43:59.095477Z","end":"2026-07-16T06:43:59.197299Z","steps":["trace[1948870584] 'process raft request' (duration: 100.97137ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:44:04.998853Z","caller":"traceutil/trace.go:171","msg":"trace[2097998605] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"133.931097ms","start":"2026-07-16T06:44:04.864878Z","end":"2026-07-16T06:44:04.998809Z","steps":["trace[2097998605] 'process raft request' (duration: 126.950639ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:44:05.271796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.960873ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-16T06:44:05.271884Z","caller":"traceutil/trace.go:171","msg":"trace[1622258898] linearizableReadLoop","detail":"{readStateIndex:619; appliedIndex:618; }","duration":"203.457047ms","start":"2026-07-16T06:44:05.068417Z","end":"2026-07-16T06:44:05.271874Z","steps":["trace[1622258898] 'read index received' (duration: 93.333889ms)","trace[1622258898] 'applied index is now lower than readState.Index' (duration: 110.121958ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T06:44:05.271998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.591041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-16T06:44:05.272017Z","caller":"traceutil/trace.go:171","msg":"trace[1537667879] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:600; }","duration":"203.614952ms","start":"2026-07-16T06:44:05.068397Z","end":"2026-07-16T06:44:05.272012Z","steps":["trace[1537667879] 'agreement among raft nodes before linearized reading' (duration: 203.504679ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:44:05.272196Z","caller":"traceutil/trace.go:171","msg":"trace[1895368054] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"383.854926ms","start":"2026-07-16T06:44:04.888134Z","end":"2026-07-16T06:44:05.271989Z","steps":["trace[1895368054] 'process raft request' (duration: 273.568293ms)","trace[1895368054] 'compare' (duration: 109.676515ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T06:44:05.272551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:44:04.888119Z","time spent":"384.186987ms","remote":"127.0.0.1:48130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-16T06:44:06.03057Z","caller":"traceutil/trace.go:171","msg":"trace[1833342927] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:621; }","duration":"250.003259ms","start":"2026-07-16T06:44:05.780532Z","end":"2026-07-16T06:44:06.030536Z","steps":["trace[1833342927] 'read index received' (duration: 249.149893ms)","trace[1833342927] 'applied index is now lower than readState.Index' (duration: 851.856µs)"],"step_count":2} {"level":"warn","ts":"2026-07-16T06:44:06.030771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.201875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T06:44:06.030784Z","caller":"traceutil/trace.go:171","msg":"trace[1773193463] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"319.608403ms","start":"2026-07-16T06:44:05.711136Z","end":"2026-07-16T06:44:06.030745Z","steps":["trace[1773193463] 'process raft request' (duration: 318.745896ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:44:06.030829Z","caller":"traceutil/trace.go:171","msg":"trace[1443928561] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:603; }","duration":"250.322409ms","start":"2026-07-16T06:44:05.780488Z","end":"2026-07-16T06:44:06.030811Z","steps":["trace[1443928561] 'agreement among raft nodes before linearized reading' (duration: 250.202035ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:44:06.030974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:44:05.710642Z","time spent":"320.231933ms","remote":"127.0.0.1:47870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T06:44:21.685188Z","caller":"traceutil/trace.go:171","msg":"trace[434186122] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"199.966316ms","start":"2026-07-16T06:44:21.485196Z","end":"2026-07-16T06:44:21.685163Z","steps":["trace[434186122] 'process raft request' (duration: 199.73924ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:45:41.991566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.417942ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-16T06:45:41.9917Z","caller":"traceutil/trace.go:171","msg":"trace[1421196843] transaction","detail":"{read_only:false; response_revision:1848; number_of_response:1; }","duration":"116.656626ms","start":"2026-07-16T06:45:41.875019Z","end":"2026-07-16T06:45:41.991676Z","steps":["trace[1421196843] 'process raft request' (duration: 10.02309ms)","trace[1421196843] 'compare' (duration: 106.26904ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:45:42.181767Z","caller":"traceutil/trace.go:171","msg":"trace[1300846896] transaction","detail":"{read_only:false; response_revision:1849; number_of_response:1; }","duration":"107.849347ms","start":"2026-07-16T06:45:42.073813Z","end":"2026-07-16T06:45:42.181662Z","steps":["trace[1300846896] 'process raft request' (duration: 74.629102ms)","trace[1300846896] 'compare' (duration: 32.95633ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T06:45:42.481156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.436774ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-16T06:45:42.48132Z","caller":"traceutil/trace.go:171","msg":"trace[158388513] linearizableReadLoop","detail":"{readStateIndex:1920; appliedIndex:1918; }","duration":"347.17394ms","start":"2026-07-16T06:45:42.134123Z","end":"2026-07-16T06:45:42.481297Z","steps":["trace[158388513] 'read index received' (duration: 14.309933ms)","trace[158388513] 'applied index is now lower than readState.Index' (duration: 332.862687ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:45:42.481399Z","caller":"traceutil/trace.go:171","msg":"trace[1556975704] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"396.81302ms","start":"2026-07-16T06:45:42.084516Z","end":"2026-07-16T06:45:42.481329Z","steps":["trace[1556975704] 'process raft request' (duration: 241.07528ms)","trace[1556975704] 'compare' (duration: 155.209731ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T06:45:42.48159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.462664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-16T06:45:42.48163Z","caller":"traceutil/trace.go:171","msg":"trace[445751231] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1850; }","duration":"347.522246ms","start":"2026-07-16T06:45:42.134098Z","end":"2026-07-16T06:45:42.48162Z","steps":["trace[445751231] 'agreement among raft nodes before linearized reading' (duration: 347.320143ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:45:42.481749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:45:42.134087Z","time spent":"347.649468ms","remote":"127.0.0.1:48024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-16T06:45:42.481792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.303875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f0136ab0-279c-45ab-b645-0ee82bbf33f2\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-07-16T06:45:42.481848Z","caller":"traceutil/trace.go:171","msg":"trace[1779312080] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f0136ab0-279c-45ab-b645-0ee82bbf33f2; range_end:; response_count:1; response_revision:1850; }","duration":"135.394517ms","start":"2026-07-16T06:45:42.346439Z","end":"2026-07-16T06:45:42.481833Z","steps":["trace[1779312080] 'agreement among raft nodes before linearized reading' (duration: 135.188084ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:45:42.482505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:45:42.084477Z","time spent":"397.008163ms","remote":"127.0.0.1:47820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T06:45:42.482522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.892882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:528"} {"level":"info","ts":"2026-07-16T06:45:42.482591Z","caller":"traceutil/trace.go:171","msg":"trace[383547000] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:1850; }","duration":"342.006864ms","start":"2026-07-16T06:45:42.140566Z","end":"2026-07-16T06:45:42.482572Z","steps":["trace[383547000] 'agreement among raft nodes before linearized reading' (duration: 340.898078ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:45:42.482627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:45:42.140546Z","time spent":"342.073145ms","remote":"127.0.0.1:48024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":550,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"info","ts":"2026-07-16T06:45:42.787357Z","caller":"traceutil/trace.go:171","msg":"trace[1620722415] linearizableReadLoop","detail":"{readStateIndex:1923; appliedIndex:1921; }","duration":"261.995522ms","start":"2026-07-16T06:45:42.525318Z","end":"2026-07-16T06:45:42.787314Z","steps":["trace[1620722415] 'read index received' (duration: 202.880462ms)","trace[1620722415] 'applied index is now lower than readState.Index' (duration: 59.11372ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:45:42.787576Z","caller":"traceutil/trace.go:171","msg":"trace[1203668870] transaction","detail":"{read_only:false; response_revision:1852; number_of_response:1; }","duration":"298.051469ms","start":"2026-07-16T06:45:42.489498Z","end":"2026-07-16T06:45:42.78755Z","steps":["trace[1203668870] 'process raft request' (duration: 238.820717ms)","trace[1203668870] 'compare' (duration: 58.38161ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:45:42.787681Z","caller":"traceutil/trace.go:171","msg":"trace[1849708057] transaction","detail":"{read_only:false; response_revision:1853; number_of_response:1; }","duration":"297.368489ms","start":"2026-07-16T06:45:42.490297Z","end":"2026-07-16T06:45:42.787665Z","steps":["trace[1849708057] 'process raft request' (duration: 296.910512ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:45:42.787814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.025589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T06:45:42.787877Z","caller":"traceutil/trace.go:171","msg":"trace[1553526638] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:1853; }","duration":"298.351794ms","start":"2026-07-16T06:45:42.489505Z","end":"2026-07-16T06:45:42.787856Z","steps":["trace[1553526638] 'agreement among raft nodes before linearized reading' (duration: 298.007489ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:45:42.787983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.516148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T06:45:42.788327Z","caller":"traceutil/trace.go:171","msg":"trace[885245662] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1853; }","duration":"283.029775ms","start":"2026-07-16T06:45:42.50527Z","end":"2026-07-16T06:45:42.788299Z","steps":["trace[885245662] 'agreement among raft nodes before linearized reading' (duration: 282.396646ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:46:15.68638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.877286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-16T06:46:15.686475Z","caller":"traceutil/trace.go:171","msg":"trace[987353217] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2088; }","duration":"132.028038ms","start":"2026-07-16T06:46:15.554427Z","end":"2026-07-16T06:46:15.686455Z","steps":["trace[987353217] 'range keys from in-memory index tree' (duration: 131.694834ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:46:16.059303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.610038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-16T06:46:16.059368Z","caller":"traceutil/trace.go:171","msg":"trace[744708936] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2091; }","duration":"114.736689ms","start":"2026-07-16T06:46:15.944616Z","end":"2026-07-16T06:46:16.059353Z","steps":["trace[744708936] 'range keys from in-memory index tree' (duration: 114.461766ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:46:16.059788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.395155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-16T06:46:16.059928Z","caller":"traceutil/trace.go:171","msg":"trace[2077040465] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2091; }","duration":"114.593998ms","start":"2026-07-16T06:46:15.945298Z","end":"2026-07-16T06:46:16.059892Z","steps":["trace[2077040465] 'range keys from in-memory index tree' (duration: 114.208473ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:46:16.818805Z","caller":"traceutil/trace.go:171","msg":"trace[784298268] transaction","detail":"{read_only:false; response_revision:2096; number_of_response:1; }","duration":"134.018589ms","start":"2026-07-16T06:46:16.684754Z","end":"2026-07-16T06:46:16.818773Z","steps":["trace[784298268] 'process raft request' (duration: 133.828396ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:46:16.89742Z","caller":"traceutil/trace.go:171","msg":"trace[630150919] linearizableReadLoop","detail":"{readStateIndex:2174; appliedIndex:2172; }","duration":"119.701712ms","start":"2026-07-16T06:46:16.7777Z","end":"2026-07-16T06:46:16.897401Z","steps":["trace[630150919] 'read index received' (duration: 40.914565ms)","trace[630150919] 'applied index is now lower than readState.Index' (duration: 78.786327ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:46:16.897467Z","caller":"traceutil/trace.go:171","msg":"trace[1095868211] transaction","detail":"{read_only:false; response_revision:2097; number_of_response:1; }","duration":"136.627053ms","start":"2026-07-16T06:46:16.76082Z","end":"2026-07-16T06:46:16.897447Z","steps":["trace[1095868211] 'process raft request' (duration: 136.456061ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:46:16.897543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.836174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T06:46:16.897573Z","caller":"traceutil/trace.go:171","msg":"trace[684507891] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2097; }","duration":"119.918655ms","start":"2026-07-16T06:46:16.777647Z","end":"2026-07-16T06:46:16.897565Z","steps":["trace[684507891] 'agreement among raft nodes before linearized reading' (duration: 119.852275ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:47:22.249748Z","caller":"traceutil/trace.go:171","msg":"trace[375632494] linearizableReadLoop","detail":"{readStateIndex:2636; appliedIndex:2635; }","duration":"174.895248ms","start":"2026-07-16T06:47:22.074835Z","end":"2026-07-16T06:47:22.24973Z","steps":["trace[375632494] 'read index received' (duration: 174.716536ms)","trace[375632494] 'applied index is now lower than readState.Index' (duration: 178.202µs)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:47:22.249842Z","caller":"traceutil/trace.go:171","msg":"trace[844565316] transaction","detail":"{read_only:false; response_revision:2544; number_of_response:1; }","duration":"198.418855ms","start":"2026-07-16T06:47:22.051383Z","end":"2026-07-16T06:47:22.249802Z","steps":["trace[844565316] 'process raft request' (duration: 198.218633ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:47:22.249973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.08838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.73\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-07-16T06:47:22.250002Z","caller":"traceutil/trace.go:171","msg":"trace[741344353] range","detail":"{range_begin:/registry/masterleases/199.19.213.73; range_end:; response_count:1; response_revision:2544; }","duration":"175.208031ms","start":"2026-07-16T06:47:22.074784Z","end":"2026-07-16T06:47:22.249992Z","steps":["trace[741344353] 'agreement among raft nodes before linearized reading' (duration: 175.053739ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:47:54.723869Z","caller":"traceutil/trace.go:171","msg":"trace[1433175565] transaction","detail":"{read_only:false; response_revision:2725; number_of_response:1; }","duration":"146.091163ms","start":"2026-07-16T06:47:54.577746Z","end":"2026-07-16T06:47:54.723837Z","steps":["trace[1433175565] 'process raft request' (duration: 121.244215ms)","trace[1433175565] 'compare' (duration: 24.710903ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:47:54.723898Z","caller":"traceutil/trace.go:171","msg":"trace[632085955] linearizableReadLoop","detail":"{readStateIndex:2825; appliedIndex:2824; }","duration":"145.685769ms","start":"2026-07-16T06:47:54.578184Z","end":"2026-07-16T06:47:54.72387Z","steps":["trace[632085955] 'read index received' (duration: 120.760498ms)","trace[632085955] 'applied index is now lower than readState.Index' (duration: 24.924181ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T06:47:54.724445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.239639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-16T06:47:54.724524Z","caller":"traceutil/trace.go:171","msg":"trace[442749419] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2725; }","duration":"146.348973ms","start":"2026-07-16T06:47:54.578157Z","end":"2026-07-16T06:47:54.724506Z","steps":["trace[442749419] 'agreement among raft nodes before linearized reading' (duration: 145.793663ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:51:53.775348Z","caller":"traceutil/trace.go:171","msg":"trace[1394056756] linearizableReadLoop","detail":"{readStateIndex:4827; appliedIndex:4825; }","duration":"101.242451ms","start":"2026-07-16T06:51:53.674073Z","end":"2026-07-16T06:51:53.775316Z","steps":["trace[1394056756] 'read index received' (duration: 70.224978ms)","trace[1394056756] 'applied index is now lower than readState.Index' (duration: 31.016373ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:51:53.775711Z","caller":"traceutil/trace.go:171","msg":"trace[407569759] transaction","detail":"{read_only:false; response_revision:4650; number_of_response:1; }","duration":"106.198577ms","start":"2026-07-16T06:51:53.669503Z","end":"2026-07-16T06:51:53.775702Z","steps":["trace[407569759] 'process raft request' (duration: 105.653668ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:51:53.776065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.971173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-07-16T06:51:53.776101Z","caller":"traceutil/trace.go:171","msg":"trace[815677922] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4650; }","duration":"102.071555ms","start":"2026-07-16T06:51:53.674022Z","end":"2026-07-16T06:51:53.776093Z","steps":["trace[815677922] 'agreement among raft nodes before linearized reading' (duration: 101.860762ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:51:59.053913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.577711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-07-16T06:51:59.053967Z","caller":"traceutil/trace.go:171","msg":"trace[1643469418] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4771; }","duration":"122.677162ms","start":"2026-07-16T06:51:58.931279Z","end":"2026-07-16T06:51:59.053956Z","steps":["trace[1643469418] 'range keys from in-memory index tree' (duration: 122.419868ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:51:59.05411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.759027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18c2b28c4b6e3cb5\" ","response":"range_response_count:1 size:1012"} {"level":"info","ts":"2026-07-16T06:51:59.054127Z","caller":"traceutil/trace.go:171","msg":"trace[1695248120] range","detail":"{range_begin:/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18c2b28c4b6e3cb5; range_end:; response_count:1; response_revision:4771; }","duration":"114.820488ms","start":"2026-07-16T06:51:58.9393Z","end":"2026-07-16T06:51:59.054121Z","steps":["trace[1695248120] 'range keys from in-memory index tree' (duration: 114.638675ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:51:59.266879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.720661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-07-16T06:51:59.266967Z","caller":"traceutil/trace.go:171","msg":"trace[702485187] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4773; }","duration":"112.834153ms","start":"2026-07-16T06:51:59.154115Z","end":"2026-07-16T06:51:59.266949Z","steps":["trace[702485187] 'range keys from in-memory index tree' (duration: 112.520508ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:52:00.009735Z","caller":"traceutil/trace.go:171","msg":"trace[2029788135] transaction","detail":"{read_only:false; response_revision:4785; number_of_response:1; }","duration":"169.0743ms","start":"2026-07-16T06:51:59.840632Z","end":"2026-07-16T06:52:00.009706Z","steps":["trace[2029788135] 'process raft request' (duration: 136.910553ms)","trace[2029788135] 'compare' (duration: 31.507126ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:52:00.009966Z","caller":"traceutil/trace.go:171","msg":"trace[2038050796] transaction","detail":"{read_only:false; response_revision:4786; number_of_response:1; }","duration":"159.392436ms","start":"2026-07-16T06:51:59.850563Z","end":"2026-07-16T06:52:00.009955Z","steps":["trace[2038050796] 'process raft request' (duration: 158.740906ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:52:11.701678Z","caller":"traceutil/trace.go:171","msg":"trace[1301382162] transaction","detail":"{read_only:false; response_revision:4953; number_of_response:1; }","duration":"151.235393ms","start":"2026-07-16T06:52:11.550384Z","end":"2026-07-16T06:52:11.701619Z","steps":["trace[1301382162] 'process raft request' (duration: 83.317416ms)","trace[1301382162] 'compare' (duration: 66.915971ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:52:48.150372Z","caller":"traceutil/trace.go:171","msg":"trace[510719610] transaction","detail":"{read_only:false; response_revision:5284; number_of_response:1; }","duration":"141.785991ms","start":"2026-07-16T06:52:48.008556Z","end":"2026-07-16T06:52:48.150342Z","steps":["trace[510719610] 'process raft request' (duration: 141.594228ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:52:48.156765Z","caller":"traceutil/trace.go:171","msg":"trace[136204885] transaction","detail":"{read_only:false; response_revision:5285; number_of_response:1; }","duration":"102.007913ms","start":"2026-07-16T06:52:48.054731Z","end":"2026-07-16T06:52:48.156739Z","steps":["trace[136204885] 'process raft request' (duration: 101.77541ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:53:19.162493Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2856} {"level":"info","ts":"2026-07-16T06:53:19.310332Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2856,"took":"145.586174ms","hash":3212822625,"current-db-size-bytes":52928512,"current-db-size":"53 MB","current-db-size-in-use-bytes":29671424,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-07-16T06:53:19.31041Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3212822625,"revision":2856,"compact-revision":-1} {"level":"info","ts":"2026-07-16T06:58:19.169318Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5529} {"level":"info","ts":"2026-07-16T06:58:19.244993Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5529,"took":"73.053875ms","hash":4138574151,"current-db-size-bytes":52928512,"current-db-size":"53 MB","current-db-size-in-use-bytes":18505728,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-16T06:58:19.245178Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4138574151,"revision":5529,"compact-revision":2856}