{"level":"warn","ts":"2026-07-27T19:59:50.913139Z","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-27T19:59:50.913244Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.90: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.90:2380","--initial-cluster=instance=https://199.19.213.90:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.90:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.90: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-27T19:59:50.913347Z","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-27T19:59:50.913366Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.90:2380"]} {"level":"info","ts":"2026-07-27T19:59:50.913386Z","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-27T19:59:50.915573Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.90:2379"]} {"level":"info","ts":"2026-07-27T19:59:50.915675Z","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.90:2380"],"listen-peer-urls":["https://199.19.213.90:2380"],"advertise-client-urls":["https://199.19.213.90:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.90:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.90: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-27T19:59:50.91934Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.375788ms"} {"level":"info","ts":"2026-07-27T19:59:50.933682Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2b21fdc9c735cc27","cluster-id":"77163f3b44f8f1db"} {"level":"info","ts":"2026-07-27T19:59:50.933775Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2b21fdc9c735cc27 switched to configuration voters=()"} {"level":"info","ts":"2026-07-27T19:59:50.933796Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2b21fdc9c735cc27 became follower at term 0"} {"level":"info","ts":"2026-07-27T19:59:50.933808Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2b21fdc9c735cc27 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-27T19:59:50.933819Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2b21fdc9c735cc27 became follower at term 1"} {"level":"info","ts":"2026-07-27T19:59:50.933855Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2b21fdc9c735cc27 switched to configuration voters=(3108044260934798375)"} {"level":"warn","ts":"2026-07-27T19:59:50.939576Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-27T19:59:50.941821Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-27T19:59:50.943007Z","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-27T19:59:50.945727Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2b21fdc9c735cc27","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-27T19:59:50.945892Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2b21fdc9c735cc27","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-27T19:59:50.946128Z","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-27T19:59:50.946187Z","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-27T19:59:50.946208Z","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-27T19:59:50.946836Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2b21fdc9c735cc27 switched to configuration voters=(3108044260934798375)"} {"level":"info","ts":"2026-07-27T19:59:50.948888Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"77163f3b44f8f1db","local-member-id":"2b21fdc9c735cc27","added-peer-id":"2b21fdc9c735cc27","added-peer-peer-urls":["https://199.19.213.90:2380"]} {"level":"info","ts":"2026-07-27T19:59:50.951342Z","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-27T19:59:50.951489Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.90:2380"} {"level":"info","ts":"2026-07-27T19:59:50.952305Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.90:2380"} {"level":"info","ts":"2026-07-27T19:59:50.952574Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2b21fdc9c735cc27","initial-advertise-peer-urls":["https://199.19.213.90:2380"],"listen-peer-urls":["https://199.19.213.90:2380"],"advertise-client-urls":["https://199.19.213.90:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.90:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-27T19:59:50.952647Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-27T19:59:51.134923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2b21fdc9c735cc27 is starting a new election at term 1"} {"level":"info","ts":"2026-07-27T19:59:51.13498Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2b21fdc9c735cc27 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-27T19:59:51.135009Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2b21fdc9c735cc27 received MsgPreVoteResp from 2b21fdc9c735cc27 at term 1"} {"level":"info","ts":"2026-07-27T19:59:51.135025Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2b21fdc9c735cc27 became candidate at term 2"} {"level":"info","ts":"2026-07-27T19:59:51.135035Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2b21fdc9c735cc27 received MsgVoteResp from 2b21fdc9c735cc27 at term 2"} {"level":"info","ts":"2026-07-27T19:59:51.13505Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2b21fdc9c735cc27 became leader at term 2"} {"level":"info","ts":"2026-07-27T19:59:51.135123Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2b21fdc9c735cc27 elected leader 2b21fdc9c735cc27 at term 2"} {"level":"info","ts":"2026-07-27T19:59:51.137233Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-27T19:59:51.138073Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2b21fdc9c735cc27","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.90:2379]}","request-path":"/0/members/2b21fdc9c735cc27/attributes","cluster-id":"77163f3b44f8f1db","publish-timeout":"7s"} {"level":"info","ts":"2026-07-27T19:59:51.138208Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-27T19:59:51.138313Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-27T19:59:51.138575Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-27T19:59:51.138592Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-27T19:59:51.13892Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"77163f3b44f8f1db","local-member-id":"2b21fdc9c735cc27","cluster-version":"3.5"} {"level":"info","ts":"2026-07-27T19:59:51.138995Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-27T19:59:51.139025Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-27T19:59:51.141619Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.90:2379"} {"level":"info","ts":"2026-07-27T19:59:51.142093Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-27T20:00:27.232758Z","caller":"traceutil/trace.go:171","msg":"trace[2022087451] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"503.541655ms","start":"2026-07-27T20:00:26.729193Z","end":"2026-07-27T20:00:27.232735Z","steps":["trace[2022087451] 'process raft request' (duration: 503.413721ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:27.234101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:00:26.729179Z","time spent":"503.698249ms","remote":"127.0.0.1:34026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-27T20:00:27.240462Z","caller":"traceutil/trace.go:171","msg":"trace[356908593] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"377.256096ms","start":"2026-07-27T20:00:26.86318Z","end":"2026-07-27T20:00:27.240436Z","steps":["trace[356908593] 'process raft request' (duration: 377.142183ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:00:27.24053Z","caller":"traceutil/trace.go:171","msg":"trace[1011207268] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"370.863629ms","start":"2026-07-27T20:00:26.86965Z","end":"2026-07-27T20:00:27.240513Z","steps":["trace[1011207268] 'process raft request' (duration: 370.742226ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:00:27.240592Z","caller":"traceutil/trace.go:171","msg":"trace[307030324] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"382.864521ms","start":"2026-07-27T20:00:26.857719Z","end":"2026-07-27T20:00:27.240583Z","steps":["trace[307030324] 'process raft request' (duration: 382.499961ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:27.240623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:00:26.857697Z","time spent":"382.913552ms","remote":"127.0.0.1:33854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-27T20:00:27.24065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:00:26.869638Z","time spent":"370.956721ms","remote":"127.0.0.1:33854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-27T20:00:27.240559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:00:26.863159Z","time spent":"377.360939ms","remote":"127.0.0.1:33854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-27T20:00:27.240672Z","caller":"traceutil/trace.go:171","msg":"trace[848828368] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"366.846179ms","start":"2026-07-27T20:00:26.873799Z","end":"2026-07-27T20:00:27.240646Z","steps":["trace[848828368] 'process raft request' (duration: 366.631873ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:00:27.240523Z","caller":"traceutil/trace.go:171","msg":"trace[1296044438] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"377.235465ms","start":"2026-07-27T20:00:26.863254Z","end":"2026-07-27T20:00:27.240489Z","steps":["trace[1296044438] 'process raft request' (duration: 377.103062ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:27.240768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:00:26.863248Z","time spent":"377.502212ms","remote":"127.0.0.1:33854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-27T20:00:27.240808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:00:26.873791Z","time spent":"366.953331ms","remote":"127.0.0.1:33854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-27T20:00:27.240913Z","caller":"traceutil/trace.go:171","msg":"trace[2083874310] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"365.969104ms","start":"2026-07-27T20:00:26.874919Z","end":"2026-07-27T20:00:27.240888Z","steps":["trace[2083874310] 'process raft request' (duration: 365.566713ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:27.241026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:00:26.8749Z","time spent":"366.069376ms","remote":"127.0.0.1:33854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-27T20:00:27.241361Z","caller":"traceutil/trace.go:171","msg":"trace[177462022] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"366.365175ms","start":"2026-07-27T20:00:26.874983Z","end":"2026-07-27T20:00:27.241348Z","steps":["trace[177462022] 'process raft request' (duration: 365.560643ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:27.241449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:00:26.874976Z","time spent":"366.450237ms","remote":"127.0.0.1:33854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-27T20:00:27.24155Z","caller":"traceutil/trace.go:171","msg":"trace[2123727669] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"365.258355ms","start":"2026-07-27T20:00:26.876268Z","end":"2026-07-27T20:00:27.241526Z","steps":["trace[2123727669] 'process raft request' (duration: 365.049139ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:27.24166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:00:26.876256Z","time spent":"365.365517ms","remote":"127.0.0.1:33854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-27T20:00:27.241661Z","caller":"traceutil/trace.go:171","msg":"trace[1906917659] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"347.473694ms","start":"2026-07-27T20:00:26.894164Z","end":"2026-07-27T20:00:27.241638Z","steps":["trace[1906917659] 'process raft request' (duration: 347.32074ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:27.241752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:00:26.894142Z","time spent":"347.569826ms","remote":"127.0.0.1:33854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-27T20:00:27.241769Z","caller":"traceutil/trace.go:171","msg":"trace[585299481] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"330.378131ms","start":"2026-07-27T20:00:26.911381Z","end":"2026-07-27T20:00:27.241759Z","steps":["trace[585299481] 'process raft request' (duration: 330.182376ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:27.241818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:00:26.911354Z","time spent":"330.442203ms","remote":"127.0.0.1:33854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-27T20:00:27.245759Z","caller":"traceutil/trace.go:171","msg":"trace[719103875] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"229.136708ms","start":"2026-07-27T20:00:27.016604Z","end":"2026-07-27T20:00:27.245741Z","steps":["trace[719103875] 'process raft request' (duration: 229.046125ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:00:27.245908Z","caller":"traceutil/trace.go:171","msg":"trace[292174141] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"314.861481ms","start":"2026-07-27T20:00:26.93104Z","end":"2026-07-27T20:00:27.245901Z","steps":["trace[292174141] 'process raft request' (duration: 310.700848ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:27.245971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:00:26.931014Z","time spent":"314.916283ms","remote":"127.0.0.1:33854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-27T20:00:27.71081Z","caller":"traceutil/trace.go:171","msg":"trace[1649936140] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"201.368977ms","start":"2026-07-27T20:00:27.509417Z","end":"2026-07-27T20:00:27.710786Z","steps":["trace[1649936140] 'process raft request' (duration: 201.276455ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:00:27.71087Z","caller":"traceutil/trace.go:171","msg":"trace[1802778289] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"201.409317ms","start":"2026-07-27T20:00:27.509425Z","end":"2026-07-27T20:00:27.710834Z","steps":["trace[1802778289] 'process raft request' (duration: 165.754711ms)","trace[1802778289] 'compare' (duration: 35.312847ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T20:00:27.750476Z","caller":"traceutil/trace.go:171","msg":"trace[6523104] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"150.594236ms","start":"2026-07-27T20:00:27.599805Z","end":"2026-07-27T20:00:27.750399Z","steps":["trace[6523104] 'process raft request' (duration: 150.315908ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:00:27.75062Z","caller":"traceutil/trace.go:171","msg":"trace[1602958388] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"237.703583ms","start":"2026-07-27T20:00:27.512881Z","end":"2026-07-27T20:00:27.750584Z","steps":["trace[1602958388] 'process raft request' (duration: 236.993793ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:00:33.309812Z","caller":"traceutil/trace.go:171","msg":"trace[1540028491] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"298.588985ms","start":"2026-07-27T20:00:33.011148Z","end":"2026-07-27T20:00:33.309737Z","steps":["trace[1540028491] 'process raft request' (duration: 294.57154ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:34.137022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.89767ms","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-07-27T20:00:34.137226Z","caller":"traceutil/trace.go:171","msg":"trace[240695242] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:584; }","duration":"562.167727ms","start":"2026-07-27T20:00:33.57503Z","end":"2026-07-27T20:00:34.137198Z","steps":["trace[240695242] 'range keys from in-memory index tree' (duration: 561.87471ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:34.137383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.742051ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-27T20:00:34.137563Z","caller":"traceutil/trace.go:171","msg":"trace[1775119887] linearizableReadLoop","detail":"{readStateIndex:616; appliedIndex:614; }","duration":"668.202492ms","start":"2026-07-27T20:00:33.469342Z","end":"2026-07-27T20:00:34.137544Z","steps":["trace[1775119887] 'read index received' (duration: 96.869605ms)","trace[1775119887] 'applied index is now lower than readState.Index' (duration: 571.331537ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T20:00:34.137637Z","caller":"traceutil/trace.go:171","msg":"trace[857383662] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"771.669691ms","start":"2026-07-27T20:00:33.365907Z","end":"2026-07-27T20:00:34.137577Z","steps":["trace[857383662] 'process raft request' (duration: 771.562208ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:34.137751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"668.399477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-27T20:00:34.137767Z","caller":"traceutil/trace.go:171","msg":"trace[1237071519] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"819.858292ms","start":"2026-07-27T20:00:33.317856Z","end":"2026-07-27T20:00:34.137714Z","steps":["trace[1237071519] 'process raft request' (duration: 248.411822ms)","trace[1237071519] 'compare' (duration: 570.565497ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T20:00:34.137802Z","caller":"traceutil/trace.go:171","msg":"trace[820593658] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:586; }","duration":"668.484179ms","start":"2026-07-27T20:00:33.469302Z","end":"2026-07-27T20:00:34.137786Z","steps":["trace[820593658] 'agreement among raft nodes before linearized reading' (duration: 668.364766ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:34.137852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:00:33.469283Z","time spent":"668.557212ms","remote":"127.0.0.1:33778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-27T20:00:34.137861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:00:33.365882Z","time spent":"771.894556ms","remote":"127.0.0.1:34106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-27T20:00:34.137902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:00:33.317837Z","time spent":"819.990085ms","remote":"127.0.0.1:34026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-27T20:00:34.209765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"737.151173ms","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-07-27T20:00:34.209872Z","caller":"traceutil/trace.go:171","msg":"trace[551939847] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:587; }","duration":"737.272316ms","start":"2026-07-27T20:00:33.472564Z","end":"2026-07-27T20:00:34.209836Z","steps":["trace[551939847] 'agreement among raft nodes before linearized reading' (duration: 737.072591ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:34.209927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:00:33.472552Z","time spent":"737.360848ms","remote":"127.0.0.1:34026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-27T20:00:34.210076Z","caller":"traceutil/trace.go:171","msg":"trace[306229618] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"279.441454ms","start":"2026-07-27T20:00:33.930589Z","end":"2026-07-27T20:00:34.21003Z","steps":["trace[306229618] 'process raft request' (duration: 278.849769ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:34.210161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.930443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-27T20:00:34.210312Z","caller":"traceutil/trace.go:171","msg":"trace[150509257] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:587; }","duration":"414.116528ms","start":"2026-07-27T20:00:33.796183Z","end":"2026-07-27T20:00:34.2103Z","steps":["trace[150509257] 'agreement among raft nodes before linearized reading' (duration: 413.903393ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:34.210346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:00:33.79616Z","time spent":"414.17599ms","remote":"127.0.0.1:34026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-27T20:00:35.122852Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14710902239544384330,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-27T20:00:35.624432Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14710902239544384330,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-27T20:00:35.772199Z","caller":"traceutil/trace.go:171","msg":"trace[617696360] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:623; }","duration":"1.149586361s","start":"2026-07-27T20:00:34.622586Z","end":"2026-07-27T20:00:35.772172Z","steps":["trace[617696360] 'read index received' (duration: 1.146084101s)","trace[617696360] 'applied index is now lower than readState.Index' (duration: 3.50137ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T20:00:35.772368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.149760276s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.90\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-07-27T20:00:35.772359Z","caller":"traceutil/trace.go:171","msg":"trace[481271472] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"1.157653991s","start":"2026-07-27T20:00:34.614673Z","end":"2026-07-27T20:00:35.772327Z","steps":["trace[481271472] 'process raft request' (duration: 1.155391113s)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:35.772436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.127438446s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-crzx6\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-07-27T20:00:35.772473Z","caller":"traceutil/trace.go:171","msg":"trace[1628028607] range","detail":"{range_begin:/registry/pods/kube-system/cilium-crzx6; range_end:; response_count:1; response_revision:594; }","duration":"1.127497658s","start":"2026-07-27T20:00:34.644964Z","end":"2026-07-27T20:00:35.772461Z","steps":["trace[1628028607] 'agreement among raft nodes before linearized reading' (duration: 1.127377385s)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:35.7725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:00:34.644952Z","time spent":"1.127541589s","remote":"127.0.0.1:33960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16983,"request content":"key:\"/registry/pods/kube-system/cilium-crzx6\" "} {"level":"info","ts":"2026-07-27T20:00:35.772398Z","caller":"traceutil/trace.go:171","msg":"trace[380422623] range","detail":"{range_begin:/registry/masterleases/199.19.213.90; range_end:; response_count:1; response_revision:594; }","duration":"1.149832178s","start":"2026-07-27T20:00:34.622555Z","end":"2026-07-27T20:00:35.772387Z","steps":["trace[380422623] 'agreement among raft nodes before linearized reading' (duration: 1.149757396s)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:35.772537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:00:34.622541Z","time spent":"1.149984071s","remote":"127.0.0.1:33824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":155,"request content":"key:\"/registry/masterleases/199.19.213.90\" "} {"level":"warn","ts":"2026-07-27T20:00:35.77254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:00:34.614645Z","time spent":"1.157792044s","remote":"127.0.0.1:33884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-27T20:00:35.772538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.592665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-27T20:00:35.772644Z","caller":"traceutil/trace.go:171","msg":"trace[1766463808] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:594; }","duration":"302.715268ms","start":"2026-07-27T20:00:35.469904Z","end":"2026-07-27T20:00:35.77262Z","steps":["trace[1766463808] 'agreement among raft nodes before linearized reading' (duration: 302.520843ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:35.772705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:00:35.469838Z","time spent":"302.854351ms","remote":"127.0.0.1:33778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-27T20:00:35.928917Z","caller":"traceutil/trace.go:171","msg":"trace[362361605] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"128.415902ms","start":"2026-07-27T20:00:35.800474Z","end":"2026-07-27T20:00:35.92889Z","steps":["trace[362361605] 'process raft request' (duration: 128.052523ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:00:38.868448Z","caller":"traceutil/trace.go:171","msg":"trace[867471038] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"492.47883ms","start":"2026-07-27T20:00:38.375945Z","end":"2026-07-27T20:00:38.868424Z","steps":["trace[867471038] 'process raft request' (duration: 492.327816ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:38.868604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:00:38.375936Z","time spent":"492.589672ms","remote":"127.0.0.1:33854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9305,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-27T20:00:38.873739Z","caller":"traceutil/trace.go:171","msg":"trace[1171867536] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"114.228423ms","start":"2026-07-27T20:00:38.759493Z","end":"2026-07-27T20:00:38.873722Z","steps":["trace[1171867536] 'process raft request' (duration: 114.198493ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:00:38.873872Z","caller":"traceutil/trace.go:171","msg":"trace[209477643] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"314.101878ms","start":"2026-07-27T20:00:38.559759Z","end":"2026-07-27T20:00:38.873861Z","steps":["trace[209477643] 'process raft request' (duration: 313.830861ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:38.873928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:00:38.559727Z","time spent":"314.15774ms","remote":"127.0.0.1:33854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-27T20:00:39.259528Z","caller":"traceutil/trace.go:171","msg":"trace[1087795924] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"296.454506ms","start":"2026-07-27T20:00:38.963054Z","end":"2026-07-27T20:00:39.259509Z","steps":["trace[1087795924] 'process raft request' (duration: 296.21555ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:39.857895Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14710902239544384434,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-27T20:00:39.949539Z","caller":"traceutil/trace.go:171","msg":"trace[1368007033] linearizableReadLoop","detail":"{readStateIndex:692; appliedIndex:691; }","duration":"592.565651ms","start":"2026-07-27T20:00:39.356949Z","end":"2026-07-27T20:00:39.949514Z","steps":["trace[1368007033] 'read index received' (duration: 591.857143ms)","trace[1368007033] 'applied index is now lower than readState.Index' (duration: 707.648µs)"],"step_count":2} {"level":"warn","ts":"2026-07-27T20:00:39.949865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.895039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-27T20:00:39.949926Z","caller":"traceutil/trace.go:171","msg":"trace[1994910716] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:661; }","duration":"593.009402ms","start":"2026-07-27T20:00:39.356899Z","end":"2026-07-27T20:00:39.949909Z","steps":["trace[1994910716] 'agreement among raft nodes before linearized reading' (duration: 592.902519ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:39.949942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.116724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-07-27T20:00:39.949973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:00:39.356884Z","time spent":"593.070893ms","remote":"127.0.0.1:33854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" "} {"level":"info","ts":"2026-07-27T20:00:39.949978Z","caller":"traceutil/trace.go:171","msg":"trace[1604480506] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:661; }","duration":"585.179395ms","start":"2026-07-27T20:00:39.364788Z","end":"2026-07-27T20:00:39.949968Z","steps":["trace[1604480506] 'agreement among raft nodes before linearized reading' (duration: 585.047792ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:39.950015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:00:39.364781Z","time spent":"585.224406ms","remote":"127.0.0.1:34026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-27T20:00:39.950365Z","caller":"traceutil/trace.go:171","msg":"trace[160933623] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"679.378066ms","start":"2026-07-27T20:00:39.270965Z","end":"2026-07-27T20:00:39.950343Z","steps":["trace[160933623] 'process raft request' (duration: 677.877848ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:39.950518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:00:39.270943Z","time spent":"679.491329ms","remote":"127.0.0.1:33854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":24220,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-27T20:00:52.971715Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14710902239544384658,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-27T20:00:53.081961Z","caller":"traceutil/trace.go:171","msg":"trace[163225637] linearizableReadLoop","detail":"{readStateIndex:801; appliedIndex:800; }","duration":"610.486058ms","start":"2026-07-27T20:00:52.471453Z","end":"2026-07-27T20:00:53.081939Z","steps":["trace[163225637] 'read index received' (duration: 610.326935ms)","trace[163225637] 'applied index is now lower than readState.Index' (duration: 158.273µs)"],"step_count":2} {"level":"warn","ts":"2026-07-27T20:00:53.082094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.617811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-27T20:00:53.082146Z","caller":"traceutil/trace.go:171","msg":"trace[63135283] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:766; }","duration":"610.729864ms","start":"2026-07-27T20:00:52.471406Z","end":"2026-07-27T20:00:53.082136Z","steps":["trace[63135283] 'agreement among raft nodes before linearized reading' (duration: 610.629611ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:53.082186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:00:52.471387Z","time spent":"610.787125ms","remote":"127.0.0.1:33778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-27T20:00:53.082215Z","caller":"traceutil/trace.go:171","msg":"trace[1317528471] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"649.067335ms","start":"2026-07-27T20:00:52.433086Z","end":"2026-07-27T20:00:53.082153Z","steps":["trace[1317528471] 'process raft request' (duration: 648.703527ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:53.082546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:00:52.433058Z","time spent":"649.279209ms","remote":"127.0.0.1:34026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-27T20:00:53.252902Z","caller":"traceutil/trace.go:171","msg":"trace[1574455562] linearizableReadLoop","detail":"{readStateIndex:802; appliedIndex:801; }","duration":"169.618384ms","start":"2026-07-27T20:00:53.083258Z","end":"2026-07-27T20:00:53.252876Z","steps":["trace[1574455562] 'read index received' (duration: 169.42488ms)","trace[1574455562] 'applied index is now lower than readState.Index' (duration: 192.414µs)"],"step_count":2} {"level":"info","ts":"2026-07-27T20:00:53.253107Z","caller":"traceutil/trace.go:171","msg":"trace[242551665] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"197.46957ms","start":"2026-07-27T20:00:53.055627Z","end":"2026-07-27T20:00:53.253096Z","steps":["trace[242551665] 'process raft request' (duration: 197.106882ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:53.253636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.33024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-27T20:00:53.253706Z","caller":"traceutil/trace.go:171","msg":"trace[754758584] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:767; }","duration":"170.456713ms","start":"2026-07-27T20:00:53.083232Z","end":"2026-07-27T20:00:53.253689Z","steps":["trace[754758584] 'agreement among raft nodes before linearized reading' (duration: 170.33131ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:01:42.729585Z","caller":"traceutil/trace.go:171","msg":"trace[1833421358] transaction","detail":"{read_only:false; response_revision:1062; number_of_response:1; }","duration":"183.812407ms","start":"2026-07-27T20:01:42.54575Z","end":"2026-07-27T20:01:42.729562Z","steps":["trace[1833421358] 'process raft request' (duration: 169.705473ms)","trace[1833421358] 'compare' (duration: 13.384171ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T20:02:27.494884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.410561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-27T20:02:27.494974Z","caller":"traceutil/trace.go:171","msg":"trace[1679833924] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1207; }","duration":"572.550533ms","start":"2026-07-27T20:02:26.922403Z","end":"2026-07-27T20:02:27.494953Z","steps":["trace[1679833924] 'range keys from in-memory index tree' (duration: 572.241748ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:02:27.495318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:02:26.922381Z","time spent":"572.924369ms","remote":"127.0.0.1:34026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-27T20:02:29.208581Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14710902239544385728,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-27T20:02:31.466889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00014806s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-27T20:02:31.466983Z","caller":"traceutil/trace.go:171","msg":"trace[433686294] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000309033s","start":"2026-07-27T20:02:29.466655Z","end":"2026-07-27T20:02:31.466964Z","steps":["trace[433686294] 'agreement among raft nodes before linearized reading' (duration: 2.000170081s)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:02:31.467037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:02:29.466642Z","time spent":"2.000385294s","remote":"127.0.0.1:33778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-27T20:02:31.517309Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14710902239544385728,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-27T20:02:31.987233Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.419476325s","expected-duration":"1s"} {"level":"info","ts":"2026-07-27T20:02:31.987641Z","caller":"traceutil/trace.go:171","msg":"trace[241631693] transaction","detail":"{read_only:false; response_revision:1210; number_of_response:1; }","duration":"3.419917332s","start":"2026-07-27T20:02:28.567692Z","end":"2026-07-27T20:02:31.987609Z","steps":["trace[241631693] 'process raft request' (duration: 3.419753889s)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:02:31.987793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:02:28.567681Z","time spent":"3.420029413s","remote":"127.0.0.1:34026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-27T20:02:31.99232Z","caller":"traceutil/trace.go:171","msg":"trace[595066588] transaction","detail":"{read_only:false; response_revision:1211; number_of_response:1; }","duration":"3.288797583s","start":"2026-07-27T20:02:28.703479Z","end":"2026-07-27T20:02:31.992276Z","steps":["trace[595066588] 'process raft request' (duration: 3.288533209s)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:02:31.992334Z","caller":"traceutil/trace.go:171","msg":"trace[239050713] transaction","detail":"{read_only:false; response_revision:1212; number_of_response:1; }","duration":"2.255046748s","start":"2026-07-27T20:02:29.737266Z","end":"2026-07-27T20:02:31.992313Z","steps":["trace[239050713] 'process raft request' (duration: 2.254884515s)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:02:31.992459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:02:28.70346Z","time spent":"3.288930486s","remote":"127.0.0.1:34026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-27T20:02:31.992495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:02:29.737249Z","time spent":"2.255158659s","remote":"127.0.0.1:34026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-27T20:02:31.993329Z","caller":"traceutil/trace.go:171","msg":"trace[1341488184] linearizableReadLoop","detail":"{readStateIndex:1270; appliedIndex:1266; }","duration":"3.285089865s","start":"2026-07-27T20:02:28.708219Z","end":"2026-07-27T20:02:31.993309Z","steps":["trace[1341488184] 'read index received' (duration: 3.279234752s)","trace[1341488184] 'applied index is now lower than readState.Index' (duration: 5.853993ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T20:02:31.993656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.225170886s","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-07-27T20:02:31.993707Z","caller":"traceutil/trace.go:171","msg":"trace[1421863694] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1212; }","duration":"3.225222757s","start":"2026-07-27T20:02:28.768471Z","end":"2026-07-27T20:02:31.993694Z","steps":["trace[1421863694] 'agreement among raft nodes before linearized reading' (duration: 3.225050244s)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:02:31.993741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:02:28.768432Z","time spent":"3.225301437s","remote":"127.0.0.1:34026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-27T20:02:31.993772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.941824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-27T20:02:31.993835Z","caller":"traceutil/trace.go:171","msg":"trace[718432623] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1212; }","duration":"526.031965ms","start":"2026-07-27T20:02:31.467785Z","end":"2026-07-27T20:02:31.993817Z","steps":["trace[718432623] 'agreement among raft nodes before linearized reading' (duration: 525.921583ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:02:31.993867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.479895433s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-07-27T20:02:31.993875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:02:31.467767Z","time spent":"526.098566ms","remote":"127.0.0.1:33794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-27T20:02:31.993878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.285650163s","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-27T20:02:31.993895Z","caller":"traceutil/trace.go:171","msg":"trace[48615173] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1212; }","duration":"2.479930874s","start":"2026-07-27T20:02:29.513956Z","end":"2026-07-27T20:02:31.993887Z","steps":["trace[48615173] 'agreement among raft nodes before linearized reading' (duration: 2.479857543s)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:02:31.993925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:02:29.513948Z","time spent":"2.479971164s","remote":"127.0.0.1:34026","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":"info","ts":"2026-07-27T20:02:31.993927Z","caller":"traceutil/trace.go:171","msg":"trace[692452459] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1212; }","duration":"3.285719915s","start":"2026-07-27T20:02:28.708194Z","end":"2026-07-27T20:02:31.993914Z","steps":["trace[692452459] 'agreement among raft nodes before linearized reading' (duration: 3.285562033s)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:02:31.993991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:02:28.708184Z","time spent":"3.285799856s","remote":"127.0.0.1:34026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-27T20:02:31.993935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.4911046s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-27T20:02:31.994238Z","caller":"traceutil/trace.go:171","msg":"trace[172960917] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1212; }","duration":"2.491435205s","start":"2026-07-27T20:02:29.502793Z","end":"2026-07-27T20:02:31.994229Z","steps":["trace[172960917] 'agreement among raft nodes before linearized reading' (duration: 2.491048229s)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:02:31.994318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:02:29.502781Z","time spent":"2.491527347s","remote":"127.0.0.1:34026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}