{"level":"warn","ts":"2026-10-14T12:52:22.262858Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-14T12:52:22.262944Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.9: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.9:2380","--initial-cluster=instance=https://199.19.213.9:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.9:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.9: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-10-14T12:52:22.263002Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-14T12:52:22.26301Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.9:2380"]} {"level":"info","ts":"2026-10-14T12:52:22.263025Z","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-10-14T12:52:22.263662Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.9:2379"]} {"level":"info","ts":"2026-10-14T12:52:22.263734Z","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.9:2380"],"listen-peer-urls":["https://199.19.213.9:2380"],"advertise-client-urls":["https://199.19.213.9:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.9:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.9: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-10-14T12:52:22.269246Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.340017ms"} {"level":"info","ts":"2026-10-14T12:52:22.286073Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3a0c9d65f167b31b","cluster-id":"86e523b598166645"} {"level":"info","ts":"2026-10-14T12:52:22.286426Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b switched to configuration voters=()"} {"level":"info","ts":"2026-10-14T12:52:22.286582Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b became follower at term 0"} {"level":"info","ts":"2026-10-14T12:52:22.286737Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3a0c9d65f167b31b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-14T12:52:22.286824Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b became follower at term 1"} {"level":"info","ts":"2026-10-14T12:52:22.286991Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b switched to configuration voters=(4182891215087711003)"} {"level":"warn","ts":"2026-10-14T12:52:22.294402Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-14T12:52:22.298418Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-14T12:52:22.300145Z","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-10-14T12:52:22.302839Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3a0c9d65f167b31b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-14T12:52:22.303277Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3a0c9d65f167b31b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-14T12:52:22.303474Z","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-10-14T12:52:22.303586Z","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-10-14T12:52:22.303674Z","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-10-14T12:52:22.305523Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b switched to configuration voters=(4182891215087711003)"} {"level":"info","ts":"2026-10-14T12:52:22.305596Z","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-10-14T12:52:22.305632Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"86e523b598166645","local-member-id":"3a0c9d65f167b31b","added-peer-id":"3a0c9d65f167b31b","added-peer-peer-urls":["https://199.19.213.9:2380"]} {"level":"info","ts":"2026-10-14T12:52:22.305693Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.9:2380"} {"level":"info","ts":"2026-10-14T12:52:22.305746Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.9:2380"} {"level":"info","ts":"2026-10-14T12:52:22.305945Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3a0c9d65f167b31b","initial-advertise-peer-urls":["https://199.19.213.9:2380"],"listen-peer-urls":["https://199.19.213.9:2380"],"advertise-client-urls":["https://199.19.213.9:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.9:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-14T12:52:22.305998Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-14T12:52:22.488244Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b is starting a new election at term 1"} {"level":"info","ts":"2026-10-14T12:52:22.488314Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b became pre-candidate at term 1"} {"level":"info","ts":"2026-10-14T12:52:22.488371Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b received MsgPreVoteResp from 3a0c9d65f167b31b at term 1"} {"level":"info","ts":"2026-10-14T12:52:22.488405Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b became candidate at term 2"} {"level":"info","ts":"2026-10-14T12:52:22.488421Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b received MsgVoteResp from 3a0c9d65f167b31b at term 2"} {"level":"info","ts":"2026-10-14T12:52:22.488467Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b became leader at term 2"} {"level":"info","ts":"2026-10-14T12:52:22.488486Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3a0c9d65f167b31b elected leader 3a0c9d65f167b31b at term 2"} {"level":"info","ts":"2026-10-14T12:52:22.489707Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T12:52:22.490647Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3a0c9d65f167b31b","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.9:2379]}","request-path":"/0/members/3a0c9d65f167b31b/attributes","cluster-id":"86e523b598166645","publish-timeout":"7s"} {"level":"info","ts":"2026-10-14T12:52:22.49083Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-14T12:52:22.490956Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-14T12:52:22.491365Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"86e523b598166645","local-member-id":"3a0c9d65f167b31b","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T12:52:22.491532Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T12:52:22.491579Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T12:52:22.491978Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-14T12:52:22.492246Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-14T12:52:22.495632Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.9:2379"} {"level":"info","ts":"2026-10-14T12:52:22.496091Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-14T12:52:28.303146Z","caller":"traceutil/trace.go:171","msg":"trace[1743762414] linearizableReadLoop","detail":"{readStateIndex:240; appliedIndex:239; }","duration":"151.461855ms","start":"2026-10-14T12:52:28.15166Z","end":"2026-10-14T12:52:28.303122Z","steps":["trace[1743762414] 'read index received' (duration: 151.037846ms)","trace[1743762414] 'applied index is now lower than readState.Index' (duration: 423.199µs)"],"step_count":2} {"level":"warn","ts":"2026-10-14T12:52:28.303428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.739171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T12:52:28.303568Z","caller":"traceutil/trace.go:171","msg":"trace[240315386] transaction","detail":"{read_only:false; response_revision:234; number_of_response:1; }","duration":"222.880499ms","start":"2026-10-14T12:52:28.08065Z","end":"2026-10-14T12:52:28.30353Z","steps":["trace[240315386] 'process raft request' (duration: 222.341347ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T12:52:28.303675Z","caller":"traceutil/trace.go:171","msg":"trace[146852451] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/resourcequota-controller; range_end:; response_count:0; response_revision:234; }","duration":"152.035818ms","start":"2026-10-14T12:52:28.151603Z","end":"2026-10-14T12:52:28.303639Z","steps":["trace[146852451] 'agreement among raft nodes before linearized reading' (duration: 151.728511ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T12:52:29.308889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.860099ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T12:52:29.308995Z","caller":"traceutil/trace.go:171","msg":"trace[1590189081] linearizableReadLoop","detail":"{readStateIndex:275; appliedIndex:274; }","duration":"385.478158ms","start":"2026-10-14T12:52:28.923502Z","end":"2026-10-14T12:52:29.308981Z","steps":["trace[1590189081] 'read index received' (duration: 64.555775ms)","trace[1590189081] 'applied index is now lower than readState.Index' (duration: 320.921123ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T12:52:29.309345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.845235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-10-14T12:52:29.309548Z","caller":"traceutil/trace.go:171","msg":"trace[69584384] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:269; }","duration":"386.050529ms","start":"2026-10-14T12:52:28.923466Z","end":"2026-10-14T12:52:29.309517Z","steps":["trace[69584384] 'agreement among raft nodes before linearized reading' (duration: 385.579889ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T12:52:29.309579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T12:52:28.923455Z","time spent":"386.115182ms","remote":"127.0.0.1:39914","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":"warn","ts":"2026-10-14T12:52:30.296052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"785.985453ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-14T12:52:30.296184Z","caller":"traceutil/trace.go:171","msg":"trace[1069443525] transaction","detail":"{read_only:false; response_revision:270; number_of_response:1; }","duration":"1.094518067s","start":"2026-10-14T12:52:29.201641Z","end":"2026-10-14T12:52:30.296159Z","steps":["trace[1069443525] 'process raft request' (duration: 308.334409ms)","trace[1069443525] 'compare' (duration: 785.83006ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T12:52:30.296244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T12:52:29.20162Z","time spent":"1.094602418s","remote":"127.0.0.1:39862","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-14T12:52:30.93448Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.424383185s","expected-duration":"1s"} {"level":"warn","ts":"2026-10-14T12:52:31.380693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.526587ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:5"} {"level":"info","ts":"2026-10-14T12:52:31.380976Z","caller":"traceutil/trace.go:171","msg":"trace[1694960547] transaction","detail":"{read_only:false; number_of_response:0; response_revision:270; }","duration":"2.092466153s","start":"2026-10-14T12:52:29.288469Z","end":"2026-10-14T12:52:31.380935Z","steps":["trace[1694960547] 'process raft request' (duration: 1.646331614s)","trace[1694960547] 'compare' (duration: 445.450725ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T12:52:31.381164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T12:52:29.288402Z","time spent":"2.092671028s","remote":"127.0.0.1:39968","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T12:52:31.381501Z","caller":"traceutil/trace.go:171","msg":"trace[562057947] transaction","detail":"{read_only:false; response_revision:271; number_of_response:1; }","duration":"2.06881812s","start":"2026-10-14T12:52:29.312631Z","end":"2026-10-14T12:52:31.381449Z","steps":["trace[562057947] 'process raft request' (duration: 2.068203226s)"],"step_count":1} {"level":"info","ts":"2026-10-14T12:52:31.381591Z","caller":"traceutil/trace.go:171","msg":"trace[2023938881] transaction","detail":"{read_only:false; response_revision:272; number_of_response:1; }","duration":"2.058650828s","start":"2026-10-14T12:52:29.322915Z","end":"2026-10-14T12:52:31.381566Z","steps":["trace[2023938881] 'process raft request' (duration: 2.058457304s)"],"step_count":1} {"level":"info","ts":"2026-10-14T12:52:31.381634Z","caller":"traceutil/trace.go:171","msg":"trace[1610496361] transaction","detail":"{read_only:false; response_revision:274; number_of_response:1; }","duration":"2.058382482s","start":"2026-10-14T12:52:29.323239Z","end":"2026-10-14T12:52:31.381621Z","steps":["trace[1610496361] 'process raft request' (duration: 2.05825s)"],"step_count":1} {"level":"warn","ts":"2026-10-14T12:52:31.381688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T12:52:29.322894Z","time spent":"2.058748411s","remote":"127.0.0.1:39972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3453,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-14T12:52:31.381712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T12:52:29.323227Z","time spent":"2.058454814s","remote":"127.0.0.1:39972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3953,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T12:52:31.381766Z","caller":"traceutil/trace.go:171","msg":"trace[1652901338] transaction","detail":"{read_only:false; number_of_response:0; response_revision:272; }","duration":"2.058666629s","start":"2026-10-14T12:52:29.323066Z","end":"2026-10-14T12:52:31.381732Z","steps":["trace[1652901338] 'process raft request' (duration: 2.058361192s)"],"step_count":1} {"level":"info","ts":"2026-10-14T12:52:31.3818Z","caller":"traceutil/trace.go:171","msg":"trace[1250245721] transaction","detail":"{read_only:false; response_revision:273; number_of_response:1; }","duration":"2.058695699s","start":"2026-10-14T12:52:29.323092Z","end":"2026-10-14T12:52:31.381788Z","steps":["trace[1250245721] 'process raft request' (duration: 2.058362892s)"],"step_count":1} {"level":"warn","ts":"2026-10-14T12:52:31.381856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T12:52:29.323074Z","time spent":"2.058758641s","remote":"127.0.0.1:39972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T12:52:31.381813Z","caller":"traceutil/trace.go:171","msg":"trace[2098814122] transaction","detail":"{read_only:false; response_revision:275; number_of_response:1; }","duration":"2.057953793s","start":"2026-10-14T12:52:29.32383Z","end":"2026-10-14T12:52:31.381783Z","steps":["trace[2098814122] 'process raft request' (duration: 2.057683147s)"],"step_count":1} {"level":"warn","ts":"2026-10-14T12:52:31.381881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T12:52:29.323044Z","time spent":"2.058792051s","remote":"127.0.0.1:39972","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T12:52:31.38184Z","caller":"traceutil/trace.go:171","msg":"trace[1888964359] linearizableReadLoop","detail":"{readStateIndex:277; appliedIndex:275; }","duration":"2.072798387s","start":"2026-10-14T12:52:29.309014Z","end":"2026-10-14T12:52:31.381812Z","steps":["trace[1888964359] 'read index received' (duration: 201.019694ms)","trace[1888964359] 'applied index is now lower than readState.Index' (duration: 1.871776403s)"],"step_count":2} {"level":"warn","ts":"2026-10-14T12:52:31.381955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.341248527s","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-10-14T12:52:31.382013Z","caller":"traceutil/trace.go:171","msg":"trace[152007551] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:276; }","duration":"2.34137259s","start":"2026-10-14T12:52:29.040626Z","end":"2026-10-14T12:52:31.381998Z","steps":["trace[152007551] 'agreement among raft nodes before linearized reading' (duration: 2.341250917s)"],"step_count":1} {"level":"warn","ts":"2026-10-14T12:52:31.381988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T12:52:29.32382Z","time spent":"2.058079595s","remote":"127.0.0.1:39972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-14T12:52:31.382064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T12:52:29.040594Z","time spent":"2.341458822s","remote":"127.0.0.1:40072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-10-14T12:52:31.382086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.181581003s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T12:52:31.382123Z","caller":"traceutil/trace.go:171","msg":"trace[2030108584] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:276; }","duration":"2.181638744s","start":"2026-10-14T12:52:29.200474Z","end":"2026-10-14T12:52:31.382113Z","steps":["trace[2030108584] 'agreement among raft nodes before linearized reading' (duration: 2.181582613s)"],"step_count":1} {"level":"info","ts":"2026-10-14T12:52:31.381736Z","caller":"traceutil/trace.go:171","msg":"trace[1051199602] transaction","detail":"{read_only:false; response_revision:276; number_of_response:1; }","duration":"1.080705448s","start":"2026-10-14T12:52:30.300885Z","end":"2026-10-14T12:52:31.381591Z","steps":["trace[1051199602] 'process raft request' (duration: 1.080661107s)"],"step_count":1} {"level":"warn","ts":"2026-10-14T12:52:31.382158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T12:52:29.200463Z","time spent":"2.181688075s","remote":"127.0.0.1:40072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "} {"level":"warn","ts":"2026-10-14T12:52:31.382188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.915959624s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-10-14T12:52:31.382074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.963003677s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-10-14T12:52:31.382201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.311436489s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T12:52:31.382236Z","caller":"traceutil/trace.go:171","msg":"trace[1251497302] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:276; }","duration":"1.963175031s","start":"2026-10-14T12:52:29.419051Z","end":"2026-10-14T12:52:31.382226Z","steps":["trace[1251497302] 'agreement among raft nodes before linearized reading' (duration: 1.962944876s)"],"step_count":1} {"level":"info","ts":"2026-10-14T12:52:31.382233Z","caller":"traceutil/trace.go:171","msg":"trace[69572478] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:276; }","duration":"1.916027625s","start":"2026-10-14T12:52:29.46619Z","end":"2026-10-14T12:52:31.382218Z","steps":["trace[69572478] 'agreement among raft nodes before linearized reading' (duration: 1.915969654s)"],"step_count":1} {"level":"info","ts":"2026-10-14T12:52:31.382252Z","caller":"traceutil/trace.go:171","msg":"trace[177718792] range","detail":"{range_begin:/registry/deployments/kube-system/; range_end:/registry/deployments/kube-system0; response_count:0; response_revision:276; }","duration":"2.311560242s","start":"2026-10-14T12:52:29.070677Z","end":"2026-10-14T12:52:31.382237Z","steps":["trace[177718792] 'agreement among raft nodes before linearized reading' (duration: 2.31147632s)"],"step_count":1} {"level":"warn","ts":"2026-10-14T12:52:31.382269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T12:52:29.418978Z","time spent":"1.963283393s","remote":"127.0.0.1:40072","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-10-14T12:52:31.382284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T12:52:29.466169Z","time spent":"1.916105267s","remote":"127.0.0.1:40072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-14T12:52:31.3823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T12:52:29.070639Z","time spent":"2.311649303s","remote":"127.0.0.1:40230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" "} {"level":"warn","ts":"2026-10-14T12:52:31.382483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T12:52:30.300855Z","time spent":"1.081315481s","remote":"127.0.0.1:39862","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":625,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-14T12:52:31.382143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"874.745476ms","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-10-14T12:52:31.382578Z","caller":"traceutil/trace.go:171","msg":"trace[448314251] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:276; }","duration":"875.229017ms","start":"2026-10-14T12:52:30.507337Z","end":"2026-10-14T12:52:31.382566Z","steps":["trace[448314251] 'agreement among raft nodes before linearized reading' (duration: 874.776677ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T12:52:31.382639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T12:52:30.50732Z","time spent":"875.292808ms","remote":"127.0.0.1:40072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-14T12:52:31.382639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T12:52:29.312593Z","time spent":"2.069926074s","remote":"127.0.0.1:39990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":201,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-14T12:52:31.38262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.182648376s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-10-14T12:52:31.382773Z","caller":"traceutil/trace.go:171","msg":"trace[1770040486] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:276; }","duration":"2.183400243s","start":"2026-10-14T12:52:29.199348Z","end":"2026-10-14T12:52:31.382748Z","steps":["trace[1770040486] 'agreement among raft nodes before linearized reading' (duration: 2.182478243s)"],"step_count":1} {"level":"warn","ts":"2026-10-14T12:52:31.382822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T12:52:29.199317Z","time spent":"2.183491094s","remote":"127.0.0.1:40174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":687,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-10-14T12:52:31.564063Z","caller":"traceutil/trace.go:171","msg":"trace[1380924002] linearizableReadLoop","detail":"{readStateIndex:286; appliedIndex:284; }","duration":"172.7546ms","start":"2026-10-14T12:52:31.391282Z","end":"2026-10-14T12:52:31.564037Z","steps":["trace[1380924002] 'read index received' (duration: 127.786071ms)","trace[1380924002] 'applied index is now lower than readState.Index' (duration: 44.967129ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T12:52:31.564085Z","caller":"traceutil/trace.go:171","msg":"trace[1848448297] transaction","detail":"{read_only:false; response_revision:278; number_of_response:1; }","duration":"172.896923ms","start":"2026-10-14T12:52:31.39114Z","end":"2026-10-14T12:52:31.564037Z","steps":["trace[1848448297] 'process raft request' (duration: 172.693298ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T12:52:31.564104Z","caller":"traceutil/trace.go:171","msg":"trace[155519889] transaction","detail":"{read_only:false; response_revision:277; number_of_response:1; }","duration":"175.266954ms","start":"2026-10-14T12:52:31.388793Z","end":"2026-10-14T12:52:31.56406Z","steps":["trace[155519889] 'process raft request' (duration: 130.193693ms)","trace[155519889] 'compare' (duration: 44.621921ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T12:52:31.564221Z","caller":"traceutil/trace.go:171","msg":"trace[1284423173] transaction","detail":"{read_only:false; response_revision:279; number_of_response:1; }","duration":"172.154976ms","start":"2026-10-14T12:52:31.392052Z","end":"2026-10-14T12:52:31.564207Z","steps":["trace[1284423173] 'process raft request' (duration: 171.84532ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T12:52:31.564418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.111447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-10-14T12:52:31.564497Z","caller":"traceutil/trace.go:171","msg":"trace[1257773090] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:281; }","duration":"173.213809ms","start":"2026-10-14T12:52:31.391268Z","end":"2026-10-14T12:52:31.564482Z","steps":["trace[1257773090] 'agreement among raft nodes before linearized reading' (duration: 173.068626ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T12:52:31.564504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.275409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4015"} {"level":"info","ts":"2026-10-14T12:52:31.564541Z","caller":"traceutil/trace.go:171","msg":"trace[1877878359] transaction","detail":"{read_only:false; response_revision:280; number_of_response:1; }","duration":"172.409622ms","start":"2026-10-14T12:52:31.392116Z","end":"2026-10-14T12:52:31.564526Z","steps":["trace[1877878359] 'process raft request' (duration: 171.82551ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T12:52:31.564567Z","caller":"traceutil/trace.go:171","msg":"trace[1303612116] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:281; }","duration":"172.343421ms","start":"2026-10-14T12:52:31.392192Z","end":"2026-10-14T12:52:31.564535Z","steps":["trace[1303612116] 'agreement among raft nodes before linearized reading' (duration: 172.184277ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T12:52:31.564685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.145797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-10-14T12:52:31.56468Z","caller":"traceutil/trace.go:171","msg":"trace[263101697] transaction","detail":"{read_only:false; response_revision:281; number_of_response:1; }","duration":"171.745018ms","start":"2026-10-14T12:52:31.392922Z","end":"2026-10-14T12:52:31.564667Z","steps":["trace[263101697] 'process raft request' (duration: 171.063764ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T12:52:31.564715Z","caller":"traceutil/trace.go:171","msg":"trace[1988240347] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:281; }","duration":"172.184497ms","start":"2026-10-14T12:52:31.39252Z","end":"2026-10-14T12:52:31.564704Z","steps":["trace[1988240347] 'agreement among raft nodes before linearized reading' (duration: 172.111996ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T12:52:31.564935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.405772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5887"} {"level":"info","ts":"2026-10-14T12:52:31.564969Z","caller":"traceutil/trace.go:171","msg":"trace[616499966] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:281; }","duration":"172.470064ms","start":"2026-10-14T12:52:31.392489Z","end":"2026-10-14T12:52:31.564959Z","steps":["trace[616499966] 'agreement among raft nodes before linearized reading' (duration: 172.30139ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T12:52:31.56508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.906622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/coredns\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T12:52:31.565106Z","caller":"traceutil/trace.go:171","msg":"trace[145816553] range","detail":"{range_begin:/registry/configmaps/kube-system/coredns; range_end:; response_count:0; response_revision:281; }","duration":"166.953664ms","start":"2026-10-14T12:52:31.398144Z","end":"2026-10-14T12:52:31.565098Z","steps":["trace[145816553] 'agreement among raft nodes before linearized reading' (duration: 166.896873ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T12:52:31.565117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.402429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T12:52:31.565166Z","caller":"traceutil/trace.go:171","msg":"trace[2011962339] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:281; }","duration":"170.46802ms","start":"2026-10-14T12:52:31.394683Z","end":"2026-10-14T12:52:31.565151Z","steps":["trace[2011962339] 'agreement among raft nodes before linearized reading' (duration: 170.371228ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T12:52:31.564712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.094705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4015"} {"level":"info","ts":"2026-10-14T12:52:31.566791Z","caller":"traceutil/trace.go:171","msg":"trace[223309060] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:281; }","duration":"174.252263ms","start":"2026-10-14T12:52:31.39251Z","end":"2026-10-14T12:52:31.566763Z","steps":["trace[223309060] 'agreement among raft nodes before linearized reading' (duration: 172.048095ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T12:53:08.986709Z","caller":"traceutil/trace.go:171","msg":"trace[947395612] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"307.267981ms","start":"2026-10-14T12:53:08.679231Z","end":"2026-10-14T12:53:08.986499Z","steps":["trace[947395612] 'process raft request' (duration: 307.113828ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T12:53:08.98683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T12:53:08.679209Z","time spent":"307.565108ms","remote":"127.0.0.1:39840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T12:53:08.993962Z","caller":"traceutil/trace.go:171","msg":"trace[923431050] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"313.913857ms","start":"2026-10-14T12:53:08.680026Z","end":"2026-10-14T12:53:08.99394Z","steps":["trace[923431050] 'process raft request' (duration: 313.760044ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T12:53:08.994152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T12:53:08.680014Z","time spent":"314.07495ms","remote":"127.0.0.1:39840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T12:53:08.994182Z","caller":"traceutil/trace.go:171","msg":"trace[1101839019] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"304.302137ms","start":"2026-10-14T12:53:08.689826Z","end":"2026-10-14T12:53:08.994128Z","steps":["trace[1101839019] 'process raft request' (duration: 304.010731ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T12:53:08.994263Z","caller":"traceutil/trace.go:171","msg":"trace[2050888416] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"314.824717ms","start":"2026-10-14T12:53:08.67943Z","end":"2026-10-14T12:53:08.994255Z","steps":["trace[2050888416] 'process raft request' (duration: 314.274865ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T12:53:08.9943Z","caller":"traceutil/trace.go:171","msg":"trace[594212624] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"281.224092ms","start":"2026-10-14T12:53:08.713049Z","end":"2026-10-14T12:53:08.994273Z","steps":["trace[594212624] 'process raft request' (duration: 281.021278ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T12:53:08.99434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T12:53:08.679402Z","time spent":"314.892868ms","remote":"127.0.0.1:39840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-14T12:53:08.994357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T12:53:08.689806Z","time spent":"304.47143ms","remote":"127.0.0.1:39840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T12:53:08.9942Z","caller":"traceutil/trace.go:171","msg":"trace[1514520755] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"302.303633ms","start":"2026-10-14T12:53:08.691866Z","end":"2026-10-14T12:53:08.99417Z","steps":["trace[1514520755] 'process raft request' (duration: 302.026717ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T12:53:08.994461Z","caller":"traceutil/trace.go:171","msg":"trace[234899543] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"302.16469ms","start":"2026-10-14T12:53:08.692289Z","end":"2026-10-14T12:53:08.994454Z","steps":["trace[234899543] 'process raft request' (duration: 301.660239ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T12:53:08.994595Z","caller":"traceutil/trace.go:171","msg":"trace[1007478246] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"276.272845ms","start":"2026-10-14T12:53:08.718312Z","end":"2026-10-14T12:53:08.994585Z","steps":["trace[1007478246] 'process raft request' (duration: 275.875106ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T12:53:08.994645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T12:53:08.69227Z","time spent":"302.329573ms","remote":"127.0.0.1:39840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T12:53:08.994476Z","caller":"traceutil/trace.go:171","msg":"trace[2044944586] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"281.344105ms","start":"2026-10-14T12:53:08.71312Z","end":"2026-10-14T12:53:08.994464Z","steps":["trace[2044944586] 'process raft request' (duration: 281.008898ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T12:53:08.99464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T12:53:08.691858Z","time spent":"302.663211ms","remote":"127.0.0.1:39840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T12:53:08.994774Z","caller":"traceutil/trace.go:171","msg":"trace[1247736386] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"266.140433ms","start":"2026-10-14T12:53:08.728626Z","end":"2026-10-14T12:53:08.994766Z","steps":["trace[1247736386] 'process raft request' (duration: 265.905258ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T12:53:08.994961Z","caller":"traceutil/trace.go:171","msg":"trace[1575847053] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"241.039885ms","start":"2026-10-14T12:53:08.753906Z","end":"2026-10-14T12:53:08.994946Z","steps":["trace[1575847053] 'process raft request' (duration: 240.865431ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T12:53:08.995255Z","caller":"traceutil/trace.go:171","msg":"trace[639202555] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"143.940755ms","start":"2026-10-14T12:53:08.851303Z","end":"2026-10-14T12:53:08.995244Z","steps":["trace[639202555] 'process raft request' (duration: 143.610117ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T12:53:12.112741Z","caller":"traceutil/trace.go:171","msg":"trace[1132326943] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"212.084734ms","start":"2026-10-14T12:53:11.900632Z","end":"2026-10-14T12:53:12.112716Z","steps":["trace[1132326943] 'process raft request' (duration: 211.638174ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T12:53:15.583877Z","caller":"traceutil/trace.go:171","msg":"trace[215195979] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"214.350465ms","start":"2026-10-14T12:53:15.369498Z","end":"2026-10-14T12:53:15.583849Z","steps":["trace[215195979] 'process raft request' (duration: 214.095889ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T12:53:15.807782Z","caller":"traceutil/trace.go:171","msg":"trace[1987035913] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"292.508172ms","start":"2026-10-14T12:53:15.515239Z","end":"2026-10-14T12:53:15.807747Z","steps":["trace[1987035913] 'process raft request' (duration: 291.750066ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T12:53:16.148637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.406966ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T12:53:16.148834Z","caller":"traceutil/trace.go:171","msg":"trace[1314638333] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"256.850363ms","start":"2026-10-14T12:53:15.891967Z","end":"2026-10-14T12:53:16.148818Z","steps":["trace[1314638333] 'process raft request' (duration: 256.815392ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T12:53:16.148901Z","caller":"traceutil/trace.go:171","msg":"trace[1397345318] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:657; }","duration":"325.159456ms","start":"2026-10-14T12:53:15.82372Z","end":"2026-10-14T12:53:16.148879Z","steps":["trace[1397345318] 'read index received' (duration: 88.448043ms)","trace[1397345318] 'applied index is now lower than readState.Index' (duration: 236.708883ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T12:53:16.149096Z","caller":"traceutil/trace.go:171","msg":"trace[908350501] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"265.653245ms","start":"2026-10-14T12:53:15.883414Z","end":"2026-10-14T12:53:16.149067Z","steps":["trace[908350501] 'process raft request' (duration: 265.323368ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T12:53:16.149189Z","caller":"traceutil/trace.go:171","msg":"trace[477935381] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"327.831464ms","start":"2026-10-14T12:53:15.82134Z","end":"2026-10-14T12:53:16.149171Z","steps":["trace[477935381] 'process raft request' (duration: 90.810124ms)","trace[477935381] 'compare' (duration: 236.270203ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T12:53:16.149284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T12:53:15.821332Z","time spent":"327.898856ms","remote":"127.0.0.1:40072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T12:53:16.149519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.051844ms","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-10-14T12:53:16.149557Z","caller":"traceutil/trace.go:171","msg":"trace[2025716639] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:638; }","duration":"309.130656ms","start":"2026-10-14T12:53:15.840415Z","end":"2026-10-14T12:53:16.149546Z","steps":["trace[2025716639] 'agreement among raft nodes before linearized reading' (duration: 309.011573ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T12:53:16.149584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T12:53:15.840405Z","time spent":"309.171527ms","remote":"127.0.0.1:40072","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-10-14T12:53:16.149695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.980044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-14T12:53:16.149717Z","caller":"traceutil/trace.go:171","msg":"trace[1544533351] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:638; }","duration":"326.023394ms","start":"2026-10-14T12:53:15.823686Z","end":"2026-10-14T12:53:16.149709Z","steps":["trace[1544533351] 'agreement among raft nodes before linearized reading' (duration: 325.956843ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T12:53:16.149738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T12:53:15.823672Z","time spent":"326.060636ms","remote":"127.0.0.1:40072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-14T12:53:16.624239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.689719ms","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-10-14T12:53:16.62436Z","caller":"traceutil/trace.go:171","msg":"trace[1484868439] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:638; }","duration":"299.827642ms","start":"2026-10-14T12:53:16.324516Z","end":"2026-10-14T12:53:16.624343Z","steps":["trace[1484868439] 'range keys from in-memory index tree' (duration: 299.675959ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T12:53:16.624658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.834414ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T12:53:16.625294Z","caller":"traceutil/trace.go:171","msg":"trace[140765596] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"471.362242ms","start":"2026-10-14T12:53:16.153913Z","end":"2026-10-14T12:53:16.625276Z","steps":["trace[140765596] 'process raft request' (duration: 250.587897ms)","trace[140765596] 'compare' (duration: 219.694641ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T12:53:16.625438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T12:53:16.153897Z","time spent":"471.455803ms","remote":"127.0.0.1:40072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T12:53:16.625765Z","caller":"traceutil/trace.go:171","msg":"trace[1526112469] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:660; }","duration":"470.406671ms","start":"2026-10-14T12:53:16.155319Z","end":"2026-10-14T12:53:16.625726Z","steps":["trace[1526112469] 'read index received' (duration: 249.278308ms)","trace[1526112469] 'applied index is now lower than readState.Index' (duration: 221.127123ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T12:53:16.625983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.657596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-10-14T12:53:16.625978Z","caller":"traceutil/trace.go:171","msg":"trace[1447725168] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"471.76495ms","start":"2026-10-14T12:53:16.154103Z","end":"2026-10-14T12:53:16.625868Z","steps":["trace[1447725168] 'process raft request' (duration: 471.521914ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T12:53:16.626008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.502379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T12:53:16.626028Z","caller":"traceutil/trace.go:171","msg":"trace[639637210] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:640; }","duration":"470.728658ms","start":"2026-10-14T12:53:16.155286Z","end":"2026-10-14T12:53:16.626015Z","steps":["trace[639637210] 'agreement among raft nodes before linearized reading' (duration: 470.575655ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T12:53:16.626059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T12:53:16.155273Z","time spent":"470.779579ms","remote":"127.0.0.1:39990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"info","ts":"2026-10-14T12:53:16.626059Z","caller":"traceutil/trace.go:171","msg":"trace[170187730] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:640; }","duration":"231.584151ms","start":"2026-10-14T12:53:16.394459Z","end":"2026-10-14T12:53:16.626043Z","steps":["trace[170187730] 'agreement among raft nodes before linearized reading' (duration: 231.439268ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T12:53:16.626233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.35318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.9\" ","response":"range_response_count:1 size:131"} {"level":"info","ts":"2026-10-14T12:53:16.626372Z","caller":"traceutil/trace.go:171","msg":"trace[1429789440] range","detail":"{range_begin:/registry/masterleases/199.19.213.9; range_end:; response_count:1; response_revision:640; }","duration":"217.570145ms","start":"2026-10-14T12:53:16.408772Z","end":"2026-10-14T12:53:16.626342Z","steps":["trace[1429789440] 'agreement among raft nodes before linearized reading' (duration: 217.268198ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T12:53:16.626599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T12:53:16.154078Z","time spent":"471.966285ms","remote":"127.0.0.1:40072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T12:53:16.985873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.594542ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T12:53:16.986168Z","caller":"traceutil/trace.go:171","msg":"trace[541479287] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"315.016864ms","start":"2026-10-14T12:53:16.671126Z","end":"2026-10-14T12:53:16.986143Z","steps":["trace[541479287] 'process raft request' (duration: 314.876781ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T12:53:16.986262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T12:53:16.671105Z","time spent":"315.118567ms","remote":"127.0.0.1:39972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T12:53:16.986324Z","caller":"traceutil/trace.go:171","msg":"trace[405142918] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"316.293783ms","start":"2026-10-14T12:53:16.670004Z","end":"2026-10-14T12:53:16.986298Z","steps":["trace[405142918] 'process raft request' (duration: 138.16039ms)","trace[405142918] 'compare' (duration: 177.308995ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T12:53:16.98645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T12:53:16.669976Z","time spent":"316.395634ms","remote":"127.0.0.1:39824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":116,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T12:53:18.654683Z","caller":"traceutil/trace.go:171","msg":"trace[1734083650] linearizableReadLoop","detail":"{readStateIndex:695; appliedIndex:694; }","duration":"104.596896ms","start":"2026-10-14T12:53:18.550065Z","end":"2026-10-14T12:53:18.654662Z","steps":["trace[1734083650] 'read index received' (duration: 12.795329ms)","trace[1734083650] 'applied index is now lower than readState.Index' (duration: 91.800747ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T12:53:18.654785Z","caller":"traceutil/trace.go:171","msg":"trace[433882914] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"152.581125ms","start":"2026-10-14T12:53:18.502185Z","end":"2026-10-14T12:53:18.654766Z","steps":["trace[433882914] 'process raft request' (duration: 60.736228ms)","trace[433882914] 'compare' (duration: 91.631323ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T12:53:18.654857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.75497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T12:53:18.654887Z","caller":"traceutil/trace.go:171","msg":"trace[1621085539] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:672; }","duration":"104.848302ms","start":"2026-10-14T12:53:18.55003Z","end":"2026-10-14T12:53:18.654878Z","steps":["trace[1621085539] 'agreement among raft nodes before linearized reading' (duration: 104.74664ms)"],"step_count":1}