{"level":"warn","ts":"2026-07-17T11:57:34.001444Z","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-17T11:57:34.001569Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.216: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.216:2380","--initial-cluster=instance=https://199.19.213.216:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.216:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.216: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-17T11:57:34.001673Z","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-17T11:57:34.001688Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.216:2380"]} {"level":"info","ts":"2026-07-17T11:57:34.001719Z","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-17T11:57:34.002712Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.216:2379"]} {"level":"info","ts":"2026-07-17T11:57:34.002815Z","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.216:2380"],"listen-peer-urls":["https://199.19.213.216:2380"],"advertise-client-urls":["https://199.19.213.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.216: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-17T11:57:34.006961Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.67967ms"} {"level":"info","ts":"2026-07-17T11:57:34.015341Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"58fa9386873601ed","cluster-id":"b3ae27d84cfabdf7"} {"level":"info","ts":"2026-07-17T11:57:34.015433Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed switched to configuration voters=()"} {"level":"info","ts":"2026-07-17T11:57:34.015452Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed became follower at term 0"} {"level":"info","ts":"2026-07-17T11:57:34.015477Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 58fa9386873601ed [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-17T11:57:34.015487Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed became follower at term 1"} {"level":"info","ts":"2026-07-17T11:57:34.015571Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed switched to configuration voters=(6411599225518686701)"} {"level":"warn","ts":"2026-07-17T11:57:34.02356Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-17T11:57:34.024851Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-17T11:57:34.025688Z","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-17T11:57:34.027808Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"58fa9386873601ed","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-17T11:57:34.028263Z","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-17T11:57:34.028402Z","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-17T11:57:34.028425Z","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-17T11:57:34.028933Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"58fa9386873601ed","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-17T11:57:34.030767Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed switched to configuration voters=(6411599225518686701)"} {"level":"info","ts":"2026-07-17T11:57:34.031002Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b3ae27d84cfabdf7","local-member-id":"58fa9386873601ed","added-peer-id":"58fa9386873601ed","added-peer-peer-urls":["https://199.19.213.216:2380"]} {"level":"info","ts":"2026-07-17T11:57:34.032779Z","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-17T11:57:34.033024Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"58fa9386873601ed","initial-advertise-peer-urls":["https://199.19.213.216:2380"],"listen-peer-urls":["https://199.19.213.216:2380"],"advertise-client-urls":["https://199.19.213.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-17T11:57:34.033058Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-17T11:57:34.033137Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.216:2380"} {"level":"info","ts":"2026-07-17T11:57:34.03315Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.216:2380"} {"level":"info","ts":"2026-07-17T11:57:34.215968Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed is starting a new election at term 1"} {"level":"info","ts":"2026-07-17T11:57:34.216076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed became pre-candidate at term 1"} {"level":"info","ts":"2026-07-17T11:57:34.21612Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed received MsgPreVoteResp from 58fa9386873601ed at term 1"} {"level":"info","ts":"2026-07-17T11:57:34.216153Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed became candidate at term 2"} {"level":"info","ts":"2026-07-17T11:57:34.216171Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed received MsgVoteResp from 58fa9386873601ed at term 2"} {"level":"info","ts":"2026-07-17T11:57:34.216194Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed became leader at term 2"} {"level":"info","ts":"2026-07-17T11:57:34.216216Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 58fa9386873601ed elected leader 58fa9386873601ed at term 2"} {"level":"info","ts":"2026-07-17T11:57:34.217267Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"58fa9386873601ed","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.216:2379]}","request-path":"/0/members/58fa9386873601ed/attributes","cluster-id":"b3ae27d84cfabdf7","publish-timeout":"7s"} {"level":"info","ts":"2026-07-17T11:57:34.217396Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-17T11:57:34.217567Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-17T11:57:34.217656Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-17T11:57:34.218551Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b3ae27d84cfabdf7","local-member-id":"58fa9386873601ed","cluster-version":"3.5"} {"level":"info","ts":"2026-07-17T11:57:34.218826Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-17T11:57:34.218888Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-17T11:57:34.22161Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-17T11:57:34.221803Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-17T11:57:34.221831Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-17T11:57:34.22224Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.216:2379"} {"level":"warn","ts":"2026-07-17T11:57:40.210288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.93126ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-17T11:57:40.210811Z","caller":"traceutil/trace.go:171","msg":"trace[743570717] transaction","detail":"{read_only:false; response_revision:265; number_of_response:1; }","duration":"325.04482ms","start":"2026-07-17T11:57:39.885731Z","end":"2026-07-17T11:57:40.210776Z","steps":["trace[743570717] 'process raft request' (duration: 221.973192ms)","trace[743570717] 'compare' (duration: 101.616422ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T11:57:40.21092Z","caller":"traceutil/trace.go:171","msg":"trace[666660259] transaction","detail":"{read_only:false; response_revision:266; number_of_response:1; }","duration":"279.612883ms","start":"2026-07-17T11:57:39.931219Z","end":"2026-07-17T11:57:40.210832Z","steps":["trace[666660259] 'process raft request' (duration: 279.4953ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:57:40.211287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:57:39.885714Z","time spent":"325.252686ms","remote":"127.0.0.1:44560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":302,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-17T11:57:40.474496Z","caller":"traceutil/trace.go:171","msg":"trace[1970272930] linearizableReadLoop","detail":"{readStateIndex:276; appliedIndex:275; }","duration":"259.272774ms","start":"2026-07-17T11:57:40.215183Z","end":"2026-07-17T11:57:40.474456Z","steps":["trace[1970272930] 'read index received' (duration: 252.455984ms)","trace[1970272930] 'applied index is now lower than readState.Index' (duration: 6.81498ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T11:57:40.47451Z","caller":"traceutil/trace.go:171","msg":"trace[167479287] transaction","detail":"{read_only:false; response_revision:267; number_of_response:1; }","duration":"259.534781ms","start":"2026-07-17T11:57:40.214936Z","end":"2026-07-17T11:57:40.474471Z","steps":["trace[167479287] 'process raft request' (duration: 252.515285ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:57:40.474638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.433058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T11:57:40.474715Z","caller":"traceutil/trace.go:171","msg":"trace[50531016] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:0; response_revision:267; }","duration":"259.553621ms","start":"2026-07-17T11:57:40.215142Z","end":"2026-07-17T11:57:40.474696Z","steps":["trace[50531016] 'agreement among raft nodes before linearized reading' (duration: 259.407988ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:57:40.491886Z","caller":"traceutil/trace.go:171","msg":"trace[2071749544] transaction","detail":"{read_only:false; response_revision:268; number_of_response:1; }","duration":"275.139622ms","start":"2026-07-17T11:57:40.216707Z","end":"2026-07-17T11:57:40.491846Z","steps":["trace[2071749544] 'process raft request' (duration: 274.842693ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:57:40.492037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.371942ms","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-07-17T11:57:40.49234Z","caller":"traceutil/trace.go:171","msg":"trace[1157121036] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:268; }","duration":"248.727971ms","start":"2026-07-17T11:57:40.243586Z","end":"2026-07-17T11:57:40.492313Z","steps":["trace[1157121036] 'agreement among raft nodes before linearized reading' (duration: 248.301031ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:57:40.79223Z","caller":"traceutil/trace.go:171","msg":"trace[1575965922] linearizableReadLoop","detail":"{readStateIndex:280; appliedIndex:277; }","duration":"280.775973ms","start":"2026-07-17T11:57:40.511424Z","end":"2026-07-17T11:57:40.7922Z","steps":["trace[1575965922] 'read index received' (duration: 21.857926ms)","trace[1575965922] 'applied index is now lower than readState.Index' (duration: 258.917427ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T11:57:40.7923Z","caller":"traceutil/trace.go:171","msg":"trace[2137687882] transaction","detail":"{read_only:false; response_revision:271; number_of_response:1; }","duration":"294.814993ms","start":"2026-07-17T11:57:40.497438Z","end":"2026-07-17T11:57:40.792253Z","steps":["trace[2137687882] 'process raft request' (duration: 294.702571ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:57:40.79238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.935857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3980"} {"level":"info","ts":"2026-07-17T11:57:40.792414Z","caller":"traceutil/trace.go:171","msg":"trace[105591011] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:271; }","duration":"281.038919ms","start":"2026-07-17T11:57:40.511364Z","end":"2026-07-17T11:57:40.792403Z","steps":["trace[105591011] 'agreement among raft nodes before linearized reading' (duration: 280.936927ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:57:40.792459Z","caller":"traceutil/trace.go:171","msg":"trace[28327221] transaction","detail":"{read_only:false; response_revision:270; number_of_response:1; }","duration":"295.406109ms","start":"2026-07-17T11:57:40.497004Z","end":"2026-07-17T11:57:40.79241Z","steps":["trace[28327221] 'process raft request' (duration: 295.007429ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:57:40.792574Z","caller":"traceutil/trace.go:171","msg":"trace[2016981034] transaction","detail":"{read_only:false; number_of_response:0; response_revision:271; }","duration":"278.137417ms","start":"2026-07-17T11:57:40.514408Z","end":"2026-07-17T11:57:40.792546Z","steps":["trace[2016981034] 'process raft request' (duration: 277.765787ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:57:41.356788Z","caller":"traceutil/trace.go:171","msg":"trace[677821754] transaction","detail":"{read_only:false; response_revision:287; number_of_response:1; }","duration":"124.654146ms","start":"2026-07-17T11:57:41.232103Z","end":"2026-07-17T11:57:41.356757Z","steps":["trace[677821754] 'process raft request' (duration: 124.4268ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:57:44.109592Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":138942466641871300,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-17T11:57:44.111546Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.525431227s","expected-duration":"1s"} {"level":"info","ts":"2026-07-17T11:57:44.112149Z","caller":"traceutil/trace.go:171","msg":"trace[228742523] linearizableReadLoop","detail":"{readStateIndex:304; appliedIndex:303; }","duration":"1.525847117s","start":"2026-07-17T11:57:42.586279Z","end":"2026-07-17T11:57:44.112126Z","steps":["trace[228742523] 'read index received' (duration: 1.525462108s)","trace[228742523] 'applied index is now lower than readState.Index' (duration: 383.819µs)"],"step_count":2} {"level":"info","ts":"2026-07-17T11:57:44.112203Z","caller":"traceutil/trace.go:171","msg":"trace[1878652707] transaction","detail":"{read_only:false; response_revision:294; number_of_response:1; }","duration":"1.526164625s","start":"2026-07-17T11:57:42.586004Z","end":"2026-07-17T11:57:44.112168Z","steps":["trace[1878652707] 'process raft request' (duration: 1.525759895s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:57:44.112403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.526096263s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-07-17T11:57:44.112431Z","caller":"traceutil/trace.go:171","msg":"trace[310800651] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:294; }","duration":"1.526216726s","start":"2026-07-17T11:57:42.586206Z","end":"2026-07-17T11:57:44.112423Z","steps":["trace[310800651] 'agreement among raft nodes before linearized reading' (duration: 1.526122904s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:57:44.11246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.304101972s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-07-17T11:57:44.11247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:57:42.586182Z","time spent":"1.526274777s","remote":"127.0.0.1:36672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-07-17T11:57:44.11251Z","caller":"traceutil/trace.go:171","msg":"trace[1640187647] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:294; }","duration":"1.304205894s","start":"2026-07-17T11:57:42.808286Z","end":"2026-07-17T11:57:44.112492Z","steps":["trace[1640187647] 'agreement among raft nodes before linearized reading' (duration: 1.304100452s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:57:44.11256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:57:42.808264Z","time spent":"1.304285017s","remote":"127.0.0.1:44516","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-17T11:57:44.112576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:57:42.585963Z","time spent":"1.526303168s","remote":"127.0.0.1:44516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T11:57:47.995251Z","caller":"traceutil/trace.go:171","msg":"trace[1472544357] linearizableReadLoop","detail":"{readStateIndex:367; appliedIndex:366; }","duration":"412.779054ms","start":"2026-07-17T11:57:47.582436Z","end":"2026-07-17T11:57:47.995215Z","steps":["trace[1472544357] 'read index received' (duration: 412.533238ms)","trace[1472544357] 'applied index is now lower than readState.Index' (duration: 244.746µs)"],"step_count":2} {"level":"warn","ts":"2026-07-17T11:57:47.995437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.981478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-17T11:57:47.995464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.679928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.216\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-17T11:57:47.995507Z","caller":"traceutil/trace.go:171","msg":"trace[1958033766] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:356; }","duration":"413.111931ms","start":"2026-07-17T11:57:47.582372Z","end":"2026-07-17T11:57:47.995484Z","steps":["trace[1958033766] 'agreement among raft nodes before linearized reading' (duration: 412.971788ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:57:47.995519Z","caller":"traceutil/trace.go:171","msg":"trace[84363485] range","detail":"{range_begin:/registry/masterleases/199.19.213.216; range_end:; response_count:1; response_revision:356; }","duration":"257.77366ms","start":"2026-07-17T11:57:47.737731Z","end":"2026-07-17T11:57:47.995504Z","steps":["trace[84363485] 'agreement among raft nodes before linearized reading' (duration: 257.667898ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:57:47.995559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:57:47.582299Z","time spent":"413.247934ms","remote":"127.0.0.1:36578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-17T11:57:47.996124Z","caller":"traceutil/trace.go:171","msg":"trace[731481387] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"675.477538ms","start":"2026-07-17T11:57:47.319832Z","end":"2026-07-17T11:57:47.99531Z","steps":["trace[731481387] 'process raft request' (duration: 675.212262ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:57:47.996257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:57:47.319821Z","time spent":"676.361578ms","remote":"127.0.0.1:44454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7288,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T11:57:48.248705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.838456ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-17T11:57:48.249195Z","caller":"traceutil/trace.go:171","msg":"trace[1044387206] linearizableReadLoop","detail":"{readStateIndex:370; appliedIndex:368; }","duration":"115.019266ms","start":"2026-07-17T11:57:48.134155Z","end":"2026-07-17T11:57:48.249174Z","steps":["trace[1044387206] 'read index received' (duration: 40.456074ms)","trace[1044387206] 'applied index is now lower than readState.Index' (duration: 74.562312ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T11:57:48.249347Z","caller":"traceutil/trace.go:171","msg":"trace[1262598890] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"233.07679ms","start":"2026-07-17T11:57:48.016211Z","end":"2026-07-17T11:57:48.249288Z","steps":["trace[1262598890] 'process raft request' (duration: 57.538227ms)","trace[1262598890] 'compare' (duration: 174.643012ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T11:57:48.249477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.287211ms","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-17T11:57:48.249593Z","caller":"traceutil/trace.go:171","msg":"trace[1289342250] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:358; }","duration":"115.471536ms","start":"2026-07-17T11:57:48.134094Z","end":"2026-07-17T11:57:48.249566Z","steps":["trace[1289342250] 'agreement among raft nodes before linearized reading' (duration: 115.21781ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:57:48.250292Z","caller":"traceutil/trace.go:171","msg":"trace[293144193] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"228.055755ms","start":"2026-07-17T11:57:48.022213Z","end":"2026-07-17T11:57:48.250268Z","steps":["trace[293144193] 'process raft request' (duration: 226.879898ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:57:48.442705Z","caller":"traceutil/trace.go:171","msg":"trace[1913940650] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"187.281594ms","start":"2026-07-17T11:57:48.255399Z","end":"2026-07-17T11:57:48.44268Z","steps":["trace[1913940650] 'process raft request' (duration: 148.852016ms)","trace[1913940650] 'compare' (duration: 38.250854ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T11:57:48.442921Z","caller":"traceutil/trace.go:171","msg":"trace[31009700] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"187.14379ms","start":"2026-07-17T11:57:48.255763Z","end":"2026-07-17T11:57:48.442907Z","steps":["trace[31009700] 'process raft request' (duration: 186.875234ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:57:48.443104Z","caller":"traceutil/trace.go:171","msg":"trace[911037563] linearizableReadLoop","detail":"{readStateIndex:373; appliedIndex:370; }","duration":"186.775232ms","start":"2026-07-17T11:57:48.256296Z","end":"2026-07-17T11:57:48.443071Z","steps":["trace[911037563] 'read index received' (duration: 25.399096ms)","trace[911037563] 'applied index is now lower than readState.Index' (duration: 161.375096ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T11:57:48.443284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.960207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-17T11:57:48.443329Z","caller":"traceutil/trace.go:171","msg":"trace[1241250515] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:362; }","duration":"187.042708ms","start":"2026-07-17T11:57:48.256272Z","end":"2026-07-17T11:57:48.443315Z","steps":["trace[1241250515] 'agreement among raft nodes before linearized reading' (duration: 186.926876ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:57:48.443499Z","caller":"traceutil/trace.go:171","msg":"trace[157583323] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"186.381993ms","start":"2026-07-17T11:57:48.2571Z","end":"2026-07-17T11:57:48.443482Z","steps":["trace[157583323] 'process raft request' (duration: 185.771169ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:58:17.640381Z","caller":"traceutil/trace.go:171","msg":"trace[1387058971] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"116.077219ms","start":"2026-07-17T11:58:17.524259Z","end":"2026-07-17T11:58:17.640336Z","steps":["trace[1387058971] 'process raft request' (duration: 115.372377ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:58:17.640648Z","caller":"traceutil/trace.go:171","msg":"trace[960529754] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"103.571676ms","start":"2026-07-17T11:58:17.536855Z","end":"2026-07-17T11:58:17.640426Z","steps":["trace[960529754] 'process raft request' (duration: 102.959985ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:58:17.640787Z","caller":"traceutil/trace.go:171","msg":"trace[1161863096] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"116.411306ms","start":"2026-07-17T11:58:17.524346Z","end":"2026-07-17T11:58:17.640757Z","steps":["trace[1161863096] 'process raft request' (duration: 115.415857ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:58:17.966831Z","caller":"traceutil/trace.go:171","msg":"trace[2076472333] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"384.993244ms","start":"2026-07-17T11:58:17.581787Z","end":"2026-07-17T11:58:17.966781Z","steps":["trace[2076472333] 'process raft request' (duration: 384.822541ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:58:17.966934Z","caller":"traceutil/trace.go:171","msg":"trace[672012123] transaction","detail":"{read_only:false; number_of_response:1; response_revision:509; }","duration":"384.639027ms","start":"2026-07-17T11:58:17.582277Z","end":"2026-07-17T11:58:17.966916Z","steps":["trace[672012123] 'process raft request' (duration: 384.429113ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:58:17.967292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:58:17.582249Z","time spent":"384.969372ms","remote":"127.0.0.1:36620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7366,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T11:58:17.966981Z","caller":"traceutil/trace.go:171","msg":"trace[1411296117] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"389.902631ms","start":"2026-07-17T11:58:17.577042Z","end":"2026-07-17T11:58:17.966945Z","steps":["trace[1411296117] 'process raft request' (duration: 377.649262ms)","trace[1411296117] 'compare' (duration: 11.440894ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T11:58:17.967421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:58:17.577003Z","time spent":"390.40174ms","remote":"127.0.0.1:36620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-17T11:58:17.967053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:58:17.581757Z","time spent":"385.169257ms","remote":"127.0.0.1:36620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7317,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T11:58:17.966864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.540205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T11:58:17.967612Z","caller":"traceutil/trace.go:171","msg":"trace[1794041412] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:510; }","duration":"385.334029ms","start":"2026-07-17T11:58:17.582262Z","end":"2026-07-17T11:58:17.967596Z","steps":["trace[1794041412] 'agreement among raft nodes before linearized reading' (duration: 384.524915ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:58:17.967042Z","caller":"traceutil/trace.go:171","msg":"trace[344688753] linearizableReadLoop","detail":"{readStateIndex:527; appliedIndex:525; }","duration":"384.477464ms","start":"2026-07-17T11:58:17.582304Z","end":"2026-07-17T11:58:17.966781Z","steps":["trace[344688753] 'read index received' (duration: 58.676696ms)","trace[344688753] 'applied index is now lower than readState.Index' (duration: 325.800078ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T11:58:17.967676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:58:17.582246Z","time spent":"385.40058ms","remote":"127.0.0.1:36578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-17T11:58:17.96717Z","caller":"traceutil/trace.go:171","msg":"trace[1534264536] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"383.71339ms","start":"2026-07-17T11:58:17.58339Z","end":"2026-07-17T11:58:17.967103Z","steps":["trace[1534264536] 'process raft request' (duration: 383.344114ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:58:17.96776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:58:17.583363Z","time spent":"384.379182ms","remote":"127.0.0.1:44724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-17T11:58:18.002911Z","caller":"traceutil/trace.go:171","msg":"trace[1755478944] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"352.489774ms","start":"2026-07-17T11:58:17.650378Z","end":"2026-07-17T11:58:18.002868Z","steps":["trace[1755478944] 'process raft request' (duration: 352.178999ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:58:18.002949Z","caller":"traceutil/trace.go:171","msg":"trace[377369344] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"351.433956ms","start":"2026-07-17T11:58:17.651482Z","end":"2026-07-17T11:58:18.002916Z","steps":["trace[377369344] 'process raft request' (duration: 351.375645ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:58:18.003075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:58:17.650352Z","time spent":"352.645867ms","remote":"127.0.0.1:44724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-17T11:58:18.003137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:58:17.651476Z","time spent":"351.561038ms","remote":"127.0.0.1:44724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-17T11:58:18.00328Z","caller":"traceutil/trace.go:171","msg":"trace[1427719916] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"352.562945ms","start":"2026-07-17T11:58:17.650663Z","end":"2026-07-17T11:58:18.003226Z","steps":["trace[1427719916] 'process raft request' (duration: 352.140958ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:58:18.003496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:58:17.650657Z","time spent":"352.727608ms","remote":"127.0.0.1:36620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T11:58:18.003327Z","caller":"traceutil/trace.go:171","msg":"trace[729829870] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"348.35649ms","start":"2026-07-17T11:58:17.654953Z","end":"2026-07-17T11:58:18.003309Z","steps":["trace[729829870] 'process raft request' (duration: 347.934652ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:58:18.003621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:58:17.654947Z","time spent":"348.642625ms","remote":"127.0.0.1:44724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-17T11:58:18.004681Z","caller":"traceutil/trace.go:171","msg":"trace[211591063] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"354.160903ms","start":"2026-07-17T11:58:17.650496Z","end":"2026-07-17T11:58:18.004656Z","steps":["trace[211591063] 'process raft request' (duration: 352.25204ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:58:18.00675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:58:17.650486Z","time spent":"356.132639ms","remote":"127.0.0.1:44724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-17T11:58:18.006716Z","caller":"traceutil/trace.go:171","msg":"trace[1157822523] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"348.639045ms","start":"2026-07-17T11:58:17.658009Z","end":"2026-07-17T11:58:18.006648Z","steps":["trace[1157822523] 'process raft request' (duration: 345.309036ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:58:18.006942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:58:17.658001Z","time spent":"348.841579ms","remote":"127.0.0.1:36620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T11:58:18.007486Z","caller":"traceutil/trace.go:171","msg":"trace[2001608049] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"342.225951ms","start":"2026-07-17T11:58:17.665231Z","end":"2026-07-17T11:58:18.007457Z","steps":["trace[2001608049] 'process raft request' (duration: 338.153799ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:58:18.007637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:58:17.665217Z","time spent":"342.340093ms","remote":"127.0.0.1:36620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T11:58:18.00768Z","caller":"traceutil/trace.go:171","msg":"trace[1766242236] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"271.242245ms","start":"2026-07-17T11:58:17.736257Z","end":"2026-07-17T11:58:18.0075Z","steps":["trace[1766242236] 'process raft request' (duration: 267.219614ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:58:18.007938Z","caller":"traceutil/trace.go:171","msg":"trace[913809408] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"347.041927ms","start":"2026-07-17T11:58:17.656641Z","end":"2026-07-17T11:58:18.003682Z","steps":["trace[913809408] 'process raft request' (duration: 346.592069ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:58:18.008108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:58:17.656609Z","time spent":"351.409275ms","remote":"127.0.0.1:36620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T11:58:18.008296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.67572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.216\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-17T11:58:18.008351Z","caller":"traceutil/trace.go:171","msg":"trace[77952237] range","detail":"{range_begin:/registry/masterleases/199.19.213.216; range_end:; response_count:1; response_revision:519; }","duration":"268.73228ms","start":"2026-07-17T11:58:17.739605Z","end":"2026-07-17T11:58:18.008337Z","steps":["trace[77952237] 'agreement among raft nodes before linearized reading' (duration: 267.865214ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:58:24.553583Z","caller":"traceutil/trace.go:171","msg":"trace[720146447] linearizableReadLoop","detail":"{readStateIndex:629; appliedIndex:628; }","duration":"316.231838ms","start":"2026-07-17T11:58:24.237329Z","end":"2026-07-17T11:58:24.553561Z","steps":["trace[720146447] 'read index received' (duration: 315.475776ms)","trace[720146447] 'applied index is now lower than readState.Index' (duration: 755.172µs)"],"step_count":2} {"level":"info","ts":"2026-07-17T11:58:24.553681Z","caller":"traceutil/trace.go:171","msg":"trace[267309316] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"406.953049ms","start":"2026-07-17T11:58:24.146712Z","end":"2026-07-17T11:58:24.553665Z","steps":["trace[267309316] 'process raft request' (duration: 406.372639ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:58:24.553749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.403851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-qxtq4\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-17T11:58:24.553784Z","caller":"traceutil/trace.go:171","msg":"trace[74297306] range","detail":"{range_begin:/registry/pods/kube-system/cilium-qxtq4; range_end:; response_count:1; response_revision:604; }","duration":"316.694546ms","start":"2026-07-17T11:58:24.237079Z","end":"2026-07-17T11:58:24.553774Z","steps":["trace[74297306] 'agreement among raft nodes before linearized reading' (duration: 316.603884ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:58:24.553796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:58:24.146685Z","time spent":"407.03615ms","remote":"127.0.0.1:36660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T11:58:24.553825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:58:24.237055Z","time spent":"316.762276ms","remote":"127.0.0.1:44454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-qxtq4\" "} {"level":"info","ts":"2026-07-17T11:58:24.684492Z","caller":"traceutil/trace.go:171","msg":"trace[431972900] linearizableReadLoop","detail":"{readStateIndex:631; appliedIndex:629; }","duration":"104.989433ms","start":"2026-07-17T11:58:24.579476Z","end":"2026-07-17T11:58:24.684466Z","steps":["trace[431972900] 'read index received' (duration: 54.280437ms)","trace[431972900] 'applied index is now lower than readState.Index' (duration: 50.707536ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T11:58:24.684631Z","caller":"traceutil/trace.go:171","msg":"trace[1497937660] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"124.046144ms","start":"2026-07-17T11:58:24.560525Z","end":"2026-07-17T11:58:24.684571Z","steps":["trace[1497937660] 'process raft request' (duration: 73.747405ms)","trace[1497937660] 'compare' (duration: 49.864172ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T11:58:24.684629Z","caller":"traceutil/trace.go:171","msg":"trace[6807493] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"114.560194ms","start":"2026-07-17T11:58:24.570017Z","end":"2026-07-17T11:58:24.684578Z","steps":["trace[6807493] 'process raft request' (duration: 114.3307ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:58:24.685072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.568172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T11:58:24.685139Z","caller":"traceutil/trace.go:171","msg":"trace[928529653] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:607; }","duration":"105.679194ms","start":"2026-07-17T11:58:24.579437Z","end":"2026-07-17T11:58:24.685117Z","steps":["trace[928529653] 'agreement among raft nodes before linearized reading' (duration: 105.529391ms)"],"step_count":1}