{"level":"warn","ts":"2026-05-01T00:56:32.733064Z","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-01T00:56:32.73316Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.157: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.157:2380","--initial-cluster=instance=https://199.204.45.157:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.157:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.157: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-01T00:56:32.73324Z","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-01T00:56:32.733251Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.157:2380"]} {"level":"info","ts":"2026-05-01T00:56:32.73328Z","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-01T00:56:32.734119Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"]} {"level":"info","ts":"2026-05-01T00:56:32.734221Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.157:2380"],"listen-peer-urls":["https://199.204.45.157:2380"],"advertise-client-urls":["https://199.204.45.157:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.157: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-01T00:56:32.738307Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.849717ms"} {"level":"info","ts":"2026-05-01T00:56:32.74878Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5f170c75a1d97cc","cluster-id":"44a3176ec85feb9"} {"level":"info","ts":"2026-05-01T00:56:32.748912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=()"} {"level":"info","ts":"2026-05-01T00:56:32.74897Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became follower at term 0"} {"level":"info","ts":"2026-05-01T00:56:32.749018Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5f170c75a1d97cc [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-01T00:56:32.749065Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became follower at term 1"} {"level":"info","ts":"2026-05-01T00:56:32.749136Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=(428247441089599436)"} {"level":"warn","ts":"2026-05-01T00:56:32.760799Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-01T00:56:32.762061Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-01T00:56:32.76709Z","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-01T00:56:32.769437Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5f170c75a1d97cc","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-01T00:56:32.769571Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5f170c75a1d97cc","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-01T00:56:32.769755Z","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-01T00:56:32.769888Z","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-01T00:56:32.769911Z","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-01T00:56:32.77098Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=(428247441089599436)"} {"level":"info","ts":"2026-05-01T00:56:32.771188Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"44a3176ec85feb9","local-member-id":"5f170c75a1d97cc","added-peer-id":"5f170c75a1d97cc","added-peer-peer-urls":["https://199.204.45.157:2380"]} {"level":"info","ts":"2026-05-01T00:56:32.777974Z","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-01T00:56:32.778115Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.157:2380"} {"level":"info","ts":"2026-05-01T00:56:32.778163Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.157:2380"} {"level":"info","ts":"2026-05-01T00:56:32.778372Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5f170c75a1d97cc","initial-advertise-peer-urls":["https://199.204.45.157:2380"],"listen-peer-urls":["https://199.204.45.157:2380"],"advertise-client-urls":["https://199.204.45.157:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-01T00:56:32.77841Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-01T00:56:33.749724Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc is starting a new election at term 1"} {"level":"info","ts":"2026-05-01T00:56:33.749787Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became pre-candidate at term 1"} {"level":"info","ts":"2026-05-01T00:56:33.74982Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc received MsgPreVoteResp from 5f170c75a1d97cc at term 1"} {"level":"info","ts":"2026-05-01T00:56:33.749845Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became candidate at term 2"} {"level":"info","ts":"2026-05-01T00:56:33.749861Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc received MsgVoteResp from 5f170c75a1d97cc at term 2"} {"level":"info","ts":"2026-05-01T00:56:33.749877Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became leader at term 2"} {"level":"info","ts":"2026-05-01T00:56:33.749896Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5f170c75a1d97cc elected leader 5f170c75a1d97cc at term 2"} {"level":"info","ts":"2026-05-01T00:56:33.750795Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-01T00:56:33.751507Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-01T00:56:33.751545Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-01T00:56:33.751516Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5f170c75a1d97cc","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.157:2379]}","request-path":"/0/members/5f170c75a1d97cc/attributes","cluster-id":"44a3176ec85feb9","publish-timeout":"7s"} {"level":"info","ts":"2026-05-01T00:56:33.751876Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-01T00:56:33.751916Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-01T00:56:33.752616Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"44a3176ec85feb9","local-member-id":"5f170c75a1d97cc","cluster-version":"3.5"} {"level":"info","ts":"2026-05-01T00:56:33.752688Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-01T00:56:33.752711Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-01T00:56:33.754429Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-01T00:56:33.75505Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.157:2379"} {"level":"warn","ts":"2026-05-01T00:56:39.097407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.310894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-05-01T00:56:39.097519Z","caller":"traceutil/trace.go:171","msg":"trace[1363685799] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:296; }","duration":"335.503718ms","start":"2026-05-01T00:56:38.761995Z","end":"2026-05-01T00:56:39.097499Z","steps":["trace[1363685799] 'range keys from in-memory index tree' (duration: 335.191802ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T00:56:39.097569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T00:56:38.761982Z","time spent":"335.57747ms","remote":"127.0.0.1:42858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":238,"request content":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" "} {"level":"warn","ts":"2026-05-01T00:56:39.097917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.676469ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-01T00:56:39.098022Z","caller":"traceutil/trace.go:171","msg":"trace[785980141] linearizableReadLoop","detail":"{readStateIndex:304; appliedIndex:303; }","duration":"142.792338ms","start":"2026-05-01T00:56:38.955214Z","end":"2026-05-01T00:56:39.098006Z","steps":["trace[785980141] 'read index received' (duration: 57.321µs)","trace[785980141] 'applied index is now lower than readState.Index' (duration: 142.733887ms)"],"step_count":2} {"level":"warn","ts":"2026-05-01T00:56:39.098144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.930841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-01T00:56:39.09808Z","caller":"traceutil/trace.go:171","msg":"trace[1311251815] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"222.603161ms","start":"2026-05-01T00:56:38.875409Z","end":"2026-05-01T00:56:39.098012Z","steps":["trace[1311251815] 'process raft request' (duration: 38.321579ms)","trace[1311251815] 'compare' (duration: 183.561137ms)"],"step_count":2} {"level":"info","ts":"2026-05-01T00:56:39.098182Z","caller":"traceutil/trace.go:171","msg":"trace[1631793877] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:297; }","duration":"143.020072ms","start":"2026-05-01T00:56:38.955151Z","end":"2026-05-01T00:56:39.098172Z","steps":["trace[1631793877] 'agreement among raft nodes before linearized reading' (duration: 142.938591ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T00:56:39.323066Z","caller":"traceutil/trace.go:171","msg":"trace[253186726] linearizableReadLoop","detail":"{readStateIndex:307; appliedIndex:304; }","duration":"219.202792ms","start":"2026-05-01T00:56:39.103836Z","end":"2026-05-01T00:56:39.323039Z","steps":["trace[253186726] 'read index received' (duration: 6.725045ms)","trace[253186726] 'applied index is now lower than readState.Index' (duration: 212.476627ms)"],"step_count":2} {"level":"info","ts":"2026-05-01T00:56:39.323206Z","caller":"traceutil/trace.go:171","msg":"trace[1870814128] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"220.335916ms","start":"2026-05-01T00:56:39.102846Z","end":"2026-05-01T00:56:39.323182Z","steps":["trace[1870814128] 'process raft request' (duration: 143.243498ms)","trace[1870814128] 'compare' (duration: 76.72067ms)"],"step_count":2} {"level":"warn","ts":"2026-05-01T00:56:39.323247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.391227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-05-01T00:56:39.323297Z","caller":"traceutil/trace.go:171","msg":"trace[440909069] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:300; }","duration":"219.501129ms","start":"2026-05-01T00:56:39.10378Z","end":"2026-05-01T00:56:39.323281Z","steps":["trace[440909069] 'agreement among raft nodes before linearized reading' (duration: 219.399887ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T00:56:39.32337Z","caller":"traceutil/trace.go:171","msg":"trace[1599077226] transaction","detail":"{read_only:false; response_revision:300; number_of_response:1; }","duration":"220.199814ms","start":"2026-05-01T00:56:39.102926Z","end":"2026-05-01T00:56:39.323126Z","steps":["trace[1599077226] 'process raft request' (duration: 220.0451ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T00:56:39.324258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.754684ms","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-01T00:56:39.324375Z","caller":"traceutil/trace.go:171","msg":"trace[891131866] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:301; }","duration":"211.893386ms","start":"2026-05-01T00:56:39.112466Z","end":"2026-05-01T00:56:39.32436Z","steps":["trace[891131866] 'agreement among raft nodes before linearized reading' (duration: 211.631061ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T00:56:39.324372Z","caller":"traceutil/trace.go:171","msg":"trace[248201446] transaction","detail":"{read_only:false; response_revision:301; number_of_response:1; }","duration":"210.707992ms","start":"2026-05-01T00:56:39.113632Z","end":"2026-05-01T00:56:39.32434Z","steps":["trace[248201446] 'process raft request' (duration: 210.364895ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T00:57:01.635142Z","caller":"traceutil/trace.go:171","msg":"trace[355855806] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"134.705391ms","start":"2026-05-01T00:57:01.50042Z","end":"2026-05-01T00:57:01.635125Z","steps":["trace[355855806] 'process raft request' (duration: 134.001768ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T00:57:01.635237Z","caller":"traceutil/trace.go:171","msg":"trace[368294829] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"120.8237ms","start":"2026-05-01T00:57:01.514405Z","end":"2026-05-01T00:57:01.635229Z","steps":["trace[368294829] 'process raft request' (duration: 120.300221ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T00:57:01.635304Z","caller":"traceutil/trace.go:171","msg":"trace[1571817812] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"126.190976ms","start":"2026-05-01T00:57:01.509108Z","end":"2026-05-01T00:57:01.635299Z","steps":["trace[1571817812] 'process raft request' (duration: 125.424641ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T00:57:01.635389Z","caller":"traceutil/trace.go:171","msg":"trace[301182124] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"126.224956ms","start":"2026-05-01T00:57:01.50916Z","end":"2026-05-01T00:57:01.635385Z","steps":["trace[301182124] 'process raft request' (duration: 125.404261ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T00:57:01.635429Z","caller":"traceutil/trace.go:171","msg":"trace[258101512] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"122.741777ms","start":"2026-05-01T00:57:01.512682Z","end":"2026-05-01T00:57:01.635424Z","steps":["trace[258101512] 'process raft request' (duration: 121.902351ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T00:57:01.63542Z","caller":"traceutil/trace.go:171","msg":"trace[1883712438] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"109.182743ms","start":"2026-05-01T00:57:01.526207Z","end":"2026-05-01T00:57:01.63539Z","steps":["trace[1883712438] 'process raft request' (duration: 108.602263ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T00:57:01.635593Z","caller":"traceutil/trace.go:171","msg":"trace[964278090] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"115.090308ms","start":"2026-05-01T00:57:01.520497Z","end":"2026-05-01T00:57:01.635587Z","steps":["trace[964278090] 'process raft request' (duration: 114.275333ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T00:57:01.635466Z","caller":"traceutil/trace.go:171","msg":"trace[869864131] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"122.202977ms","start":"2026-05-01T00:57:01.513259Z","end":"2026-05-01T00:57:01.635462Z","steps":["trace[869864131] 'process raft request' (duration: 121.360931ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T00:57:01.635984Z","caller":"traceutil/trace.go:171","msg":"trace[1162013152] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"121.015914ms","start":"2026-05-01T00:57:01.514958Z","end":"2026-05-01T00:57:01.635974Z","steps":["trace[1162013152] 'process raft request' (duration: 119.77215ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T00:57:07.395747Z","caller":"traceutil/trace.go:171","msg":"trace[1265249572] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"149.067742ms","start":"2026-05-01T00:57:07.246654Z","end":"2026-05-01T00:57:07.395722Z","steps":["trace[1265249572] 'process raft request' (duration: 147.717296ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T00:57:07.918294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.623064ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-01T00:57:07.918411Z","caller":"traceutil/trace.go:171","msg":"trace[1607519950] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:636; }","duration":"436.188872ms","start":"2026-05-01T00:57:07.482204Z","end":"2026-05-01T00:57:07.918392Z","steps":["trace[1607519950] 'read index received' (duration: 88.288395ms)","trace[1607519950] 'applied index is now lower than readState.Index' (duration: 347.899047ms)"],"step_count":2} {"level":"warn","ts":"2026-05-01T00:57:07.918533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.328524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-01T00:57:07.918575Z","caller":"traceutil/trace.go:171","msg":"trace[1116257537] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:616; }","duration":"436.386745ms","start":"2026-05-01T00:57:07.482173Z","end":"2026-05-01T00:57:07.91856Z","steps":["trace[1116257537] 'agreement among raft nodes before linearized reading' (duration: 436.323664ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T00:57:07.918608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.876347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-nn7tk\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-05-01T00:57:07.918614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T00:57:07.482165Z","time spent":"436.439166ms","remote":"127.0.0.1:42896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-05-01T00:57:07.918618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.597624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-01T00:57:07.918659Z","caller":"traceutil/trace.go:171","msg":"trace[1256760067] range","detail":"{range_begin:/registry/pods/kube-system/cilium-nn7tk; range_end:; response_count:1; response_revision:616; }","duration":"386.960569ms","start":"2026-05-01T00:57:07.531683Z","end":"2026-05-01T00:57:07.918643Z","steps":["trace[1256760067] 'agreement among raft nodes before linearized reading' (duration: 386.855227ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T00:57:07.918672Z","caller":"traceutil/trace.go:171","msg":"trace[79470869] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:616; }","duration":"168.686886ms","start":"2026-05-01T00:57:07.749969Z","end":"2026-05-01T00:57:07.918655Z","steps":["trace[79470869] 'agreement among raft nodes before linearized reading' (duration: 168.592884ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T00:57:07.918696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T00:57:07.531672Z","time spent":"387.01633ms","remote":"127.0.0.1:42846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-nn7tk\" "} {"level":"info","ts":"2026-05-01T00:57:07.918464Z","caller":"traceutil/trace.go:171","msg":"trace[1919003482] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"443.142657ms","start":"2026-05-01T00:57:07.475267Z","end":"2026-05-01T00:57:07.918409Z","steps":["trace[1919003482] 'process raft request' (duration: 146.126755ms)","trace[1919003482] 'compare' (duration: 296.44803ms)"],"step_count":2} {"level":"warn","ts":"2026-05-01T00:57:07.919156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T00:57:07.475244Z","time spent":"443.847771ms","remote":"127.0.0.1:42928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-01T00:57:08.084975Z","caller":"traceutil/trace.go:171","msg":"trace[1799714228] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"151.367798ms","start":"2026-05-01T00:57:07.933589Z","end":"2026-05-01T00:57:08.084957Z","steps":["trace[1799714228] 'process raft request' (duration: 151.274826ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T00:57:22.813597Z","caller":"traceutil/trace.go:171","msg":"trace[2121276828] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"180.135829ms","start":"2026-05-01T00:57:22.633428Z","end":"2026-05-01T00:57:22.813564Z","steps":["trace[2121276828] 'process raft request' (duration: 179.935295ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T00:57:22.958186Z","caller":"traceutil/trace.go:171","msg":"trace[1545566881] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"141.235368ms","start":"2026-05-01T00:57:22.816912Z","end":"2026-05-01T00:57:22.958147Z","steps":["trace[1545566881] 'process raft request' (duration: 141.049985ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T00:57:57.53915Z","caller":"traceutil/trace.go:171","msg":"trace[1409424139] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"302.066781ms","start":"2026-05-01T00:57:57.237022Z","end":"2026-05-01T00:57:57.539089Z","steps":["trace[1409424139] 'process raft request' (duration: 301.471239ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T00:57:57.53934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T00:57:57.236996Z","time spent":"302.241164ms","remote":"127.0.0.1:42928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-01T00:58:22.186316Z","caller":"traceutil/trace.go:171","msg":"trace[662626580] transaction","detail":"{read_only:false; response_revision:1071; number_of_response:1; }","duration":"171.156858ms","start":"2026-05-01T00:58:22.015138Z","end":"2026-05-01T00:58:22.186295Z","steps":["trace[662626580] 'process raft request' (duration: 171.020675ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T00:58:52.226544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.741608ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-01T00:58:53.58966Z","caller":"traceutil/trace.go:171","msg":"trace[821161279] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"129.927584ms","start":"2026-05-01T00:58:53.459688Z","end":"2026-05-01T00:58:53.589616Z","steps":["trace[821161279] 'process raft request' (duration: 129.736951ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T00:59:06.627402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.07862ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-01T00:59:06.627515Z","caller":"traceutil/trace.go:171","msg":"trace[1086662856] linearizableReadLoop","detail":"{readStateIndex:1392; appliedIndex:1391; }","duration":"106.160243ms","start":"2026-05-01T00:59:06.521338Z","end":"2026-05-01T00:59:06.627498Z","steps":["trace[1086662856] 'read index received' (duration: 49.961µs)","trace[1086662856] 'applied index is now lower than readState.Index' (duration: 106.109312ms)"],"step_count":2} {"level":"warn","ts":"2026-05-01T00:59:06.627698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.358337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.157\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-01T00:59:06.627728Z","caller":"traceutil/trace.go:171","msg":"trace[268344747] range","detail":"{range_begin:/registry/masterleases/199.204.45.157; range_end:; response_count:1; response_revision:1341; }","duration":"106.419438ms","start":"2026-05-01T00:59:06.521298Z","end":"2026-05-01T00:59:06.627717Z","steps":["trace[268344747] 'agreement among raft nodes before linearized reading' (duration: 106.294626ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T00:59:06.627884Z","caller":"traceutil/trace.go:171","msg":"trace[842545528] transaction","detail":"{read_only:false; response_revision:1341; number_of_response:1; }","duration":"127.106638ms","start":"2026-05-01T00:59:06.500459Z","end":"2026-05-01T00:59:06.627566Z","steps":["trace[842545528] 'compare' (duration: 122.765773ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T00:59:06.864592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.064733ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"info","ts":"2026-05-01T00:59:06.8649Z","caller":"traceutil/trace.go:171","msg":"trace[1793266726] transaction","detail":"{read_only:false; response_revision:1342; number_of_response:1; }","duration":"233.542106ms","start":"2026-05-01T00:59:06.63132Z","end":"2026-05-01T00:59:06.864862Z","steps":["trace[1793266726] 'process raft request' (duration: 233.393463ms)"],"step_count":1}