{"level":"warn","ts":"2026-02-18T22:50:21.416575Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-18T22:50:21.416833Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.113:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.113:2380","--initial-cluster=instance=https://199.204.45.113:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.113:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.113: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-02-18T22:50:21.417023Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-18T22:50:21.417071Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.113:2380"]} {"level":"info","ts":"2026-02-18T22:50:21.417132Z","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-02-18T22:50:21.418097Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"]} {"level":"info","ts":"2026-02-18T22:50:21.418261Z","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":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.113:2380"],"listen-peer-urls":["https://199.204.45.113:2380"],"advertise-client-urls":["https://199.204.45.113:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.113: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-02-18T22:50:21.508045Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"68.145611ms"} {"level":"info","ts":"2026-02-18T22:50:21.597228Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a31e123290fcf0df","cluster-id":"37661d6ee45ed9e8"} {"level":"info","ts":"2026-02-18T22:50:21.597311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=()"} {"level":"info","ts":"2026-02-18T22:50:21.597474Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became follower at term 0"} {"level":"info","ts":"2026-02-18T22:50:21.597489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a31e123290fcf0df [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-18T22:50:21.597527Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became follower at term 1"} {"level":"info","ts":"2026-02-18T22:50:21.597612Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=(11753852085873733855)"} {"level":"warn","ts":"2026-02-18T22:50:21.667011Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-18T22:50:21.719178Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-18T22:50:21.742574Z","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-02-18T22:50:21.772133Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a31e123290fcf0df","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-18T22:50:21.772623Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a31e123290fcf0df","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-18T22:50:21.772808Z","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-02-18T22:50:21.772844Z","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-02-18T22:50:21.772854Z","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-02-18T22:50:21.777078Z","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-02-18T22:50:21.777199Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.113:2380"} {"level":"info","ts":"2026-02-18T22:50:21.777286Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.113:2380"} {"level":"info","ts":"2026-02-18T22:50:21.781485Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-18T22:50:21.781467Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a31e123290fcf0df","initial-advertise-peer-urls":["https://199.204.45.113:2380"],"listen-peer-urls":["https://199.204.45.113:2380"],"advertise-client-urls":["https://199.204.45.113:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-18T22:50:21.788855Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=(11753852085873733855)"} {"level":"info","ts":"2026-02-18T22:50:21.789164Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"37661d6ee45ed9e8","local-member-id":"a31e123290fcf0df","added-peer-id":"a31e123290fcf0df","added-peer-peer-urls":["https://199.204.45.113:2380"]} {"level":"info","ts":"2026-02-18T22:50:22.498366Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df is starting a new election at term 1"} {"level":"info","ts":"2026-02-18T22:50:22.498472Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became pre-candidate at term 1"} {"level":"info","ts":"2026-02-18T22:50:22.498551Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df received MsgPreVoteResp from a31e123290fcf0df at term 1"} {"level":"info","ts":"2026-02-18T22:50:22.498584Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became candidate at term 2"} {"level":"info","ts":"2026-02-18T22:50:22.498603Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df received MsgVoteResp from a31e123290fcf0df at term 2"} {"level":"info","ts":"2026-02-18T22:50:22.498626Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became leader at term 2"} {"level":"info","ts":"2026-02-18T22:50:22.49866Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a31e123290fcf0df elected leader a31e123290fcf0df at term 2"} {"level":"info","ts":"2026-02-18T22:50:22.502131Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-18T22:50:22.503626Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a31e123290fcf0df","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.113:2379]}","request-path":"/0/members/a31e123290fcf0df/attributes","cluster-id":"37661d6ee45ed9e8","publish-timeout":"7s"} {"level":"info","ts":"2026-02-18T22:50:22.50365Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-18T22:50:22.503951Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-18T22:50:22.505478Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-18T22:50:22.509586Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.113:2379"} {"level":"info","ts":"2026-02-18T22:50:22.524153Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-18T22:50:22.524174Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-18T22:50:22.551804Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"37661d6ee45ed9e8","local-member-id":"a31e123290fcf0df","cluster-version":"3.5"} {"level":"info","ts":"2026-02-18T22:50:22.552028Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-18T22:50:22.552054Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-18T22:50:24.258185Z","caller":"traceutil/trace.go:171","msg":"trace[620950254] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"112.416749ms","start":"2026-02-18T22:50:24.145716Z","end":"2026-02-18T22:50:24.258133Z","steps":["trace[620950254] 'process raft request' (duration: 111.885725ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:24.258252Z","caller":"traceutil/trace.go:171","msg":"trace[106069509] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"107.663307ms","start":"2026-02-18T22:50:24.150565Z","end":"2026-02-18T22:50:24.258229Z","steps":["trace[106069509] 'process raft request' (duration: 107.050133ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:24.258526Z","caller":"traceutil/trace.go:171","msg":"trace[1341071181] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"107.465425ms","start":"2026-02-18T22:50:24.151055Z","end":"2026-02-18T22:50:24.25852Z","steps":["trace[1341071181] 'process raft request' (duration: 106.572169ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:24.258885Z","caller":"traceutil/trace.go:171","msg":"trace[1144130098] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"113.361084ms","start":"2026-02-18T22:50:24.145515Z","end":"2026-02-18T22:50:24.258876Z","steps":["trace[1144130098] 'process raft request' (duration: 80.793098ms)","trace[1144130098] 'compare' (duration: 31.037057ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:24.260428Z","caller":"traceutil/trace.go:171","msg":"trace[696453854] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"114.803375ms","start":"2026-02-18T22:50:24.145618Z","end":"2026-02-18T22:50:24.260421Z","steps":["trace[696453854] 'process raft request' (duration: 111.902296ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:24.260543Z","caller":"traceutil/trace.go:171","msg":"trace[980912593] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"114.876556ms","start":"2026-02-18T22:50:24.145661Z","end":"2026-02-18T22:50:24.260537Z","steps":["trace[980912593] 'process raft request' (duration: 111.884326ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:24.260617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.518021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-18T22:50:24.2607Z","caller":"traceutil/trace.go:171","msg":"trace[686781809] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12; }","duration":"110.646848ms","start":"2026-02-18T22:50:24.150039Z","end":"2026-02-18T22:50:24.260686Z","steps":["trace[686781809] 'agreement among raft nodes before linearized reading' (duration: 109.536861ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:24.260766Z","caller":"traceutil/trace.go:171","msg":"trace[759847100] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"115.039756ms","start":"2026-02-18T22:50:24.145682Z","end":"2026-02-18T22:50:24.260722Z","steps":["trace[759847100] 'process raft request' (duration: 111.874035ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:24.261101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.864205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-18T22:50:24.264312Z","caller":"traceutil/trace.go:171","msg":"trace[1809565356] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:12; }","duration":"118.087247ms","start":"2026-02-18T22:50:24.146204Z","end":"2026-02-18T22:50:24.264291Z","steps":["trace[1809565356] 'agreement among raft nodes before linearized reading' (duration: 114.844945ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:24.45769Z","caller":"traceutil/trace.go:171","msg":"trace[2050784356] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"103.48317ms","start":"2026-02-18T22:50:24.354171Z","end":"2026-02-18T22:50:24.457654Z","steps":["trace[2050784356] 'process raft request' (duration: 46.070678ms)","trace[2050784356] 'compare' (duration: 57.192361ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:24.532215Z","caller":"traceutil/trace.go:171","msg":"trace[401856533] linearizableReadLoop","detail":"{readStateIndex:29; appliedIndex:25; }","duration":"170.461766ms","start":"2026-02-18T22:50:24.361733Z","end":"2026-02-18T22:50:24.532195Z","steps":["trace[401856533] 'read index received' (duration: 38.434787ms)","trace[401856533] 'applied index is now lower than readState.Index' (duration: 132.025809ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:24.532452Z","caller":"traceutil/trace.go:171","msg":"trace[125195510] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"170.629447ms","start":"2026-02-18T22:50:24.361797Z","end":"2026-02-18T22:50:24.532426Z","steps":["trace[125195510] 'process raft request' (duration: 170.287745ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:24.532559Z","caller":"traceutil/trace.go:171","msg":"trace[1957356001] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"171.656554ms","start":"2026-02-18T22:50:24.360828Z","end":"2026-02-18T22:50:24.532484Z","steps":["trace[1957356001] 'process raft request' (duration: 171.108421ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:24.532799Z","caller":"traceutil/trace.go:171","msg":"trace[297045012] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"171.636253ms","start":"2026-02-18T22:50:24.361155Z","end":"2026-02-18T22:50:24.532791Z","steps":["trace[297045012] 'process raft request' (duration: 170.865568ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:24.532936Z","caller":"traceutil/trace.go:171","msg":"trace[468189428] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"171.417772ms","start":"2026-02-18T22:50:24.361511Z","end":"2026-02-18T22:50:24.532928Z","steps":["trace[468189428] 'process raft request' (duration: 170.538286ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:24.533067Z","caller":"traceutil/trace.go:171","msg":"trace[968157534] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"170.883099ms","start":"2026-02-18T22:50:24.36217Z","end":"2026-02-18T22:50:24.533053Z","steps":["trace[968157534] 'process raft request' (duration: 169.956223ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:24.533838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.409232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-18T22:50:24.533867Z","caller":"traceutil/trace.go:171","msg":"trace[604297382] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:28; }","duration":"171.479963ms","start":"2026-02-18T22:50:24.36238Z","end":"2026-02-18T22:50:24.53386Z","steps":["trace[604297382] 'agreement among raft nodes before linearized reading' (duration: 170.96525ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:24.534425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.666481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-18T22:50:24.536052Z","caller":"traceutil/trace.go:171","msg":"trace[692136314] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:28; }","duration":"174.314702ms","start":"2026-02-18T22:50:24.361719Z","end":"2026-02-18T22:50:24.536034Z","steps":["trace[692136314] 'agreement among raft nodes before linearized reading' (duration: 172.652791ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:24.534625Z","caller":"traceutil/trace.go:171","msg":"trace[1623167568] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"172.096008ms","start":"2026-02-18T22:50:24.36252Z","end":"2026-02-18T22:50:24.534616Z","steps":["trace[1623167568] 'process raft request' (duration: 169.645021ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:24.534666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.243668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-18T22:50:24.537336Z","caller":"traceutil/trace.go:171","msg":"trace[1841989249] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:28; }","duration":"108.886106ms","start":"2026-02-18T22:50:24.428413Z","end":"2026-02-18T22:50:24.537299Z","steps":["trace[1841989249] 'agreement among raft nodes before linearized reading' (duration: 106.231968ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:24.659837Z","caller":"traceutil/trace.go:171","msg":"trace[2033022833] linearizableReadLoop","detail":"{readStateIndex:41; appliedIndex:33; }","duration":"105.462553ms","start":"2026-02-18T22:50:24.55435Z","end":"2026-02-18T22:50:24.659813Z","steps":["trace[2033022833] 'read index received' (duration: 45.509763ms)","trace[2033022833] 'applied index is now lower than readState.Index' (duration: 59.95157ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:50:24.660045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.656734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-node-lease/\" range_end:\"/registry/resourcequotas/kube-node-lease0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-18T22:50:24.660084Z","caller":"traceutil/trace.go:171","msg":"trace[2114207379] range","detail":"{range_begin:/registry/resourcequotas/kube-node-lease/; range_end:/registry/resourcequotas/kube-node-lease0; response_count:0; response_revision:37; }","duration":"105.765034ms","start":"2026-02-18T22:50:24.554308Z","end":"2026-02-18T22:50:24.660073Z","steps":["trace[2114207379] 'agreement among raft nodes before linearized reading' (duration: 105.605683ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:24.660439Z","caller":"traceutil/trace.go:171","msg":"trace[1498309708] transaction","detail":"{read_only:false; response_revision:30; number_of_response:1; }","duration":"116.077234ms","start":"2026-02-18T22:50:24.544347Z","end":"2026-02-18T22:50:24.660424Z","steps":["trace[1498309708] 'process raft request' (duration: 55.577041ms)","trace[1498309708] 'compare' (duration: 59.455656ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:24.66065Z","caller":"traceutil/trace.go:171","msg":"trace[1370686002] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"115.903363ms","start":"2026-02-18T22:50:24.54474Z","end":"2026-02-18T22:50:24.660643Z","steps":["trace[1370686002] 'process raft request' (duration: 114.820085ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:24.660791Z","caller":"traceutil/trace.go:171","msg":"trace[956377216] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"113.711259ms","start":"2026-02-18T22:50:24.547072Z","end":"2026-02-18T22:50:24.660783Z","steps":["trace[956377216] 'process raft request' (duration: 112.54047ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:24.660888Z","caller":"traceutil/trace.go:171","msg":"trace[1495564971] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"113.651538ms","start":"2026-02-18T22:50:24.547226Z","end":"2026-02-18T22:50:24.660877Z","steps":["trace[1495564971] 'process raft request' (duration: 112.4243ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:24.660978Z","caller":"traceutil/trace.go:171","msg":"trace[1884984278] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"113.647058ms","start":"2026-02-18T22:50:24.547322Z","end":"2026-02-18T22:50:24.660969Z","steps":["trace[1884984278] 'process raft request' (duration: 112.355939ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:24.661064Z","caller":"traceutil/trace.go:171","msg":"trace[1374565414] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"113.633978ms","start":"2026-02-18T22:50:24.547421Z","end":"2026-02-18T22:50:24.661055Z","steps":["trace[1374565414] 'process raft request' (duration: 112.282149ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:24.661238Z","caller":"traceutil/trace.go:171","msg":"trace[1225523464] transaction","detail":"{read_only:false; response_revision:36; number_of_response:1; }","duration":"113.635187ms","start":"2026-02-18T22:50:24.547593Z","end":"2026-02-18T22:50:24.661228Z","steps":["trace[1225523464] 'process raft request' (duration: 112.152437ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:24.661341Z","caller":"traceutil/trace.go:171","msg":"trace[447817899] transaction","detail":"{read_only:false; response_revision:37; number_of_response:1; }","duration":"113.263354ms","start":"2026-02-18T22:50:24.548068Z","end":"2026-02-18T22:50:24.661331Z","steps":["trace[447817899] 'process raft request' (duration: 111.708003ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:27.139167Z","caller":"traceutil/trace.go:171","msg":"trace[845590221] transaction","detail":"{read_only:false; response_revision:129; number_of_response:1; }","duration":"110.139693ms","start":"2026-02-18T22:50:27.028949Z","end":"2026-02-18T22:50:27.139089Z","steps":["trace[845590221] 'process raft request' (duration: 76.755605ms)","trace[845590221] 'compare' (duration: 32.878485ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:27.317493Z","caller":"traceutil/trace.go:171","msg":"trace[453030559] transaction","detail":"{read_only:false; response_revision:133; number_of_response:1; }","duration":"108.808144ms","start":"2026-02-18T22:50:27.208651Z","end":"2026-02-18T22:50:27.31746Z","steps":["trace[453030559] 'process raft request' (duration: 54.243926ms)","trace[453030559] 'compare' (duration: 54.418827ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:27.763926Z","caller":"traceutil/trace.go:171","msg":"trace[685150097] transaction","detail":"{read_only:false; response_revision:147; number_of_response:1; }","duration":"100.312038ms","start":"2026-02-18T22:50:27.663587Z","end":"2026-02-18T22:50:27.763899Z","steps":["trace[685150097] 'process raft request' (duration: 74.241457ms)","trace[685150097] 'compare' (duration: 25.96544ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:28.268542Z","caller":"traceutil/trace.go:171","msg":"trace[776265741] transaction","detail":"{read_only:false; response_revision:160; number_of_response:1; }","duration":"118.201754ms","start":"2026-02-18T22:50:28.150312Z","end":"2026-02-18T22:50:28.268514Z","steps":["trace[776265741] 'process raft request' (duration: 54.94536ms)","trace[776265741] 'compare' (duration: 62.653129ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:28.437915Z","caller":"traceutil/trace.go:171","msg":"trace[535897354] transaction","detail":"{read_only:false; response_revision:164; number_of_response:1; }","duration":"108.372798ms","start":"2026-02-18T22:50:28.329512Z","end":"2026-02-18T22:50:28.437884Z","steps":["trace[535897354] 'process raft request' (duration: 63.723106ms)","trace[535897354] 'compare' (duration: 44.507961ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:28.707442Z","caller":"traceutil/trace.go:171","msg":"trace[1246538296] transaction","detail":"{read_only:false; response_revision:169; number_of_response:1; }","duration":"167.944538ms","start":"2026-02-18T22:50:28.539387Z","end":"2026-02-18T22:50:28.707332Z","steps":["trace[1246538296] 'process raft request' (duration: 167.799857ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:28.789529Z","caller":"traceutil/trace.go:171","msg":"trace[157990230] transaction","detail":"{read_only:false; response_revision:170; number_of_response:1; }","duration":"197.926714ms","start":"2026-02-18T22:50:28.591573Z","end":"2026-02-18T22:50:28.7895Z","steps":["trace[157990230] 'process raft request' (duration: 195.516888ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:29.02567Z","caller":"traceutil/trace.go:171","msg":"trace[1494314893] transaction","detail":"{read_only:false; response_revision:174; number_of_response:1; }","duration":"149.046013ms","start":"2026-02-18T22:50:28.876601Z","end":"2026-02-18T22:50:29.025647Z","steps":["trace[1494314893] 'process raft request' (duration: 83.444664ms)","trace[1494314893] 'compare' (duration: 65.300777ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:50:29.775128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.716024ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-18T22:50:29.775436Z","caller":"traceutil/trace.go:171","msg":"trace[2053242707] transaction","detail":"{read_only:false; response_revision:196; number_of_response:1; }","duration":"150.278427ms","start":"2026-02-18T22:50:29.625139Z","end":"2026-02-18T22:50:29.775417Z","steps":["trace[2053242707] 'process raft request' (duration: 150.185126ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:29.775725Z","caller":"traceutil/trace.go:171","msg":"trace[1096708022] transaction","detail":"{read_only:false; response_revision:195; number_of_response:1; }","duration":"151.423465ms","start":"2026-02-18T22:50:29.624259Z","end":"2026-02-18T22:50:29.775682Z","steps":["trace[1096708022] 'process raft request' (duration: 26.614073ms)","trace[1096708022] 'compare' (duration: 123.546623ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:29.90008Z","caller":"traceutil/trace.go:171","msg":"trace[55081827] transaction","detail":"{read_only:false; response_revision:198; number_of_response:1; }","duration":"104.612061ms","start":"2026-02-18T22:50:29.795445Z","end":"2026-02-18T22:50:29.900057Z","steps":["trace[55081827] 'process raft request' (duration: 87.187097ms)","trace[55081827] 'compare' (duration: 17.078731ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:29.900625Z","caller":"traceutil/trace.go:171","msg":"trace[440549093] transaction","detail":"{read_only:false; response_revision:199; number_of_response:1; }","duration":"102.780168ms","start":"2026-02-18T22:50:29.797833Z","end":"2026-02-18T22:50:29.900613Z","steps":["trace[440549093] 'process raft request' (duration: 102.000483ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:30.848774Z","caller":"traceutil/trace.go:171","msg":"trace[1417235012] transaction","detail":"{read_only:false; response_revision:231; number_of_response:1; }","duration":"139.400993ms","start":"2026-02-18T22:50:30.709331Z","end":"2026-02-18T22:50:30.848732Z","steps":["trace[1417235012] 'process raft request' (duration: 109.71703ms)","trace[1417235012] 'compare' (duration: 29.529822ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:50:31.075159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.182318ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T22:50:31.075365Z","caller":"traceutil/trace.go:171","msg":"trace[1551055773] transaction","detail":"{read_only:false; response_revision:237; number_of_response:1; }","duration":"183.357105ms","start":"2026-02-18T22:50:30.891978Z","end":"2026-02-18T22:50:31.075335Z","steps":["trace[1551055773] 'process raft request' (duration: 60.692013ms)","trace[1551055773] 'compare' (duration: 122.009417ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:31.076015Z","caller":"traceutil/trace.go:171","msg":"trace[194043628] linearizableReadLoop","detail":"{readStateIndex:244; appliedIndex:243; }","duration":"176.064268ms","start":"2026-02-18T22:50:30.899891Z","end":"2026-02-18T22:50:31.075955Z","steps":["trace[194043628] 'read index received' (duration: 52.739602ms)","trace[194043628] 'applied index is now lower than readState.Index' (duration: 123.322406ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:50:31.076272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.368419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.189578f49e21d4be\" ","response":"range_response_count:1 size:657"} {"level":"info","ts":"2026-02-18T22:50:31.076466Z","caller":"traceutil/trace.go:171","msg":"trace[1342678494] range","detail":"{range_begin:/registry/events/default/instance.189578f49e21d4be; range_end:; response_count:1; response_revision:237; }","duration":"176.591981ms","start":"2026-02-18T22:50:30.899857Z","end":"2026-02-18T22:50:31.076449Z","steps":["trace[1342678494] 'agreement among raft nodes before linearized reading' (duration: 176.217088ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:31.247682Z","caller":"traceutil/trace.go:171","msg":"trace[845430436] transaction","detail":"{read_only:false; response_revision:243; number_of_response:1; }","duration":"118.380893ms","start":"2026-02-18T22:50:31.129233Z","end":"2026-02-18T22:50:31.247614Z","steps":["trace[845430436] 'process raft request' (duration: 55.704569ms)","trace[845430436] 'compare' (duration: 62.140151ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:31.247708Z","caller":"traceutil/trace.go:171","msg":"trace[1942903246] transaction","detail":"{read_only:false; response_revision:244; number_of_response:1; }","duration":"115.128982ms","start":"2026-02-18T22:50:31.132555Z","end":"2026-02-18T22:50:31.247684Z","steps":["trace[1942903246] 'process raft request' (duration: 114.72457ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:31.416398Z","caller":"traceutil/trace.go:171","msg":"trace[412615144] transaction","detail":"{read_only:false; response_revision:246; number_of_response:1; }","duration":"163.213912ms","start":"2026-02-18T22:50:31.253161Z","end":"2026-02-18T22:50:31.416375Z","steps":["trace[412615144] 'process raft request' (duration: 137.159614ms)","trace[412615144] 'compare' (duration: 25.729156ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:31.416981Z","caller":"traceutil/trace.go:171","msg":"trace[726184515] transaction","detail":"{read_only:false; response_revision:247; number_of_response:1; }","duration":"120.364097ms","start":"2026-02-18T22:50:31.296604Z","end":"2026-02-18T22:50:31.416968Z","steps":["trace[726184515] 'process raft request' (duration: 119.650751ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:31.583343Z","caller":"traceutil/trace.go:171","msg":"trace[783770096] linearizableReadLoop","detail":"{readStateIndex:258; appliedIndex:255; }","duration":"149.837757ms","start":"2026-02-18T22:50:31.433483Z","end":"2026-02-18T22:50:31.583321Z","steps":["trace[783770096] 'read index received' (duration: 69.897191ms)","trace[783770096] 'applied index is now lower than readState.Index' (duration: 79.939306ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:31.583377Z","caller":"traceutil/trace.go:171","msg":"trace[1510662427] transaction","detail":"{read_only:false; response_revision:250; number_of_response:1; }","duration":"153.779402ms","start":"2026-02-18T22:50:31.429562Z","end":"2026-02-18T22:50:31.583342Z","steps":["trace[1510662427] 'process raft request' (duration: 153.662981ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:31.583492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.982468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T22:50:31.583527Z","caller":"traceutil/trace.go:171","msg":"trace[1705089874] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:0; response_revision:251; }","duration":"150.066878ms","start":"2026-02-18T22:50:31.43345Z","end":"2026-02-18T22:50:31.583517Z","steps":["trace[1705089874] 'agreement among raft nodes before linearized reading' (duration: 149.962027ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:31.583744Z","caller":"traceutil/trace.go:171","msg":"trace[2112663695] transaction","detail":"{read_only:false; response_revision:249; number_of_response:1; }","duration":"156.552849ms","start":"2026-02-18T22:50:31.427177Z","end":"2026-02-18T22:50:31.58373Z","steps":["trace[2112663695] 'process raft request' (duration: 148.481077ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:31.583936Z","caller":"traceutil/trace.go:171","msg":"trace[298964807] transaction","detail":"{read_only:false; response_revision:251; number_of_response:1; }","duration":"154.280475ms","start":"2026-02-18T22:50:31.429644Z","end":"2026-02-18T22:50:31.583924Z","steps":["trace[298964807] 'process raft request' (duration: 153.639011ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:31.767186Z","caller":"traceutil/trace.go:171","msg":"trace[1044657394] transaction","detail":"{read_only:false; response_revision:257; number_of_response:1; }","duration":"127.063631ms","start":"2026-02-18T22:50:31.64008Z","end":"2026-02-18T22:50:31.767144Z","steps":["trace[1044657394] 'process raft request' (duration: 51.438173ms)","trace[1044657394] 'compare' (duration: 75.325095ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:31.767564Z","caller":"traceutil/trace.go:171","msg":"trace[984671814] transaction","detail":"{read_only:false; response_revision:258; number_of_response:1; }","duration":"127.324572ms","start":"2026-02-18T22:50:31.640216Z","end":"2026-02-18T22:50:31.76754Z","steps":["trace[984671814] 'process raft request' (duration: 126.851718ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:33.116175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.851378ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-18T22:50:33.116272Z","caller":"traceutil/trace.go:171","msg":"trace[2138740058] linearizableReadLoop","detail":"{readStateIndex:309; appliedIndex:308; }","duration":"289.592357ms","start":"2026-02-18T22:50:32.826666Z","end":"2026-02-18T22:50:33.116258Z","steps":["trace[2138740058] 'read index received' (duration: 108.598388ms)","trace[2138740058] 'applied index is now lower than readState.Index' (duration: 180.991509ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:33.116334Z","caller":"traceutil/trace.go:171","msg":"trace[1992477998] transaction","detail":"{read_only:false; response_revision:302; number_of_response:1; }","duration":"290.758955ms","start":"2026-02-18T22:50:32.825568Z","end":"2026-02-18T22:50:33.116327Z","steps":["trace[1992477998] 'process raft request' (duration: 109.689145ms)","trace[1992477998] 'compare' (duration: 180.690507ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:50:33.11665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.21709ms","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-02-18T22:50:33.116709Z","caller":"traceutil/trace.go:171","msg":"trace[1019528223] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:302; }","duration":"290.296301ms","start":"2026-02-18T22:50:32.826405Z","end":"2026-02-18T22:50:33.116701Z","steps":["trace[1019528223] 'agreement among raft nodes before linearized reading' (duration: 290.16999ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:33.130524Z","caller":"traceutil/trace.go:171","msg":"trace[1975415973] transaction","detail":"{read_only:false; response_revision:303; number_of_response:1; }","duration":"294.033515ms","start":"2026-02-18T22:50:32.836475Z","end":"2026-02-18T22:50:33.130508Z","steps":["trace[1975415973] 'process raft request' (duration: 293.730073ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:33.130754Z","caller":"traceutil/trace.go:171","msg":"trace[721760519] transaction","detail":"{read_only:false; number_of_response:0; response_revision:303; }","duration":"205.375066ms","start":"2026-02-18T22:50:32.925371Z","end":"2026-02-18T22:50:33.130746Z","steps":["trace[721760519] 'process raft request' (duration: 204.913783ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:33.130913Z","caller":"traceutil/trace.go:171","msg":"trace[1941390351] transaction","detail":"{read_only:false; response_revision:304; number_of_response:1; }","duration":"199.73098ms","start":"2026-02-18T22:50:32.931173Z","end":"2026-02-18T22:50:33.130904Z","steps":["trace[1941390351] 'process raft request' (duration: 199.149316ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:33.130936Z","caller":"traceutil/trace.go:171","msg":"trace[975852566] transaction","detail":"{read_only:false; number_of_response:0; response_revision:304; }","duration":"197.743717ms","start":"2026-02-18T22:50:32.933188Z","end":"2026-02-18T22:50:33.130932Z","steps":["trace[975852566] 'process raft request' (duration: 197.176633ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:33.130953Z","caller":"traceutil/trace.go:171","msg":"trace[689737735] transaction","detail":"{read_only:false; number_of_response:0; response_revision:304; }","duration":"197.058152ms","start":"2026-02-18T22:50:32.933891Z","end":"2026-02-18T22:50:33.130949Z","steps":["trace[689737735] 'process raft request' (duration: 196.493898ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:33.131002Z","caller":"traceutil/trace.go:171","msg":"trace[990138462] transaction","detail":"{read_only:false; number_of_response:0; response_revision:304; }","duration":"197.018212ms","start":"2026-02-18T22:50:32.933979Z","end":"2026-02-18T22:50:33.130997Z","steps":["trace[990138462] 'process raft request' (duration: 196.423299ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:33.131024Z","caller":"traceutil/trace.go:171","msg":"trace[1550521936] transaction","detail":"{read_only:false; number_of_response:0; response_revision:304; }","duration":"196.231147ms","start":"2026-02-18T22:50:32.934787Z","end":"2026-02-18T22:50:33.131018Z","steps":["trace[1550521936] 'process raft request' (duration: 195.631944ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:33.131275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.185744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-02-18T22:50:33.135049Z","caller":"traceutil/trace.go:171","msg":"trace[578767835] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:304; }","duration":"292.990919ms","start":"2026-02-18T22:50:32.842042Z","end":"2026-02-18T22:50:33.135033Z","steps":["trace[578767835] 'agreement among raft nodes before linearized reading' (duration: 289.200854ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:33.471618Z","caller":"traceutil/trace.go:171","msg":"trace[15445703] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"100.716664ms","start":"2026-02-18T22:50:33.370171Z","end":"2026-02-18T22:50:33.470888Z","steps":["trace[15445703] 'process raft request' (duration: 25.297401ms)","trace[15445703] 'compare' (duration: 74.9123ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:50:33.740037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.051067ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-18T22:50:33.740189Z","caller":"traceutil/trace.go:171","msg":"trace[1033087495] linearizableReadLoop","detail":"{readStateIndex:333; appliedIndex:331; }","duration":"151.885001ms","start":"2026-02-18T22:50:33.588287Z","end":"2026-02-18T22:50:33.740172Z","steps":["trace[1033087495] 'read index received' (duration: 25.692574ms)","trace[1033087495] 'applied index is now lower than readState.Index' (duration: 126.191457ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:33.740352Z","caller":"traceutil/trace.go:171","msg":"trace[1281834986] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"203.04255ms","start":"2026-02-18T22:50:33.537298Z","end":"2026-02-18T22:50:33.740341Z","steps":["trace[1281834986] 'process raft request' (duration: 76.609511ms)","trace[1281834986] 'compare' (duration: 125.925146ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:33.74057Z","caller":"traceutil/trace.go:171","msg":"trace[1050910674] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"202.880777ms","start":"2026-02-18T22:50:33.537678Z","end":"2026-02-18T22:50:33.740559Z","steps":["trace[1050910674] 'process raft request' (duration: 202.451985ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:33.740794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.496966ms","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-02-18T22:50:33.740827Z","caller":"traceutil/trace.go:171","msg":"trace[150243396] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:321; }","duration":"152.570746ms","start":"2026-02-18T22:50:33.588247Z","end":"2026-02-18T22:50:33.740817Z","steps":["trace[150243396] 'agreement among raft nodes before linearized reading' (duration: 152.468995ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:35.431296Z","caller":"traceutil/trace.go:171","msg":"trace[2077189055] transaction","detail":"{read_only:false; response_revision:341; number_of_response:1; }","duration":"838.605443ms","start":"2026-02-18T22:50:34.592667Z","end":"2026-02-18T22:50:35.431273Z","steps":["trace[2077189055] 'process raft request' (duration: 838.482562ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:35.431434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:34.592647Z","time spent":"838.717165ms","remote":"127.0.0.1:49676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":199,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-18T22:50:35.441306Z","caller":"traceutil/trace.go:171","msg":"trace[362064387] linearizableReadLoop","detail":"{readStateIndex:358; appliedIndex:356; }","duration":"262.768198ms","start":"2026-02-18T22:50:35.178524Z","end":"2026-02-18T22:50:35.441293Z","steps":["trace[362064387] 'read index received' (duration: 252.668124ms)","trace[362064387] 'applied index is now lower than readState.Index' (duration: 10.099544ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:50:35.441428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.901259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-18T22:50:35.441445Z","caller":"traceutil/trace.go:171","msg":"trace[1309372868] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:342; }","duration":"262.971509ms","start":"2026-02-18T22:50:35.178468Z","end":"2026-02-18T22:50:35.44144Z","steps":["trace[1309372868] 'agreement among raft nodes before linearized reading' (duration: 262.882548ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:35.441627Z","caller":"traceutil/trace.go:171","msg":"trace[370206126] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"719.379743ms","start":"2026-02-18T22:50:34.722242Z","end":"2026-02-18T22:50:35.441622Z","steps":["trace[370206126] 'process raft request' (duration: 718.976071ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:35.44168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:34.722212Z","time spent":"719.428203ms","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T22:50:35.441769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.089873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-18T22:50:35.441782Z","caller":"traceutil/trace.go:171","msg":"trace[537769848] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:342; }","duration":"243.103103ms","start":"2026-02-18T22:50:35.198675Z","end":"2026-02-18T22:50:35.441778Z","steps":["trace[537769848] 'agreement among raft nodes before linearized reading' (duration: 243.076583ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:35.884429Z","caller":"traceutil/trace.go:171","msg":"trace[2059879101] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"116.792811ms","start":"2026-02-18T22:50:35.767619Z","end":"2026-02-18T22:50:35.884412Z","steps":["trace[2059879101] 'process raft request' (duration: 116.302188ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:36.070422Z","caller":"traceutil/trace.go:171","msg":"trace[696559985] linearizableReadLoop","detail":"{readStateIndex:371; appliedIndex:370; }","duration":"128.784456ms","start":"2026-02-18T22:50:35.941617Z","end":"2026-02-18T22:50:36.070402Z","steps":["trace[696559985] 'read index received' (duration: 73.857228ms)","trace[696559985] 'applied index is now lower than readState.Index' (duration: 54.926548ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:36.070531Z","caller":"traceutil/trace.go:171","msg":"trace[1270573273] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"135.334337ms","start":"2026-02-18T22:50:35.935187Z","end":"2026-02-18T22:50:36.070522Z","steps":["trace[1270573273] 'process raft request' (duration: 80.34648ms)","trace[1270573273] 'compare' (duration: 54.769476ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:50:36.070687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.060117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-02-18T22:50:36.070719Z","caller":"traceutil/trace.go:171","msg":"trace[69272775] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:355; }","duration":"129.129287ms","start":"2026-02-18T22:50:35.941583Z","end":"2026-02-18T22:50:36.070712Z","steps":["trace[69272775] 'agreement among raft nodes before linearized reading' (duration: 129.052537ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:36.275048Z","caller":"traceutil/trace.go:171","msg":"trace[1048408556] linearizableReadLoop","detail":"{readStateIndex:372; appliedIndex:371; }","duration":"184.047793ms","start":"2026-02-18T22:50:36.09098Z","end":"2026-02-18T22:50:36.275027Z","steps":["trace[1048408556] 'read index received' (duration: 152.516593ms)","trace[1048408556] 'applied index is now lower than readState.Index' (duration: 31.53051ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:36.275147Z","caller":"traceutil/trace.go:171","msg":"trace[1551056330] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"188.472602ms","start":"2026-02-18T22:50:36.086666Z","end":"2026-02-18T22:50:36.275139Z","steps":["trace[1551056330] 'process raft request' (duration: 156.884692ms)","trace[1551056330] 'compare' (duration: 31.317218ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:50:36.275282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.295375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-18T22:50:36.275298Z","caller":"traceutil/trace.go:171","msg":"trace[752987217] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:356; }","duration":"184.368616ms","start":"2026-02-18T22:50:36.090925Z","end":"2026-02-18T22:50:36.275293Z","steps":["trace[752987217] 'agreement among raft nodes before linearized reading' (duration: 184.316675ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:36.27544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.264993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-02-18T22:50:36.275452Z","caller":"traceutil/trace.go:171","msg":"trace[1516000512] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:356; }","duration":"133.307993ms","start":"2026-02-18T22:50:36.14214Z","end":"2026-02-18T22:50:36.275448Z","steps":["trace[1516000512] 'agreement among raft nodes before linearized reading' (duration: 133.285173ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:36.511097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.60047ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T22:50:36.51171Z","caller":"traceutil/trace.go:171","msg":"trace[488384548] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"156.9593ms","start":"2026-02-18T22:50:36.354728Z","end":"2026-02-18T22:50:36.511687Z","steps":["trace[488384548] 'process raft request' (duration: 36.685462ms)","trace[488384548] 'compare' (duration: 119.449729ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:36.513451Z","caller":"traceutil/trace.go:171","msg":"trace[2139917842] linearizableReadLoop","detail":"{readStateIndex:375; appliedIndex:372; }","duration":"120.348978ms","start":"2026-02-18T22:50:36.39309Z","end":"2026-02-18T22:50:36.513439Z","steps":["trace[2139917842] 'read index received' (duration: 117.686657ms)","trace[2139917842] 'applied index is now lower than readState.Index' (duration: 2.661701ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:36.515622Z","caller":"traceutil/trace.go:171","msg":"trace[1444382096] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"160.676815ms","start":"2026-02-18T22:50:36.35493Z","end":"2026-02-18T22:50:36.515607Z","steps":["trace[1444382096] 'process raft request' (duration: 156.262713ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:36.518571Z","caller":"traceutil/trace.go:171","msg":"trace[2055572761] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"163.580249ms","start":"2026-02-18T22:50:36.354975Z","end":"2026-02-18T22:50:36.518555Z","steps":["trace[2055572761] 'process raft request' (duration: 158.397318ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:36.51899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.867912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-02-18T22:50:36.519036Z","caller":"traceutil/trace.go:171","msg":"trace[218871500] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:359; }","duration":"125.975243ms","start":"2026-02-18T22:50:36.393049Z","end":"2026-02-18T22:50:36.519024Z","steps":["trace[218871500] 'agreement among raft nodes before linearized reading' (duration: 125.872992ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:36.781151Z","caller":"traceutil/trace.go:171","msg":"trace[1565133935] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"254.987832ms","start":"2026-02-18T22:50:36.526142Z","end":"2026-02-18T22:50:36.78113Z","steps":["trace[1565133935] 'process raft request' (duration: 168.877149ms)","trace[1565133935] 'compare' (duration: 86.024132ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:36.805091Z","caller":"traceutil/trace.go:171","msg":"trace[794736456] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"278.02917ms","start":"2026-02-18T22:50:36.527043Z","end":"2026-02-18T22:50:36.805072Z","steps":["trace[794736456] 'process raft request' (duration: 277.889779ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:36.805303Z","caller":"traceutil/trace.go:171","msg":"trace[1320382299] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"263.541851ms","start":"2026-02-18T22:50:36.541754Z","end":"2026-02-18T22:50:36.805296Z","steps":["trace[1320382299] 'process raft request' (duration: 263.274648ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:36.805695Z","caller":"traceutil/trace.go:171","msg":"trace[762246176] linearizableReadLoop","detail":"{readStateIndex:380; appliedIndex:375; }","duration":"257.123746ms","start":"2026-02-18T22:50:36.548564Z","end":"2026-02-18T22:50:36.805688Z","steps":["trace[762246176] 'read index received' (duration: 146.524168ms)","trace[762246176] 'applied index is now lower than readState.Index' (duration: 110.598828ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:36.805748Z","caller":"traceutil/trace.go:171","msg":"trace[303001050] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"263.936366ms","start":"2026-02-18T22:50:36.541807Z","end":"2026-02-18T22:50:36.805743Z","steps":["trace[303001050] 'process raft request' (duration: 263.454861ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:36.805831Z","caller":"traceutil/trace.go:171","msg":"trace[500172619] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"253.981559ms","start":"2026-02-18T22:50:36.551842Z","end":"2026-02-18T22:50:36.805824Z","steps":["trace[500172619] 'process raft request' (duration: 253.820377ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:36.805945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.364989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-02-18T22:50:36.805963Z","caller":"traceutil/trace.go:171","msg":"trace[1744664098] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:366; }","duration":"257.42015ms","start":"2026-02-18T22:50:36.548538Z","end":"2026-02-18T22:50:36.805958Z","steps":["trace[1744664098] 'agreement among raft nodes before linearized reading' (duration: 257.36549ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:36.806068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.108435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-18T22:50:36.80604Z","caller":"traceutil/trace.go:171","msg":"trace[427642823] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"264.104498ms","start":"2026-02-18T22:50:36.54191Z","end":"2026-02-18T22:50:36.806015Z","steps":["trace[427642823] 'process raft request' (duration: 263.684533ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:36.806087Z","caller":"traceutil/trace.go:171","msg":"trace[2050536743] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:366; }","duration":"214.127555ms","start":"2026-02-18T22:50:36.591953Z","end":"2026-02-18T22:50:36.806081Z","steps":["trace[2050536743] 'agreement among raft nodes before linearized reading' (duration: 214.091414ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:36.806265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.647534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-02-18T22:50:36.806279Z","caller":"traceutil/trace.go:171","msg":"trace[1693056761] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:366; }","duration":"113.696295ms","start":"2026-02-18T22:50:36.692578Z","end":"2026-02-18T22:50:36.806275Z","steps":["trace[1693056761] 'agreement among raft nodes before linearized reading' (duration: 113.669705ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:36.806339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.816209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-18T22:50:36.806336Z","caller":"traceutil/trace.go:171","msg":"trace[1199166792] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"256.977754ms","start":"2026-02-18T22:50:36.549316Z","end":"2026-02-18T22:50:36.806294Z","steps":["trace[1199166792] 'process raft request' (duration: 256.307977ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:36.806355Z","caller":"traceutil/trace.go:171","msg":"trace[868169872] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:366; }","duration":"163.870629ms","start":"2026-02-18T22:50:36.642481Z","end":"2026-02-18T22:50:36.806352Z","steps":["trace[868169872] 'agreement among raft nodes before linearized reading' (duration: 163.842159ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:37.111679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.863532ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T22:50:37.112043Z","caller":"traceutil/trace.go:171","msg":"trace[1513997859] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"267.012147ms","start":"2026-02-18T22:50:36.845012Z","end":"2026-02-18T22:50:37.112024Z","steps":["trace[1513997859] 'process raft request' (duration: 266.974434ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:37.112191Z","caller":"traceutil/trace.go:171","msg":"trace[619351831] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"267.894193ms","start":"2026-02-18T22:50:36.844266Z","end":"2026-02-18T22:50:37.11216Z","steps":["trace[619351831] 'process raft request' (duration: 153.467909ms)","trace[619351831] 'compare' (duration: 113.722005ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:37.112278Z","caller":"traceutil/trace.go:171","msg":"trace[521744276] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"267.810236ms","start":"2026-02-18T22:50:36.844457Z","end":"2026-02-18T22:50:37.112267Z","steps":["trace[521744276] 'process raft request' (duration: 267.425615ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:37.112434Z","caller":"traceutil/trace.go:171","msg":"trace[1283282177] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"268.106276ms","start":"2026-02-18T22:50:36.844311Z","end":"2026-02-18T22:50:37.112417Z","steps":["trace[1283282177] 'process raft request' (duration: 267.456961ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:37.112497Z","caller":"traceutil/trace.go:171","msg":"trace[878519769] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"267.974717ms","start":"2026-02-18T22:50:36.844487Z","end":"2026-02-18T22:50:37.112462Z","steps":["trace[878519769] 'process raft request' (duration: 267.434697ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:37.112682Z","caller":"traceutil/trace.go:171","msg":"trace[80887331] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"267.777063ms","start":"2026-02-18T22:50:36.844897Z","end":"2026-02-18T22:50:37.112674Z","steps":["trace[80887331] 'process raft request' (duration: 267.053073ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:37.112816Z","caller":"traceutil/trace.go:171","msg":"trace[1219132231] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"268.445826ms","start":"2026-02-18T22:50:36.844355Z","end":"2026-02-18T22:50:37.112801Z","steps":["trace[1219132231] 'process raft request' (duration: 267.463412ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:37.308723Z","caller":"traceutil/trace.go:171","msg":"trace[1252532817] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"183.913892ms","start":"2026-02-18T22:50:37.124782Z","end":"2026-02-18T22:50:37.308696Z","steps":["trace[1252532817] 'process raft request' (duration: 94.910694ms)","trace[1252532817] 'compare' (duration: 88.714053ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:37.309132Z","caller":"traceutil/trace.go:171","msg":"trace[954786236] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"160.90476ms","start":"2026-02-18T22:50:37.148216Z","end":"2026-02-18T22:50:37.30912Z","steps":["trace[954786236] 'process raft request' (duration: 160.870798ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:37.309434Z","caller":"traceutil/trace.go:171","msg":"trace[41629465] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"184.571767ms","start":"2026-02-18T22:50:37.124845Z","end":"2026-02-18T22:50:37.309417Z","steps":["trace[41629465] 'process raft request' (duration: 183.797716ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:37.309801Z","caller":"traceutil/trace.go:171","msg":"trace[1315682684] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"184.904894ms","start":"2026-02-18T22:50:37.124881Z","end":"2026-02-18T22:50:37.309786Z","steps":["trace[1315682684] 'process raft request' (duration: 184.090111ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:37.310076Z","caller":"traceutil/trace.go:171","msg":"trace[2006022289] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"185.018701ms","start":"2026-02-18T22:50:37.125046Z","end":"2026-02-18T22:50:37.310065Z","steps":["trace[2006022289] 'process raft request' (duration: 183.997737ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:37.310299Z","caller":"traceutil/trace.go:171","msg":"trace[546529837] linearizableReadLoop","detail":"{readStateIndex:395; appliedIndex:391; }","duration":"183.979924ms","start":"2026-02-18T22:50:37.126307Z","end":"2026-02-18T22:50:37.310287Z","steps":["trace[546529837] 'read index received' (duration: 18.466598ms)","trace[546529837] 'applied index is now lower than readState.Index' (duration: 165.511566ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:50:37.310442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.117642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-18T22:50:37.310536Z","caller":"traceutil/trace.go:171","msg":"trace[267843226] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:380; }","duration":"184.244589ms","start":"2026-02-18T22:50:37.126279Z","end":"2026-02-18T22:50:37.310524Z","steps":["trace[267843226] 'agreement among raft nodes before linearized reading' (duration: 184.054448ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:37.467292Z","caller":"traceutil/trace.go:171","msg":"trace[131652769] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"145.099963ms","start":"2026-02-18T22:50:37.321973Z","end":"2026-02-18T22:50:37.467073Z","steps":["trace[131652769] 'process raft request' (duration: 86.781959ms)","trace[131652769] 'compare' (duration: 58.182027ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:37.475189Z","caller":"traceutil/trace.go:171","msg":"trace[1236549068] linearizableReadLoop","detail":"{readStateIndex:402; appliedIndex:396; }","duration":"136.960437ms","start":"2026-02-18T22:50:37.33821Z","end":"2026-02-18T22:50:37.47517Z","steps":["trace[1236549068] 'read index received' (duration: 70.19312ms)","trace[1236549068] 'applied index is now lower than readState.Index' (duration: 66.766487ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:37.475574Z","caller":"traceutil/trace.go:171","msg":"trace[612363469] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"149.109788ms","start":"2026-02-18T22:50:37.326447Z","end":"2026-02-18T22:50:37.475557Z","steps":["trace[612363469] 'process raft request' (duration: 148.431291ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:37.476025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.794951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:3684"} {"level":"info","ts":"2026-02-18T22:50:37.476126Z","caller":"traceutil/trace.go:171","msg":"trace[879432081] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:386; }","duration":"137.930169ms","start":"2026-02-18T22:50:37.338183Z","end":"2026-02-18T22:50:37.476113Z","steps":["trace[879432081] 'agreement among raft nodes before linearized reading' (duration: 137.783621ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:37.475774Z","caller":"traceutil/trace.go:171","msg":"trace[331421569] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"149.199882ms","start":"2026-02-18T22:50:37.326553Z","end":"2026-02-18T22:50:37.475753Z","steps":["trace[331421569] 'process raft request' (duration: 148.444312ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:37.475831Z","caller":"traceutil/trace.go:171","msg":"trace[857408833] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"148.59337ms","start":"2026-02-18T22:50:37.327222Z","end":"2026-02-18T22:50:37.475815Z","steps":["trace[857408833] 'process raft request' (duration: 147.877822ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:37.475945Z","caller":"traceutil/trace.go:171","msg":"trace[163683126] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"142.226018ms","start":"2026-02-18T22:50:37.33371Z","end":"2026-02-18T22:50:37.475936Z","steps":["trace[163683126] 'process raft request' (duration: 141.427365ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:37.475961Z","caller":"traceutil/trace.go:171","msg":"trace[435610975] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"148.894636ms","start":"2026-02-18T22:50:37.327059Z","end":"2026-02-18T22:50:37.475954Z","steps":["trace[435610975] 'process raft request' (duration: 147.994998ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:37.766708Z","caller":"traceutil/trace.go:171","msg":"trace[1361875182] linearizableReadLoop","detail":"{readStateIndex:412; appliedIndex:404; }","duration":"100.857113ms","start":"2026-02-18T22:50:37.665836Z","end":"2026-02-18T22:50:37.766693Z","steps":["trace[1361875182] 'read index received' (duration: 16.97805ms)","trace[1361875182] 'applied index is now lower than readState.Index' (duration: 83.878253ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:50:37.766831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.989569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-02-18T22:50:37.766849Z","caller":"traceutil/trace.go:171","msg":"trace[1862349081] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:396; }","duration":"101.066604ms","start":"2026-02-18T22:50:37.665777Z","end":"2026-02-18T22:50:37.766844Z","steps":["trace[1862349081] 'agreement among raft nodes before linearized reading' (duration: 100.999271ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:37.767054Z","caller":"traceutil/trace.go:171","msg":"trace[1779266305] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"280.019581ms","start":"2026-02-18T22:50:37.487028Z","end":"2026-02-18T22:50:37.767048Z","steps":["trace[1779266305] 'process raft request' (duration: 195.842312ms)","trace[1779266305] 'compare' (duration: 83.4409ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:37.767852Z","caller":"traceutil/trace.go:171","msg":"trace[1207732265] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"280.758452ms","start":"2026-02-18T22:50:37.487086Z","end":"2026-02-18T22:50:37.767844Z","steps":["trace[1207732265] 'process raft request' (duration: 279.357826ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:37.767904Z","caller":"traceutil/trace.go:171","msg":"trace[1914046841] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"277.462604ms","start":"2026-02-18T22:50:37.490438Z","end":"2026-02-18T22:50:37.767901Z","steps":["trace[1914046841] 'process raft request' (duration: 276.028896ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:37.768022Z","caller":"traceutil/trace.go:171","msg":"trace[167172167] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"277.481315ms","start":"2026-02-18T22:50:37.490536Z","end":"2026-02-18T22:50:37.768017Z","steps":["trace[167172167] 'process raft request' (duration: 275.952743ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:37.768081Z","caller":"traceutil/trace.go:171","msg":"trace[1836939993] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"276.734055ms","start":"2026-02-18T22:50:37.491344Z","end":"2026-02-18T22:50:37.768078Z","steps":["trace[1836939993] 'process raft request' (duration: 275.171851ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:37.768175Z","caller":"traceutil/trace.go:171","msg":"trace[1116928737] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"275.762013ms","start":"2026-02-18T22:50:37.492409Z","end":"2026-02-18T22:50:37.768171Z","steps":["trace[1116928737] 'process raft request' (duration: 274.137546ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:37.768229Z","caller":"traceutil/trace.go:171","msg":"trace[2103105161] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"274.731458ms","start":"2026-02-18T22:50:37.493492Z","end":"2026-02-18T22:50:37.768224Z","steps":["trace[2103105161] 'process raft request' (duration: 273.10475ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:37.768278Z","caller":"traceutil/trace.go:171","msg":"trace[1457914810] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"274.503756ms","start":"2026-02-18T22:50:37.49377Z","end":"2026-02-18T22:50:37.768274Z","steps":["trace[1457914810] 'process raft request' (duration: 272.852537ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:38.197834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.278233ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T22:50:38.198036Z","caller":"traceutil/trace.go:171","msg":"trace[321404512] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"416.213009ms","start":"2026-02-18T22:50:37.781722Z","end":"2026-02-18T22:50:38.197935Z","steps":["trace[321404512] 'process raft request' (duration: 108.742215ms)","trace[321404512] 'compare' (duration: 307.094034ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:50:38.198136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:37.781703Z","time spent":"416.383408ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3737,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T22:50:38.208134Z","caller":"traceutil/trace.go:171","msg":"trace[20062134] linearizableReadLoop","detail":"{readStateIndex:414; appliedIndex:412; }","duration":"426.103002ms","start":"2026-02-18T22:50:37.782013Z","end":"2026-02-18T22:50:38.208116Z","steps":["trace[20062134] 'read index received' (duration: 108.46459ms)","trace[20062134] 'applied index is now lower than readState.Index' (duration: 317.637482ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:38.208231Z","caller":"traceutil/trace.go:171","msg":"trace[1682032838] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"420.692512ms","start":"2026-02-18T22:50:37.787528Z","end":"2026-02-18T22:50:38.208221Z","steps":["trace[1682032838] 'process raft request' (duration: 420.499432ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:38.208316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:37.787518Z","time spent":"420.738644ms","remote":"127.0.0.1:49660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3979,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T22:50:38.208516Z","caller":"traceutil/trace.go:171","msg":"trace[814964383] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"420.47421ms","start":"2026-02-18T22:50:37.788029Z","end":"2026-02-18T22:50:38.208503Z","steps":["trace[814964383] 'process raft request' (duration: 420.056138ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:38.208568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:37.788021Z","time spent":"420.520333ms","remote":"127.0.0.1:49552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-18T22:50:38.208775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.755656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-2tczb\" ","response":"range_response_count:1 size:4421"} {"level":"info","ts":"2026-02-18T22:50:38.208852Z","caller":"traceutil/trace.go:171","msg":"trace[804829331] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-2tczb; range_end:; response_count:1; response_revision:400; }","duration":"426.814529ms","start":"2026-02-18T22:50:37.781991Z","end":"2026-02-18T22:50:38.208805Z","steps":["trace[804829331] 'agreement among raft nodes before linearized reading' (duration: 426.695133ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:38.208884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:37.781986Z","time spent":"426.891114ms","remote":"127.0.0.1:49660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":4444,"request content":"key:\"/registry/pods/kube-system/kube-proxy-2tczb\" "} {"level":"info","ts":"2026-02-18T22:50:38.209526Z","caller":"traceutil/trace.go:171","msg":"trace[917499814] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"427.552318ms","start":"2026-02-18T22:50:37.781961Z","end":"2026-02-18T22:50:38.209514Z","steps":["trace[917499814] 'process raft request' (duration: 425.954614ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:38.209595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:37.781954Z","time spent":"427.612461ms","remote":"127.0.0.1:49552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-18T22:50:38.27054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.402951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4260"} {"level":"info","ts":"2026-02-18T22:50:38.270618Z","caller":"traceutil/trace.go:171","msg":"trace[1233772039] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:401; }","duration":"441.489396ms","start":"2026-02-18T22:50:37.829113Z","end":"2026-02-18T22:50:38.270602Z","steps":["trace[1233772039] 'agreement among raft nodes before linearized reading' (duration: 441.345098ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:38.270658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:37.82907Z","time spent":"441.57962ms","remote":"127.0.0.1:49660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4283,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"warn","ts":"2026-02-18T22:50:38.270878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.131382ms","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-02-18T22:50:38.270915Z","caller":"traceutil/trace.go:171","msg":"trace[541245278] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:401; }","duration":"342.168514ms","start":"2026-02-18T22:50:37.928737Z","end":"2026-02-18T22:50:38.270906Z","steps":["trace[541245278] 'agreement among raft nodes before linearized reading' (duration: 342.109761ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:38.270944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:37.928727Z","time spent":"342.211586ms","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-18T22:50:38.271126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.09302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-18T22:50:38.271162Z","caller":"traceutil/trace.go:171","msg":"trace[1865147733] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:401; }","duration":"356.205716ms","start":"2026-02-18T22:50:37.914948Z","end":"2026-02-18T22:50:38.271153Z","steps":["trace[1865147733] 'agreement among raft nodes before linearized reading' (duration: 356.150183ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:38.271188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:37.914915Z","time spent":"356.267549ms","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-18T22:50:38.381006Z","caller":"traceutil/trace.go:171","msg":"trace[693407361] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"101.531271ms","start":"2026-02-18T22:50:38.279454Z","end":"2026-02-18T22:50:38.380985Z","steps":["trace[693407361] 'process raft request' (duration: 38.951831ms)","trace[693407361] 'compare' (duration: 62.3959ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:38.381902Z","caller":"traceutil/trace.go:171","msg":"trace[1970629616] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"100.847816ms","start":"2026-02-18T22:50:38.281045Z","end":"2026-02-18T22:50:38.381893Z","steps":["trace[1970629616] 'process raft request' (duration: 100.566201ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:38.381979Z","caller":"traceutil/trace.go:171","msg":"trace[1263967613] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"100.867456ms","start":"2026-02-18T22:50:38.281106Z","end":"2026-02-18T22:50:38.381973Z","steps":["trace[1263967613] 'process raft request' (duration: 100.548139ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:38.381999Z","caller":"traceutil/trace.go:171","msg":"trace[918788455] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"100.441094ms","start":"2026-02-18T22:50:38.281554Z","end":"2026-02-18T22:50:38.381995Z","steps":["trace[918788455] 'process raft request' (duration: 100.130298ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:38.915836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.666077ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T22:50:38.916293Z","caller":"traceutil/trace.go:171","msg":"trace[115087316] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"485.873055ms","start":"2026-02-18T22:50:38.4304Z","end":"2026-02-18T22:50:38.916273Z","steps":["trace[115087316] 'process raft request' (duration: 215.689261ms)","trace[115087316] 'compare' (duration: 269.576611ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:50:38.916358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:38.430389Z","time spent":"485.937489ms","remote":"127.0.0.1:49660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4053,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T22:50:39.226458Z","caller":"traceutil/trace.go:171","msg":"trace[1784747119] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"299.655779ms","start":"2026-02-18T22:50:38.926775Z","end":"2026-02-18T22:50:39.226431Z","steps":["trace[1784747119] 'process raft request' (duration: 239.999662ms)","trace[1784747119] 'compare' (duration: 59.562863ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:50:39.226844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:38.92675Z","time spent":"300.024528ms","remote":"127.0.0.1:49660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7030,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T22:50:40.040133Z","caller":"traceutil/trace.go:171","msg":"trace[193062075] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"115.501134ms","start":"2026-02-18T22:50:39.924613Z","end":"2026-02-18T22:50:40.040114Z","steps":["trace[193062075] 'process raft request' (duration: 115.119214ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:40.659468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.084044ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"warn","ts":"2026-02-18T22:50:40.659666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:40.076009Z","time spent":"583.653229ms","remote":"127.0.0.1:50038","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-18T22:50:40.659604Z","caller":"traceutil/trace.go:171","msg":"trace[2092332192] linearizableReadLoop","detail":"{readStateIndex:430; appliedIndex:429; }","duration":"530.064813ms","start":"2026-02-18T22:50:40.129519Z","end":"2026-02-18T22:50:40.659584Z","steps":["trace[2092332192] 'read index received' (duration: 26.071µs)","trace[2092332192] 'applied index is now lower than readState.Index' (duration: 530.036622ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:50:40.660233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.711356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T22:50:40.66027Z","caller":"traceutil/trace.go:171","msg":"trace[753507337] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:413; }","duration":"530.79618ms","start":"2026-02-18T22:50:40.12946Z","end":"2026-02-18T22:50:40.660256Z","steps":["trace[753507337] 'agreement among raft nodes before linearized reading' (duration: 530.710966ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:40.660302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:40.129442Z","time spent":"530.853163ms","remote":"127.0.0.1:49472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-18T22:50:40.700737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.05823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-18T22:50:40.701012Z","caller":"traceutil/trace.go:171","msg":"trace[989197701] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:414; }","duration":"310.349096ms","start":"2026-02-18T22:50:40.390643Z","end":"2026-02-18T22:50:40.700992Z","steps":["trace[989197701] 'agreement among raft nodes before linearized reading' (duration: 310.029018ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:40.701375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:40.390627Z","time spent":"310.682352ms","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-18T22:50:40.701739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.773748ms","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-02-18T22:50:40.701922Z","caller":"traceutil/trace.go:171","msg":"trace[1804916844] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:414; }","duration":"311.98945ms","start":"2026-02-18T22:50:40.389918Z","end":"2026-02-18T22:50:40.701908Z","steps":["trace[1804916844] 'agreement among raft nodes before linearized reading' (duration: 311.775699ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:40.702092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:40.389903Z","time spent":"312.107135ms","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-18T22:50:41.043352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.116137ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T22:50:41.043624Z","caller":"traceutil/trace.go:171","msg":"trace[1468571283] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"332.980969ms","start":"2026-02-18T22:50:40.710616Z","end":"2026-02-18T22:50:41.043597Z","steps":["trace[1468571283] 'process raft request' (duration: 55.537446ms)","trace[1468571283] 'compare' (duration: 277.004431ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:41.043665Z","caller":"traceutil/trace.go:171","msg":"trace[245450199] linearizableReadLoop","detail":"{readStateIndex:434; appliedIndex:431; }","duration":"112.437108ms","start":"2026-02-18T22:50:40.931212Z","end":"2026-02-18T22:50:41.043649Z","steps":["trace[245450199] 'read index received' (duration: 8.306178ms)","trace[245450199] 'applied index is now lower than readState.Index' (duration: 104.13014ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:50:41.043743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.535293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-2tczb\" ","response":"range_response_count:1 size:4421"} {"level":"warn","ts":"2026-02-18T22:50:41.043746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:40.710598Z","time spent":"333.079274ms","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T22:50:41.043764Z","caller":"traceutil/trace.go:171","msg":"trace[271998036] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-2tczb; range_end:; response_count:1; response_revision:416; }","duration":"112.594796ms","start":"2026-02-18T22:50:40.931161Z","end":"2026-02-18T22:50:41.043756Z","steps":["trace[271998036] 'agreement among raft nodes before linearized reading' (duration: 112.530423ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:41.044007Z","caller":"traceutil/trace.go:171","msg":"trace[232755230] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"331.462051ms","start":"2026-02-18T22:50:40.712536Z","end":"2026-02-18T22:50:41.043998Z","steps":["trace[232755230] 'process raft request' (duration: 331.06232ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:41.044012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:40.710873Z","time spent":"333.137707ms","remote":"127.0.0.1:49508","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-18T22:50:41.044053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:40.712512Z","time spent":"331.514523ms","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T22:50:42.291665Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356763506418000011,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T22:50:42.79246Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356763506418000011,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T22:50:42.834857Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.782075648s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-18T22:50:42.846434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.322896728s","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-02-18T22:50:42.846562Z","caller":"traceutil/trace.go:171","msg":"trace[975693618] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"1.79383271s","start":"2026-02-18T22:50:41.052694Z","end":"2026-02-18T22:50:42.846527Z","steps":["trace[975693618] 'process raft request' (duration: 1.782357322s)","trace[975693618] 'compare' (duration: 11.375993ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:42.846598Z","caller":"traceutil/trace.go:171","msg":"trace[993821175] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:416; }","duration":"1.323073957s","start":"2026-02-18T22:50:41.523508Z","end":"2026-02-18T22:50:42.846582Z","steps":["trace[993821175] 'range keys from in-memory index tree' (duration: 1.322873267s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:42.846687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:41.052671Z","time spent":"1.793945116s","remote":"127.0.0.1:49508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T22:50:43.009214Z","caller":"traceutil/trace.go:171","msg":"trace[432350085] linearizableReadLoop","detail":"{readStateIndex:436; appliedIndex:434; }","duration":"1.218374998s","start":"2026-02-18T22:50:41.790815Z","end":"2026-02-18T22:50:43.00919Z","steps":["trace[432350085] 'read index received' (duration: 1.044247413s)","trace[432350085] 'applied index is now lower than readState.Index' (duration: 174.126675ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:43.009301Z","caller":"traceutil/trace.go:171","msg":"trace[242797025] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"1.952373667s","start":"2026-02-18T22:50:41.056918Z","end":"2026-02-18T22:50:43.009292Z","steps":["trace[242797025] 'process raft request' (duration: 1.932295557s)","trace[242797025] 'compare' (duration: 19.87379ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:50:43.009406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:41.056906Z","time spent":"1.95241672s","remote":"127.0.0.1:49660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4400,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T22:50:43.009555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.210211392s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-18T22:50:43.009621Z","caller":"traceutil/trace.go:171","msg":"trace[1653459764] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:418; }","duration":"1.210286026s","start":"2026-02-18T22:50:41.799317Z","end":"2026-02-18T22:50:43.009603Z","steps":["trace[1653459764] 'agreement among raft nodes before linearized reading' (duration: 1.21017507s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:43.009698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:41.799281Z","time spent":"1.210387101s","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-18T22:50:43.009708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.887418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-02-18T22:50:43.009735Z","caller":"traceutil/trace.go:171","msg":"trace[803107219] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:418; }","duration":"160.91435ms","start":"2026-02-18T22:50:42.848813Z","end":"2026-02-18T22:50:43.009727Z","steps":["trace[803107219] 'agreement among raft nodes before linearized reading' (duration: 160.847736ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:43.009841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.219025401s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-18T22:50:43.00986Z","caller":"traceutil/trace.go:171","msg":"trace[645889588] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:418; }","duration":"1.219071593s","start":"2026-02-18T22:50:41.79078Z","end":"2026-02-18T22:50:43.009852Z","steps":["trace[645889588] 'agreement among raft nodes before linearized reading' (duration: 1.219039781s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:43.009881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:41.790765Z","time spent":"1.219112425s","remote":"127.0.0.1:49736","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-02-18T22:50:43.009894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"882.026941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T22:50:43.009926Z","caller":"traceutil/trace.go:171","msg":"trace[1159729037] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:418; }","duration":"882.095174ms","start":"2026-02-18T22:50:42.127821Z","end":"2026-02-18T22:50:43.009916Z","steps":["trace[1159729037] 'agreement among raft nodes before linearized reading' (duration: 882.046662ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:43.009973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:42.127802Z","time spent":"882.165128ms","remote":"127.0.0.1:49472","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-02-18T22:50:43.166716Z","caller":"traceutil/trace.go:171","msg":"trace[587754446] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"147.998959ms","start":"2026-02-18T22:50:43.018582Z","end":"2026-02-18T22:50:43.166581Z","steps":["trace[587754446] 'process raft request' (duration: 147.487354ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:43.167728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.900574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:4729"} {"level":"info","ts":"2026-02-18T22:50:43.167796Z","caller":"traceutil/trace.go:171","msg":"trace[2108939516] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:419; }","duration":"148.993229ms","start":"2026-02-18T22:50:43.018785Z","end":"2026-02-18T22:50:43.167779Z","steps":["trace[2108939516] 'agreement among raft nodes before linearized reading' (duration: 148.736056ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:43.167438Z","caller":"traceutil/trace.go:171","msg":"trace[1871397130] linearizableReadLoop","detail":"{readStateIndex:437; appliedIndex:437; }","duration":"148.585869ms","start":"2026-02-18T22:50:43.018795Z","end":"2026-02-18T22:50:43.167381Z","steps":["trace[1871397130] 'read index received' (duration: 148.575768ms)","trace[1871397130] 'applied index is now lower than readState.Index' (duration: 7.911µs)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:43.399488Z","caller":"traceutil/trace.go:171","msg":"trace[1898522957] linearizableReadLoop","detail":"{readStateIndex:439; appliedIndex:437; }","duration":"230.777237ms","start":"2026-02-18T22:50:43.168685Z","end":"2026-02-18T22:50:43.399463Z","steps":["trace[1898522957] 'read index received' (duration: 173.621384ms)","trace[1898522957] 'applied index is now lower than readState.Index' (duration: 57.154743ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:50:43.400417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.826337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-18T22:50:43.400475Z","caller":"traceutil/trace.go:171","msg":"trace[235827277] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:421; }","duration":"344.933792ms","start":"2026-02-18T22:50:43.055531Z","end":"2026-02-18T22:50:43.400464Z","steps":["trace[235827277] 'agreement among raft nodes before linearized reading' (duration: 344.051689ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:43.40069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:43.055516Z","time spent":"345.143633ms","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-18T22:50:43.401194Z","caller":"traceutil/trace.go:171","msg":"trace[682378835] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"379.912021ms","start":"2026-02-18T22:50:43.02125Z","end":"2026-02-18T22:50:43.401162Z","steps":["trace[682378835] 'process raft request' (duration: 321.122638ms)","trace[682378835] 'compare' (duration: 56.912661ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:50:43.401479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.402827ms","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-02-18T22:50:43.401514Z","caller":"traceutil/trace.go:171","msg":"trace[1453138248] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:421; }","duration":"345.440058ms","start":"2026-02-18T22:50:43.056066Z","end":"2026-02-18T22:50:43.401506Z","steps":["trace[1453138248] 'agreement among raft nodes before linearized reading' (duration: 345.379866ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:43.401534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:43.056059Z","time spent":"345.47057ms","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-18T22:50:43.401474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:43.021241Z","time spent":"380.062589ms","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T22:50:43.402008Z","caller":"traceutil/trace.go:171","msg":"trace[1321859899] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"380.701471ms","start":"2026-02-18T22:50:43.021293Z","end":"2026-02-18T22:50:43.401994Z","steps":["trace[1321859899] 'process raft request' (duration: 378.116192ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:43.402691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:43.02129Z","time spent":"380.841758ms","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T22:50:43.431146Z","caller":"traceutil/trace.go:171","msg":"trace[651241744] transaction","detail":"{read_only:false; response_revision:422; number_of_response:1; }","duration":"251.631503ms","start":"2026-02-18T22:50:43.179494Z","end":"2026-02-18T22:50:43.431125Z","steps":["trace[651241744] 'process raft request' (duration: 251.453564ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:50:43.584821Z","caller":"traceutil/trace.go:171","msg":"trace[384545132] transaction","detail":"{read_only:false; response_revision:426; number_of_response:1; }","duration":"102.741669ms","start":"2026-02-18T22:50:43.482057Z","end":"2026-02-18T22:50:43.584799Z","steps":["trace[384545132] 'process raft request' (duration: 98.726ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:48.002828Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356763506418000047,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T22:50:48.503702Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356763506418000047,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T22:50:48.885288Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.384745094s","expected-duration":"1s"} {"level":"info","ts":"2026-02-18T22:50:48.885741Z","caller":"traceutil/trace.go:171","msg":"trace[107046159] linearizableReadLoop","detail":"{readStateIndex:451; appliedIndex:450; }","duration":"1.383649632s","start":"2026-02-18T22:50:47.50207Z","end":"2026-02-18T22:50:48.88572Z","steps":["trace[107046159] 'read index received' (duration: 1.383433962s)","trace[107046159] 'applied index is now lower than readState.Index' (duration: 214.63µs)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:48.885899Z","caller":"traceutil/trace.go:171","msg":"trace[300907882] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"1.385403855s","start":"2026-02-18T22:50:47.500482Z","end":"2026-02-18T22:50:48.885886Z","steps":["trace[300907882] 'process raft request' (duration: 1.385104011s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:48.886119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:47.500465Z","time spent":"1.385554742s","remote":"127.0.0.1:49736","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-02-18T22:50:48.886288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.359659395s","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-02-18T22:50:48.886452Z","caller":"traceutil/trace.go:171","msg":"trace[1014996010] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:432; }","duration":"1.359796862s","start":"2026-02-18T22:50:47.526549Z","end":"2026-02-18T22:50:48.886346Z","steps":["trace[1014996010] 'agreement among raft nodes before linearized reading' (duration: 1.359574602s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:48.886533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:47.526533Z","time spent":"1.359985931s","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-18T22:50:48.886816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"758.885476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T22:50:48.886909Z","caller":"traceutil/trace.go:171","msg":"trace[486513788] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:432; }","duration":"759.037143ms","start":"2026-02-18T22:50:48.127859Z","end":"2026-02-18T22:50:48.886896Z","steps":["trace[486513788] 'agreement among raft nodes before linearized reading' (duration: 758.849014ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:48.88704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:48.127838Z","time spent":"759.19104ms","remote":"127.0.0.1:49472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-18T22:50:48.887349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.385272148s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-18T22:50:48.887425Z","caller":"traceutil/trace.go:171","msg":"trace[1194738257] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:432; }","duration":"1.385367553s","start":"2026-02-18T22:50:47.502047Z","end":"2026-02-18T22:50:48.887414Z","steps":["trace[1194738257] 'agreement among raft nodes before linearized reading' (duration: 1.385256038s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:48.887517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:47.502039Z","time spent":"1.385467288s","remote":"127.0.0.1:49736","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-02-18T22:50:48.887383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.309943371s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-18T22:50:48.889391Z","caller":"traceutil/trace.go:171","msg":"trace[1779541045] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:432; }","duration":"1.311979587s","start":"2026-02-18T22:50:47.577396Z","end":"2026-02-18T22:50:48.889376Z","steps":["trace[1779541045] 'agreement among raft nodes before linearized reading' (duration: 1.309937661s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:48.890819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:47.577382Z","time spent":"1.313419354s","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-18T22:50:50.067696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"846.122038ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T22:50:50.069077Z","caller":"traceutil/trace.go:171","msg":"trace[1919037615] transaction","detail":"{read_only:false; response_revision:435; number_of_response:1; }","duration":"1.173206837s","start":"2026-02-18T22:50:48.895846Z","end":"2026-02-18T22:50:50.069053Z","steps":["trace[1919037615] 'process raft request' (duration: 1.17305439s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:50.069172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:48.895838Z","time spent":"1.17328657s","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T22:50:50.06939Z","caller":"traceutil/trace.go:171","msg":"trace[1754071595] transaction","detail":"{read_only:false; response_revision:433; number_of_response:1; }","duration":"1.176980872s","start":"2026-02-18T22:50:48.892394Z","end":"2026-02-18T22:50:50.069375Z","steps":["trace[1754071595] 'process raft request' (duration: 329.107225ms)","trace[1754071595] 'compare' (duration: 845.911457ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:50:50.069454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:48.892381Z","time spent":"1.177038396s","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T22:50:50.069572Z","caller":"traceutil/trace.go:171","msg":"trace[934138488] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"1.17497283s","start":"2026-02-18T22:50:48.89458Z","end":"2026-02-18T22:50:50.069553Z","steps":["trace[934138488] 'process raft request' (duration: 1.173220139s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:50.069673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:48.894565Z","time spent":"1.175051802s","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T22:50:53.870792Z","caller":"traceutil/trace.go:171","msg":"trace[565385195] transaction","detail":"{read_only:false; response_revision:442; number_of_response:1; }","duration":"134.515458ms","start":"2026-02-18T22:50:53.736251Z","end":"2026-02-18T22:50:53.870766Z","steps":["trace[565385195] 'process raft request' (duration: 134.370721ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:54.184528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.908671ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T22:50:54.184685Z","caller":"traceutil/trace.go:171","msg":"trace[1868175535] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"415.468467ms","start":"2026-02-18T22:50:53.769193Z","end":"2026-02-18T22:50:54.184662Z","steps":["trace[1868175535] 'process raft request' (duration: 256.336076ms)","trace[1868175535] 'compare' (duration: 158.821088ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:50:54.184782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:53.769176Z","time spent":"415.55721ms","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T22:50:55.626083Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356763506418000088,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-18T22:50:55.634053Z","caller":"traceutil/trace.go:171","msg":"trace[986485686] linearizableReadLoop","detail":"{readStateIndex:467; appliedIndex:466; }","duration":"508.245416ms","start":"2026-02-18T22:50:55.125785Z","end":"2026-02-18T22:50:55.63403Z","steps":["trace[986485686] 'read index received' (duration: 508.046508ms)","trace[986485686] 'applied index is now lower than readState.Index' (duration: 198.028µs)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:55.634294Z","caller":"traceutil/trace.go:171","msg":"trace[1519339735] transaction","detail":"{read_only:false; response_revision:447; number_of_response:1; }","duration":"692.750009ms","start":"2026-02-18T22:50:54.941531Z","end":"2026-02-18T22:50:55.634281Z","steps":["trace[1519339735] 'process raft request' (duration: 692.366403ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:55.634754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.301026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4034"} {"level":"info","ts":"2026-02-18T22:50:55.634941Z","caller":"traceutil/trace.go:171","msg":"trace[57693815] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:447; }","duration":"274.490314ms","start":"2026-02-18T22:50:55.360428Z","end":"2026-02-18T22:50:55.634918Z","steps":["trace[57693815] 'agreement among raft nodes before linearized reading' (duration: 274.15507ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:55.635173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.383654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-18T22:50:55.63483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:54.941515Z","time spent":"692.846072ms","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T22:50:55.635228Z","caller":"traceutil/trace.go:171","msg":"trace[1142642234] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:447; }","duration":"509.461449ms","start":"2026-02-18T22:50:55.12575Z","end":"2026-02-18T22:50:55.635211Z","steps":["trace[1142642234] 'agreement among raft nodes before linearized reading' (duration: 509.350533ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:50:55.642657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:50:55.125726Z","time spent":"516.856207ms","remote":"127.0.0.1:49482","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-02-18T22:50:55.883077Z","caller":"traceutil/trace.go:171","msg":"trace[1801055054] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"150.707077ms","start":"2026-02-18T22:50:55.732349Z","end":"2026-02-18T22:50:55.883056Z","steps":["trace[1801055054] 'process raft request' (duration: 71.006557ms)","trace[1801055054] 'compare' (duration: 79.546334ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:50:55.899078Z","caller":"traceutil/trace.go:171","msg":"trace[764883259] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"161.022261ms","start":"2026-02-18T22:50:55.738042Z","end":"2026-02-18T22:50:55.899064Z","steps":["trace[764883259] 'process raft request' (duration: 160.913007ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:51:07.826153Z","caller":"traceutil/trace.go:171","msg":"trace[1107289729] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"113.262208ms","start":"2026-02-18T22:51:07.712861Z","end":"2026-02-18T22:51:07.826124Z","steps":["trace[1107289729] 'process raft request' (duration: 113.011269ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:08.760205Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356763506418000273,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-18T22:51:08.833123Z","caller":"traceutil/trace.go:171","msg":"trace[1922185821] linearizableReadLoop","detail":"{readStateIndex:564; appliedIndex:563; }","duration":"572.987265ms","start":"2026-02-18T22:51:08.26012Z","end":"2026-02-18T22:51:08.833107Z","steps":["trace[1922185821] 'read index received' (duration: 572.866141ms)","trace[1922185821] 'applied index is now lower than readState.Index' (duration: 120.214µs)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:51:08.833337Z","caller":"traceutil/trace.go:171","msg":"trace[663153359] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"580.506463ms","start":"2026-02-18T22:51:08.252823Z","end":"2026-02-18T22:51:08.83333Z","steps":["trace[663153359] 'process raft request' (duration: 580.199272ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:08.833408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:08.252805Z","time spent":"580.554455ms","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T22:51:08.83352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.3984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-02-18T22:51:08.833541Z","caller":"traceutil/trace.go:171","msg":"trace[1935038112] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:540; }","duration":"573.437942ms","start":"2026-02-18T22:51:08.260096Z","end":"2026-02-18T22:51:08.833534Z","steps":["trace[1935038112] 'agreement among raft nodes before linearized reading' (duration: 573.4025ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:08.833557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:08.260085Z","time spent":"573.468592ms","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-18T22:51:08.833636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.608009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-18T22:51:08.833663Z","caller":"traceutil/trace.go:171","msg":"trace[1973523065] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:540; }","duration":"555.668711ms","start":"2026-02-18T22:51:08.277988Z","end":"2026-02-18T22:51:08.833656Z","steps":["trace[1973523065] 'agreement among raft nodes before linearized reading' (duration: 555.63113ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:08.833681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:08.277971Z","time spent":"555.704564ms","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-18T22:51:12.504541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.862447ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T22:51:12.504664Z","caller":"traceutil/trace.go:171","msg":"trace[313108883] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"200.242068ms","start":"2026-02-18T22:51:12.304388Z","end":"2026-02-18T22:51:12.50463Z","steps":["trace[313108883] 'process raft request' (duration: 85.210284ms)","trace[313108883] 'compare' (duration: 114.757154ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:51:12.522257Z","caller":"traceutil/trace.go:171","msg":"trace[1609064564] linearizableReadLoop","detail":"{readStateIndex:589; appliedIndex:587; }","duration":"165.530517ms","start":"2026-02-18T22:51:12.356611Z","end":"2026-02-18T22:51:12.522141Z","steps":["trace[1609064564] 'read index received' (duration: 32.995012ms)","trace[1609064564] 'applied index is now lower than readState.Index' (duration: 132.534495ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:51:12.522361Z","caller":"traceutil/trace.go:171","msg":"trace[1449398273] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"215.409046ms","start":"2026-02-18T22:51:12.30691Z","end":"2026-02-18T22:51:12.522319Z","steps":["trace[1449398273] 'process raft request' (duration: 215.135946ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:12.522574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.953721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:1 size:12727"} {"level":"info","ts":"2026-02-18T22:51:12.522617Z","caller":"traceutil/trace.go:171","msg":"trace[1719417151] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:564; }","duration":"166.033684ms","start":"2026-02-18T22:51:12.356571Z","end":"2026-02-18T22:51:12.522604Z","steps":["trace[1719417151] 'agreement among raft nodes before linearized reading' (duration: 165.811366ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:16.492013Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356763506418000357,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-18T22:51:16.524594Z","caller":"traceutil/trace.go:171","msg":"trace[732562113] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:604; }","duration":"533.068486ms","start":"2026-02-18T22:51:15.991509Z","end":"2026-02-18T22:51:16.524578Z","steps":["trace[732562113] 'read index received' (duration: 523.902124ms)","trace[732562113] 'applied index is now lower than readState.Index' (duration: 9.165832ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:51:16.52502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.4997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-18T22:51:16.525039Z","caller":"traceutil/trace.go:171","msg":"trace[1032315318] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:580; }","duration":"533.554562ms","start":"2026-02-18T22:51:15.991478Z","end":"2026-02-18T22:51:16.525033Z","steps":["trace[1032315318] 'agreement among raft nodes before linearized reading' (duration: 533.480459ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:16.525054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:15.991462Z","time spent":"533.588084ms","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-18T22:51:16.52516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.609119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T22:51:16.525173Z","caller":"traceutil/trace.go:171","msg":"trace[1317656028] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:580; }","duration":"400.64344ms","start":"2026-02-18T22:51:16.124526Z","end":"2026-02-18T22:51:16.525169Z","steps":["trace[1317656028] 'agreement among raft nodes before linearized reading' (duration: 400.624149ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:16.525184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:16.124513Z","time spent":"400.668421ms","remote":"127.0.0.1:49472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-18T22:51:17.458858Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356763506418000369,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-18T22:51:17.53175Z","caller":"traceutil/trace.go:171","msg":"trace[632077503] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:610; }","duration":"572.752841ms","start":"2026-02-18T22:51:16.958748Z","end":"2026-02-18T22:51:17.531501Z","steps":["trace[632077503] 'read index received' (duration: 572.622876ms)","trace[632077503] 'applied index is now lower than readState.Index' (duration: 129.465µs)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:51:17.531942Z","caller":"traceutil/trace.go:171","msg":"trace[1372685047] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"646.844058ms","start":"2026-02-18T22:51:16.885092Z","end":"2026-02-18T22:51:17.531936Z","steps":["trace[1372685047] 'process raft request' (duration: 646.322461ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:17.532002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:16.88508Z","time spent":"646.87687ms","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T22:51:17.532133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.383882ms","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-02-18T22:51:17.532157Z","caller":"traceutil/trace.go:171","msg":"trace[1561721687] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:585; }","duration":"573.431843ms","start":"2026-02-18T22:51:16.95872Z","end":"2026-02-18T22:51:17.532152Z","steps":["trace[1561721687] 'agreement among raft nodes before linearized reading' (duration: 573.362631ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:17.532177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:16.958706Z","time spent":"573.467584ms","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-18T22:51:17.532263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.968977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-18T22:51:17.532281Z","caller":"traceutil/trace.go:171","msg":"trace[575089065] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:585; }","duration":"567.999219ms","start":"2026-02-18T22:51:16.964278Z","end":"2026-02-18T22:51:17.532277Z","steps":["trace[575089065] 'agreement among raft nodes before linearized reading' (duration: 567.957267ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:17.532293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:16.964269Z","time spent":"568.021019ms","remote":"127.0.0.1:49736","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-02-18T22:51:17.532371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.786396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T22:51:17.532387Z","caller":"traceutil/trace.go:171","msg":"trace[348010775] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:585; }","duration":"404.842537ms","start":"2026-02-18T22:51:17.127541Z","end":"2026-02-18T22:51:17.532383Z","steps":["trace[348010775] 'agreement among raft nodes before linearized reading' (duration: 404.817926ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:17.532398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:17.127524Z","time spent":"404.871858ms","remote":"127.0.0.1:49472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-18T22:51:17.532471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.213306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-pzxtt\" ","response":"range_response_count:1 size:16656"} {"level":"info","ts":"2026-02-18T22:51:17.532489Z","caller":"traceutil/trace.go:171","msg":"trace[2132481414] range","detail":"{range_begin:/registry/pods/kube-system/cilium-pzxtt; range_end:; response_count:1; response_revision:585; }","duration":"503.255337ms","start":"2026-02-18T22:51:17.029229Z","end":"2026-02-18T22:51:17.532485Z","steps":["trace[2132481414] 'agreement among raft nodes before linearized reading' (duration: 503.223875ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:17.5325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:17.029215Z","time spent":"503.282368ms","remote":"127.0.0.1:49660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16679,"request content":"key:\"/registry/pods/kube-system/cilium-pzxtt\" "} {"level":"info","ts":"2026-02-18T22:51:17.719194Z","caller":"traceutil/trace.go:171","msg":"trace[505175425] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"178.204724ms","start":"2026-02-18T22:51:17.540975Z","end":"2026-02-18T22:51:17.719179Z","steps":["trace[505175425] 'process raft request' (duration: 178.113231ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:19.036227Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356763506418000373,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T22:51:19.536539Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356763506418000373,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T22:51:20.036646Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356763506418000373,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T22:51:20.232588Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.513475708s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-18T22:51:20.536709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.950533ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T22:51:20.536814Z","caller":"traceutil/trace.go:171","msg":"trace[481286874] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:612; }","duration":"2.000942239s","start":"2026-02-18T22:51:18.535863Z","end":"2026-02-18T22:51:20.536805Z","steps":["trace[481286874] 'read index received' (duration: 1.69680794s)","trace[481286874] 'applied index is now lower than readState.Index' (duration: 304.133729ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:51:20.536917Z","caller":"traceutil/trace.go:171","msg":"trace[2056605231] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"2.9957972s","start":"2026-02-18T22:51:17.541114Z","end":"2026-02-18T22:51:20.536911Z","steps":["trace[2056605231] 'process raft request' (duration: 2.691596969s)","trace[2056605231] 'compare' (duration: 303.885141ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:51:20.536953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:17.541108Z","time spent":"2.995828712s","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T22:51:20.537028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.001155636s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-02-18T22:51:20.537056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.411754914s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T22:51:20.537072Z","caller":"traceutil/trace.go:171","msg":"trace[375653959] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:588; }","duration":"1.411794625s","start":"2026-02-18T22:51:19.125272Z","end":"2026-02-18T22:51:20.537067Z","steps":["trace[375653959] 'agreement among raft nodes before linearized reading' (duration: 1.411767744s)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:51:20.537072Z","caller":"traceutil/trace.go:171","msg":"trace[1128643245] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:588; }","duration":"2.001245239s","start":"2026-02-18T22:51:18.535815Z","end":"2026-02-18T22:51:20.53706Z","steps":["trace[1128643245] 'agreement among raft nodes before linearized reading' (duration: 2.001098003s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:20.537086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:19.125257Z","time spent":"1.411826276s","remote":"127.0.0.1:49472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-18T22:51:20.537098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:18.535794Z","time spent":"2.001300031s","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-18T22:51:20.537225Z","caller":"traceutil/trace.go:171","msg":"trace[1708934773] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"2.990205783s","start":"2026-02-18T22:51:17.547013Z","end":"2026-02-18T22:51:20.537218Z","steps":["trace[1708934773] 'process raft request' (duration: 2.989759248s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:20.537233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"815.019744ms","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-02-18T22:51:20.537249Z","caller":"traceutil/trace.go:171","msg":"trace[1873719489] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:588; }","duration":"815.073995ms","start":"2026-02-18T22:51:19.72217Z","end":"2026-02-18T22:51:20.537244Z","steps":["trace[1873719489] 'agreement among raft nodes before linearized reading' (duration: 815.009033ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:20.537266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:19.722148Z","time spent":"815.113277ms","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-18T22:51:20.537273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:17.547002Z","time spent":"2.990235854s","remote":"127.0.0.1:49660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T22:51:20.537384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.000642916s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-18T22:51:20.537399Z","caller":"traceutil/trace.go:171","msg":"trace[290532682] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:588; }","duration":"1.000658417s","start":"2026-02-18T22:51:19.536736Z","end":"2026-02-18T22:51:20.537394Z","steps":["trace[290532682] 'agreement among raft nodes before linearized reading' (duration: 1.000581004s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:20.537411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:19.536702Z","time spent":"1.000705818s","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-18T22:51:21.157276Z","caller":"traceutil/trace.go:171","msg":"trace[1894270980] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"610.998418ms","start":"2026-02-18T22:51:20.546262Z","end":"2026-02-18T22:51:21.15726Z","steps":["trace[1894270980] 'process raft request' (duration: 610.917186ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:21.15739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:20.546254Z","time spent":"611.072811ms","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T22:51:21.164229Z","caller":"traceutil/trace.go:171","msg":"trace[515960701] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"615.020446ms","start":"2026-02-18T22:51:20.549193Z","end":"2026-02-18T22:51:21.164213Z","steps":["trace[515960701] 'process raft request' (duration: 614.915783ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:21.164329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:20.549186Z","time spent":"615.087078ms","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T22:51:21.164359Z","caller":"traceutil/trace.go:171","msg":"trace[620323720] linearizableReadLoop","detail":"{readStateIndex:617; appliedIndex:615; }","duration":"471.934993ms","start":"2026-02-18T22:51:20.692409Z","end":"2026-02-18T22:51:21.164344Z","steps":["trace[620323720] 'read index received' (duration: 465.212757ms)","trace[620323720] 'applied index is now lower than readState.Index' (duration: 6.720996ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:51:21.164483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.063288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.113\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-18T22:51:21.164505Z","caller":"traceutil/trace.go:171","msg":"trace[1344317235] range","detail":"{range_begin:/registry/masterleases/199.204.45.113; range_end:; response_count:1; response_revision:591; }","duration":"472.11534ms","start":"2026-02-18T22:51:20.692383Z","end":"2026-02-18T22:51:21.164498Z","steps":["trace[1344317235] 'agreement among raft nodes before linearized reading' (duration: 472.010566ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:21.164529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:20.692371Z","time spent":"472.150481ms","remote":"127.0.0.1:49508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.113\" "} {"level":"info","ts":"2026-02-18T22:51:21.164554Z","caller":"traceutil/trace.go:171","msg":"trace[1400280325] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"615.320607ms","start":"2026-02-18T22:51:20.549228Z","end":"2026-02-18T22:51:21.164549Z","steps":["trace[1400280325] 'process raft request' (duration: 614.963784ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:21.164584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:20.549225Z","time spent":"615.344247ms","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T22:51:23.715382Z","caller":"traceutil/trace.go:171","msg":"trace[2145155408] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"460.586378ms","start":"2026-02-18T22:51:23.254769Z","end":"2026-02-18T22:51:23.715356Z","steps":["trace[2145155408] 'process raft request' (duration: 460.431593ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:23.715533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:51:23.254758Z","time spent":"460.692801ms","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-18T22:51:26.563561Z","caller":"traceutil/trace.go:171","msg":"trace[338478823] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"211.950762ms","start":"2026-02-18T22:51:26.351595Z","end":"2026-02-18T22:51:26.563546Z","steps":["trace[338478823] 'process raft request' (duration: 211.720295ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:51:26.572721Z","caller":"traceutil/trace.go:171","msg":"trace[1151293841] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"190.968859ms","start":"2026-02-18T22:51:26.381736Z","end":"2026-02-18T22:51:26.572704Z","steps":["trace[1151293841] 'process raft request' (duration: 190.407392ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:51:41.549239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.498084ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T22:51:41.549365Z","caller":"traceutil/trace.go:171","msg":"trace[2144299406] linearizableReadLoop","detail":"{readStateIndex:836; appliedIndex:834; }","duration":"195.557149ms","start":"2026-02-18T22:51:41.353796Z","end":"2026-02-18T22:51:41.549354Z","steps":["trace[2144299406] 'read index received' (duration: 15.886341ms)","trace[2144299406] 'applied index is now lower than readState.Index' (duration: 179.670248ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:51:41.549431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.630591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-18T22:51:41.549447Z","caller":"traceutil/trace.go:171","msg":"trace[186554040] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:801; }","duration":"195.670192ms","start":"2026-02-18T22:51:41.353771Z","end":"2026-02-18T22:51:41.549441Z","steps":["trace[186554040] 'agreement among raft nodes before linearized reading' (duration: 195.61365ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:51:41.54958Z","caller":"traceutil/trace.go:171","msg":"trace[355822158] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"207.593177ms","start":"2026-02-18T22:51:41.341981Z","end":"2026-02-18T22:51:41.549574Z","steps":["trace[355822158] 'process raft request' (duration: 207.334001ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:51:41.549642Z","caller":"traceutil/trace.go:171","msg":"trace[1156175220] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"211.285605ms","start":"2026-02-18T22:51:41.338332Z","end":"2026-02-18T22:51:41.549618Z","steps":["trace[1156175220] 'process raft request' (duration: 31.34215ms)","trace[1156175220] 'compare' (duration: 177.598903ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T22:52:13.869717Z","caller":"traceutil/trace.go:171","msg":"trace[213708906] transaction","detail":"{read_only:false; response_revision:896; number_of_response:1; }","duration":"143.700591ms","start":"2026-02-18T22:52:13.725995Z","end":"2026-02-18T22:52:13.869696Z","steps":["trace[213708906] 'process raft request' (duration: 143.539057ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:52:14.148716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.146541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-02-18T22:52:14.148786Z","caller":"traceutil/trace.go:171","msg":"trace[1963803480] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:896; }","duration":"109.244514ms","start":"2026-02-18T22:52:14.039526Z","end":"2026-02-18T22:52:14.14877Z","steps":["trace[1963803480] 'range keys from in-memory index tree' (duration: 109.03507ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T22:52:33.505092Z","caller":"traceutil/trace.go:171","msg":"trace[1729109590] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"164.032936ms","start":"2026-02-18T22:52:33.341035Z","end":"2026-02-18T22:52:33.505068Z","steps":["trace[1729109590] 'process raft request' (duration: 119.543036ms)","trace[1729109590] 'compare' (duration: 44.383378ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:52:40.909112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.016007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T22:52:40.909209Z","caller":"traceutil/trace.go:171","msg":"trace[1828507111] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1003; }","duration":"342.245211ms","start":"2026-02-18T22:52:40.566943Z","end":"2026-02-18T22:52:40.909189Z","steps":["trace[1828507111] 'count revisions from in-memory index tree' (duration: 341.861904ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:52:40.909253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:52:40.566914Z","time spent":"342.327942ms","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"warn","ts":"2026-02-18T22:52:40.91062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.749912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.113\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-18T22:52:40.910667Z","caller":"traceutil/trace.go:171","msg":"trace[1998022977] range","detail":"{range_begin:/registry/masterleases/199.204.45.113; range_end:; response_count:1; response_revision:1003; }","duration":"205.837023ms","start":"2026-02-18T22:52:40.704818Z","end":"2026-02-18T22:52:40.910655Z","steps":["trace[1998022977] 'range keys from in-memory index tree' (duration: 204.489911ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:52:48.388761Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356763506418001441,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-18T22:52:48.767141Z","caller":"traceutil/trace.go:171","msg":"trace[1130221508] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"997.367521ms","start":"2026-02-18T22:52:47.769753Z","end":"2026-02-18T22:52:48.76712Z","steps":["trace[1130221508] 'process raft request' (duration: 997.256519ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:52:48.767454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:52:47.769728Z","time spent":"997.467823ms","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T22:52:48.767603Z","caller":"traceutil/trace.go:171","msg":"trace[414895246] linearizableReadLoop","detail":"{readStateIndex:1077; appliedIndex:1077; }","duration":"879.762831ms","start":"2026-02-18T22:52:47.887812Z","end":"2026-02-18T22:52:48.767575Z","steps":["trace[414895246] 'read index received' (duration: 879.757361ms)","trace[414895246] 'applied index is now lower than readState.Index' (duration: 4.63µs)"],"step_count":2} {"level":"warn","ts":"2026-02-18T22:52:48.767767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"879.950254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T22:52:48.767798Z","caller":"traceutil/trace.go:171","msg":"trace[1600701982] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1028; }","duration":"879.982934ms","start":"2026-02-18T22:52:47.887808Z","end":"2026-02-18T22:52:48.767791Z","steps":["trace[1600701982] 'agreement among raft nodes before linearized reading' (duration: 879.896283ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:52:48.76794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:52:47.887774Z","time spent":"880.103716ms","remote":"127.0.0.1:49634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumes/test-pv\" "} {"level":"info","ts":"2026-02-18T22:52:48.7854Z","caller":"traceutil/trace.go:171","msg":"trace[185799135] transaction","detail":"{read_only:false; response_revision:1029; number_of_response:1; }","duration":"236.840258ms","start":"2026-02-18T22:52:48.548542Z","end":"2026-02-18T22:52:48.785383Z","steps":["trace[185799135] 'process raft request' (duration: 236.578684ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:52:48.786214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.988608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-18T22:52:48.786267Z","caller":"traceutil/trace.go:171","msg":"trace[1581641037] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1029; }","duration":"415.07719ms","start":"2026-02-18T22:52:48.371178Z","end":"2026-02-18T22:52:48.786255Z","steps":["trace[1581641037] 'agreement among raft nodes before linearized reading' (duration: 414.932838ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:52:48.786608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:52:48.371165Z","time spent":"415.287654ms","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-18T22:52:48.786857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.943424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T22:52:48.78703Z","caller":"traceutil/trace.go:171","msg":"trace[381397390] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1029; }","duration":"659.081165ms","start":"2026-02-18T22:52:48.127868Z","end":"2026-02-18T22:52:48.786949Z","steps":["trace[381397390] 'agreement among raft nodes before linearized reading' (duration: 658.952853ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:52:48.787257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:52:48.127847Z","time spent":"659.360549ms","remote":"127.0.0.1:49472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-18T22:52:48.787636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"734.447926ms","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-02-18T22:52:48.787682Z","caller":"traceutil/trace.go:171","msg":"trace[1161274781] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1029; }","duration":"734.550318ms","start":"2026-02-18T22:52:48.05312Z","end":"2026-02-18T22:52:48.787671Z","steps":["trace[1161274781] 'agreement among raft nodes before linearized reading' (duration: 734.432676ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:52:48.787846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:52:48.053105Z","time spent":"734.7068ms","remote":"127.0.0.1:49736","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-02-18T22:52:48.78811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"823.058036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-18T22:52:48.788291Z","caller":"traceutil/trace.go:171","msg":"trace[660726542] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1029; }","duration":"823.221869ms","start":"2026-02-18T22:52:47.964983Z","end":"2026-02-18T22:52:48.788205Z","steps":["trace[660726542] 'agreement among raft nodes before linearized reading' (duration: 822.65392ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T22:52:48.790174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T22:52:47.964967Z","time spent":"825.189683ms","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}