{"level":"warn","ts":"2026-02-10T14:54:26.210346Z","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-10T14:54:26.210428Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.43: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://162.253.55.43:2380","--initial-cluster=instance=https://162.253.55.43:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.43:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.43: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-10T14:54:26.21061Z","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-10T14:54:26.210642Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.43:2380"]}
{"level":"info","ts":"2026-02-10T14:54:26.210683Z","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-10T14:54:26.211439Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.43:2379"]}
{"level":"info","ts":"2026-02-10T14:54:26.211608Z","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://162.253.55.43:2380"],"listen-peer-urls":["https://162.253.55.43:2380"],"advertise-client-urls":["https://162.253.55.43:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.43:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.43: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-10T14:54:26.21689Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.914417ms"}
{"level":"info","ts":"2026-02-10T14:54:26.234175Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"14f8f2dfdaccebdb","cluster-id":"5f02ccb15672f35d"}
{"level":"info","ts":"2026-02-10T14:54:26.234234Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb switched to configuration voters=()"}
{"level":"info","ts":"2026-02-10T14:54:26.234261Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became follower at term 0"}
{"level":"info","ts":"2026-02-10T14:54:26.234271Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 14f8f2dfdaccebdb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-10T14:54:26.234277Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became follower at term 1"}
{"level":"info","ts":"2026-02-10T14:54:26.234328Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb switched to configuration voters=(1511224718245293019)"}
{"level":"warn","ts":"2026-02-10T14:54:26.41996Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-10T14:54:26.434105Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-10T14:54:26.439375Z","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-10T14:54:26.452709Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"14f8f2dfdaccebdb","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-10T14:54:26.453447Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"14f8f2dfdaccebdb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-10T14:54:26.453594Z","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-10T14:54:26.45362Z","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-10T14:54:26.453627Z","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-10T14:54:26.453847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb switched to configuration voters=(1511224718245293019)"}
{"level":"info","ts":"2026-02-10T14:54:26.453985Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5f02ccb15672f35d","local-member-id":"14f8f2dfdaccebdb","added-peer-id":"14f8f2dfdaccebdb","added-peer-peer-urls":["https://162.253.55.43:2380"]}
{"level":"info","ts":"2026-02-10T14:54:26.473169Z","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-10T14:54:26.473437Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"14f8f2dfdaccebdb","initial-advertise-peer-urls":["https://162.253.55.43:2380"],"listen-peer-urls":["https://162.253.55.43:2380"],"advertise-client-urls":["https://162.253.55.43:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.43:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-10T14:54:26.473463Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-10T14:54:26.473632Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.43:2380"}
{"level":"info","ts":"2026-02-10T14:54:26.473643Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.43:2380"}
{"level":"info","ts":"2026-02-10T14:54:27.335578Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb is starting a new election at term 1"}
{"level":"info","ts":"2026-02-10T14:54:27.335632Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-10T14:54:27.335698Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb received MsgPreVoteResp from 14f8f2dfdaccebdb at term 1"}
{"level":"info","ts":"2026-02-10T14:54:27.335718Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became candidate at term 2"}
{"level":"info","ts":"2026-02-10T14:54:27.335726Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb received MsgVoteResp from 14f8f2dfdaccebdb at term 2"}
{"level":"info","ts":"2026-02-10T14:54:27.335736Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became leader at term 2"}
{"level":"info","ts":"2026-02-10T14:54:27.335745Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 14f8f2dfdaccebdb elected leader 14f8f2dfdaccebdb at term 2"}
{"level":"info","ts":"2026-02-10T14:54:27.336629Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-10T14:54:27.337329Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"14f8f2dfdaccebdb","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.43:2379]}","request-path":"/0/members/14f8f2dfdaccebdb/attributes","cluster-id":"5f02ccb15672f35d","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-10T14:54:27.337636Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-10T14:54:27.337783Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5f02ccb15672f35d","local-member-id":"14f8f2dfdaccebdb","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-10T14:54:27.337953Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-10T14:54:27.338001Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-10T14:54:27.338174Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-10T14:54:27.33822Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-10T14:54:27.338229Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-10T14:54:27.34042Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.43:2379"}
{"level":"info","ts":"2026-02-10T14:54:27.340616Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"warn","ts":"2026-02-10T14:54:31.997375Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16995349452064144377,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-10T14:54:32.498554Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.023632129s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-10T14:54:32.498716Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16995349452064144377,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-10T14:54:32.499011Z","caller":"traceutil/trace.go:171","msg":"trace[948102074] transaction","detail":"{read_only:false; response_revision:216; number_of_response:1; }","duration":"1.024179059s","start":"2026-02-10T14:54:31.474805Z","end":"2026-02-10T14:54:32.498984Z","steps":["trace[948102074] 'process raft request'  (duration: 1.0240278s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:54:32.499527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:54:31.474784Z","time spent":"1.024281404s","remote":"127.0.0.1:38378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2883,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-scheduler-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" value_size:2825 >> failure:<>"}
{"level":"info","ts":"2026-02-10T14:54:32.499985Z","caller":"traceutil/trace.go:171","msg":"trace[1956968925] linearizableReadLoop","detail":"{readStateIndex:221; appliedIndex:221; }","duration":"1.00319746s","start":"2026-02-10T14:54:31.496779Z","end":"2026-02-10T14:54:32.499977Z","steps":["trace[1956968925] 'read index received'  (duration: 1.00319379s)","trace[1956968925] 'applied index is now lower than readState.Index'  (duration: 3.15µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T14:54:32.500019Z","caller":"etcdserver/v3_server.go:874","msg":"ignored out-of-date read index response; local node read indexes queueing up and waiting to be in sync with leader","sent-request-id":16995349452064144382,"received-request-id":16995349452064144377}
{"level":"warn","ts":"2026-02-10T14:54:32.500168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.003377259s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3396"}
{"level":"info","ts":"2026-02-10T14:54:32.500208Z","caller":"traceutil/trace.go:171","msg":"trace[1568046312] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:216; }","duration":"1.003454454s","start":"2026-02-10T14:54:31.496742Z","end":"2026-02-10T14:54:32.500197Z","steps":["trace[1568046312] 'agreement among raft nodes before linearized reading'  (duration: 1.003354379s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:54:32.500234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:54:31.496725Z","time spent":"1.003505146s","remote":"127.0.0.1:38362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3418,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-02-10T14:54:32.500418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.538964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T14:54:32.500445Z","caller":"traceutil/trace.go:171","msg":"trace[1601938855] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:216; }","duration":"547.602087ms","start":"2026-02-10T14:54:31.952835Z","end":"2026-02-10T14:54:32.500437Z","steps":["trace[1601938855] 'agreement among raft nodes before linearized reading'  (duration: 547.559815ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:54:32.500475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:54:31.952811Z","time spent":"547.65672ms","remote":"127.0.0.1:38470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-02-10T14:54:34.687473Z","caller":"traceutil/trace.go:171","msg":"trace[1608964312] transaction","detail":"{read_only:false; response_revision:281; number_of_response:1; }","duration":"110.075277ms","start":"2026-02-10T14:54:34.57737Z","end":"2026-02-10T14:54:34.687446Z","steps":["trace[1608964312] 'process raft request'  (duration: 98.152726ms)","trace[1608964312] 'compare'  (duration: 11.544921ms)"],"step_count":2}
{"level":"info","ts":"2026-02-10T14:54:41.437274Z","caller":"traceutil/trace.go:171","msg":"trace[471521433] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"248.555193ms","start":"2026-02-10T14:54:41.188679Z","end":"2026-02-10T14:54:41.437234Z","steps":["trace[471521433] 'process raft request'  (duration: 248.420005ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T14:54:41.44162Z","caller":"traceutil/trace.go:171","msg":"trace[431597674] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"251.518105ms","start":"2026-02-10T14:54:41.190092Z","end":"2026-02-10T14:54:41.44161Z","steps":["trace[431597674] 'process raft request'  (duration: 251.460292ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:54:42.650142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.458063ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16995349452064144743 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/etcd-instance\" mod_revision:273 > success:<request_put:<key:\"/registry/pods/kube-system/etcd-instance\" value_size:5197 >> failure:<request_range:<key:\"/registry/pods/kube-system/etcd-instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-10T14:54:42.650243Z","caller":"traceutil/trace.go:171","msg":"trace[412093544] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"190.080528ms","start":"2026-02-10T14:54:42.460146Z","end":"2026-02-10T14:54:42.650227Z","steps":["trace[412093544] 'process raft request'  (duration: 42.278046ms)","trace[412093544] 'compare'  (duration: 147.343396ms)"],"step_count":2}
{"level":"info","ts":"2026-02-10T14:54:43.026411Z","caller":"traceutil/trace.go:171","msg":"trace[1544700478] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"157.464376ms","start":"2026-02-10T14:54:42.868931Z","end":"2026-02-10T14:54:43.026395Z","steps":["trace[1544700478] 'process raft request'  (duration: 157.434114ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T14:54:43.026752Z","caller":"traceutil/trace.go:171","msg":"trace[49240769] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"158.223568ms","start":"2026-02-10T14:54:42.868522Z","end":"2026-02-10T14:54:43.026746Z","steps":["trace[49240769] 'process raft request'  (duration: 156.325563ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T14:54:55.787649Z","caller":"traceutil/trace.go:171","msg":"trace[1457656442] linearizableReadLoop","detail":"{readStateIndex:459; appliedIndex:458; }","duration":"295.028118ms","start":"2026-02-10T14:54:55.492602Z","end":"2026-02-10T14:54:55.78763Z","steps":["trace[1457656442] 'read index received'  (duration: 195.076481ms)","trace[1457656442] 'applied index is now lower than readState.Index'  (duration: 99.950677ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T14:54:55.787781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.157674ms","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-10T14:54:55.787867Z","caller":"traceutil/trace.go:171","msg":"trace[1432935224] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:439; }","duration":"295.268021ms","start":"2026-02-10T14:54:55.492567Z","end":"2026-02-10T14:54:55.787835Z","steps":["trace[1432935224] 'agreement among raft nodes before linearized reading'  (duration: 295.095342ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T14:54:55.904602Z","caller":"traceutil/trace.go:171","msg":"trace[2035350502] transaction","detail":"{read_only:false; response_revision:440; number_of_response:1; }","duration":"113.246376ms","start":"2026-02-10T14:54:55.791339Z","end":"2026-02-10T14:54:55.904585Z","steps":["trace[2035350502] 'process raft request'  (duration: 113.093938ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T14:54:57.180313Z","caller":"traceutil/trace.go:171","msg":"trace[1698834943] transaction","detail":"{read_only:false; response_revision:442; number_of_response:1; }","duration":"169.159458ms","start":"2026-02-10T14:54:57.011125Z","end":"2026-02-10T14:54:57.180285Z","steps":["trace[1698834943] 'process raft request'  (duration: 158.641933ms)","trace[1698834943] 'compare'  (duration: 10.003525ms)"],"step_count":2}
{"level":"info","ts":"2026-02-10T14:54:57.18062Z","caller":"traceutil/trace.go:171","msg":"trace[1858107829] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"101.078117ms","start":"2026-02-10T14:54:57.07953Z","end":"2026-02-10T14:54:57.180608Z","steps":["trace[1858107829] 'process raft request'  (duration: 100.388748ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T14:54:57.180754Z","caller":"traceutil/trace.go:171","msg":"trace[236966511] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"101.141861ms","start":"2026-02-10T14:54:57.079601Z","end":"2026-02-10T14:54:57.180743Z","steps":["trace[236966511] 'process raft request'  (duration: 100.375567ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T14:55:01.259383Z","caller":"traceutil/trace.go:171","msg":"trace[757472577] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"417.357988ms","start":"2026-02-10T14:55:00.841973Z","end":"2026-02-10T14:55:01.259331Z","steps":["trace[757472577] 'process raft request'  (duration: 417.131525ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:55:01.259557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:00.841956Z","time spent":"417.511876ms","remote":"127.0.0.1:38198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13214,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" mod_revision:510 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" value_size:13124 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" > >"}
{"level":"warn","ts":"2026-02-10T14:55:03.461345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:02.742981Z","time spent":"718.358984ms","remote":"127.0.0.1:50594","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-02-10T14:55:03.741698Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.580602136s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-10T14:55:03.742437Z","caller":"traceutil/trace.go:171","msg":"trace[508146846] linearizableReadLoop","detail":"{readStateIndex:536; appliedIndex:533; }","duration":"2.54992525s","start":"2026-02-10T14:55:01.192488Z","end":"2026-02-10T14:55:03.742413Z","steps":["trace[508146846] 'read index received'  (duration: 66.739714ms)","trace[508146846] 'applied index is now lower than readState.Index'  (duration: 2.483184635s)"],"step_count":2}
{"level":"info","ts":"2026-02-10T14:55:03.742798Z","caller":"traceutil/trace.go:171","msg":"trace[1105504800] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"2.659037134s","start":"2026-02-10T14:55:01.08369Z","end":"2026-02-10T14:55:03.742727Z","steps":["trace[1105504800] 'process raft request'  (duration: 2.658676294s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:55:03.742986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:01.083671Z","time spent":"2.659219254s","remote":"127.0.0.1:38198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4234,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" value_size:4142 >> failure:<>"}
{"level":"warn","ts":"2026-02-10T14:55:03.744336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.551857559s","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-10T14:55:03.744331Z","caller":"traceutil/trace.go:171","msg":"trace[524525017] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"2.861161916s","start":"2026-02-10T14:55:00.88301Z","end":"2026-02-10T14:55:03.744171Z","steps":["trace[524525017] 'process raft request'  (duration: 2.859030465s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:55:03.744987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:00.882981Z","time spent":"2.861936441s","remote":"127.0.0.1:38198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" value_size:3262 >> failure:<>"}
{"level":"info","ts":"2026-02-10T14:55:03.745184Z","caller":"traceutil/trace.go:171","msg":"trace[260296854] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:513; }","duration":"2.55203567s","start":"2026-02-10T14:55:01.192413Z","end":"2026-02-10T14:55:03.744449Z","steps":["trace[260296854] 'agreement among raft nodes before linearized reading'  (duration: 2.550369164s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:55:03.745672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:01.192387Z","time spent":"2.553248088s","remote":"127.0.0.1:38470","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-10T14:55:03.981401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000232989s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-10T14:55:03.981834Z","caller":"traceutil/trace.go:171","msg":"trace[819297286] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000724727s","start":"2026-02-10T14:55:01.981094Z","end":"2026-02-10T14:55:03.981819Z","steps":["trace[819297286] 'agreement among raft nodes before linearized reading'  (duration: 2.000273571s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:55:03.981936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:01.981067Z","time spent":"2.000855125s","remote":"127.0.0.1:38116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/10 14:55:03 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-10T14:55:04.242593Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16995349452064145015,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-10T14:55:04.243004Z","caller":"traceutil/trace.go:171","msg":"trace[1680908045] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"527.301428ms","start":"2026-02-10T14:55:03.715684Z","end":"2026-02-10T14:55:04.242985Z","steps":["trace[1680908045] 'process raft request'  (duration: 527.246015ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:55:04.243183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:03.715665Z","time spent":"527.432695ms","remote":"127.0.0.1:38362","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4452,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:482 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4418 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-02-10T14:55:04.243367Z","caller":"traceutil/trace.go:171","msg":"trace[1533827927] linearizableReadLoop","detail":"{readStateIndex:540; appliedIndex:540; }","duration":"500.755814ms","start":"2026-02-10T14:55:03.742563Z","end":"2026-02-10T14:55:04.243319Z","steps":["trace[1533827927] 'read index received'  (duration: 500.747724ms)","trace[1533827927] 'applied index is now lower than readState.Index'  (duration: 7.21µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T14:55:04.24355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.033982025s","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:0 size:5"}
{"level":"info","ts":"2026-02-10T14:55:04.24364Z","caller":"traceutil/trace.go:171","msg":"trace[820167107] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:0; response_revision:517; }","duration":"1.034104992s","start":"2026-02-10T14:55:03.209525Z","end":"2026-02-10T14:55:04.243631Z","steps":["trace[820167107] 'agreement among raft nodes before linearized reading'  (duration: 1.033961904s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:55:04.243705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:03.209507Z","time spent":"1.034190436s","remote":"127.0.0.1:38262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" "}
{"level":"warn","ts":"2026-02-10T14:55:04.244091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.362019612s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"}
{"level":"info","ts":"2026-02-10T14:55:04.244197Z","caller":"traceutil/trace.go:171","msg":"trace[1698928765] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:517; }","duration":"1.362154751s","start":"2026-02-10T14:55:02.882034Z","end":"2026-02-10T14:55:04.244188Z","steps":["trace[1698928765] 'agreement among raft nodes before linearized reading'  (duration: 1.36198064s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:55:04.244302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:02.882014Z","time spent":"1.362277377s","remote":"127.0.0.1:38198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":1,"response size":13251,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" "}
{"level":"info","ts":"2026-02-10T14:55:04.244414Z","caller":"traceutil/trace.go:171","msg":"trace[854202885] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"2.560007007s","start":"2026-02-10T14:55:01.684387Z","end":"2026-02-10T14:55:04.244394Z","steps":["trace[854202885] 'process raft request'  (duration: 2.558226695s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:55:04.244615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:01.684366Z","time spent":"2.560087001s","remote":"127.0.0.1:38198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" value_size:3111 >> failure:<>"}
{"level":"info","ts":"2026-02-10T14:55:04.244796Z","caller":"traceutil/trace.go:171","msg":"trace[566369245] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"2.357139362s","start":"2026-02-10T14:55:01.887648Z","end":"2026-02-10T14:55:04.244787Z","steps":["trace[566369245] 'process raft request'  (duration: 2.355205252s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:55:04.244966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:01.88763Z","time spent":"2.357190015s","remote":"127.0.0.1:38198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" value_size:23189 >> failure:<>"}
{"level":"info","ts":"2026-02-10T14:55:04.245504Z","caller":"traceutil/trace.go:171","msg":"trace[633010630] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"556.355793ms","start":"2026-02-10T14:55:03.689139Z","end":"2026-02-10T14:55:04.245495Z","steps":["trace[633010630] 'process raft request'  (duration: 553.746235ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:55:04.245632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:03.689115Z","time spent":"556.415126ms","remote":"127.0.0.1:38470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:435 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-02-10T14:55:04.246277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.316736265s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-02-10T14:55:04.246312Z","caller":"traceutil/trace.go:171","msg":"trace[1470790170] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:517; }","duration":"2.31680113s","start":"2026-02-10T14:55:01.929503Z","end":"2026-02-10T14:55:04.246304Z","steps":["trace[1470790170] 'agreement among raft nodes before linearized reading'  (duration: 2.316743706s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:55:04.246667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:01.929487Z","time spent":"2.317001592s","remote":"127.0.0.1:38470","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-10T14:55:04.246886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.564294097s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"}
{"level":"info","ts":"2026-02-10T14:55:04.246914Z","caller":"traceutil/trace.go:171","msg":"trace[1873607492] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:517; }","duration":"1.564380992s","start":"2026-02-10T14:55:02.682525Z","end":"2026-02-10T14:55:04.246906Z","steps":["trace[1873607492] 'agreement among raft nodes before linearized reading'  (duration: 1.564287217s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:55:04.246941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:02.682504Z","time spent":"1.564429444s","remote":"127.0.0.1:38198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":1,"response size":10399,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" "}
{"level":"warn","ts":"2026-02-10T14:55:04.24719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.7654695s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"}
{"level":"info","ts":"2026-02-10T14:55:04.247216Z","caller":"traceutil/trace.go:171","msg":"trace[1950865803] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:517; }","duration":"1.765523024s","start":"2026-02-10T14:55:02.481687Z","end":"2026-02-10T14:55:04.24721Z","steps":["trace[1950865803] 'agreement among raft nodes before linearized reading'  (duration: 1.76545424s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:55:04.247235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:02.481673Z","time spent":"1.765558195s","remote":"127.0.0.1:38198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":9342,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" "}
{"level":"warn","ts":"2026-02-10T14:55:04.247397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.962837426s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"}
{"level":"info","ts":"2026-02-10T14:55:04.247422Z","caller":"traceutil/trace.go:171","msg":"trace[1157813071] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:517; }","duration":"1.962889888s","start":"2026-02-10T14:55:02.284526Z","end":"2026-02-10T14:55:04.247415Z","steps":["trace[1157813071] 'agreement among raft nodes before linearized reading'  (duration: 1.962817944s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:55:04.247476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:02.284504Z","time spent":"1.962964282s","remote":"127.0.0.1:38198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4105,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" "}
{"level":"warn","ts":"2026-02-10T14:55:04.247628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.165397235s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"}
{"level":"info","ts":"2026-02-10T14:55:04.247665Z","caller":"traceutil/trace.go:171","msg":"trace[450343576] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:517; }","duration":"2.16547036s","start":"2026-02-10T14:55:02.082186Z","end":"2026-02-10T14:55:04.247656Z","steps":["trace[450343576] 'agreement among raft nodes before linearized reading'  (duration: 2.165375914s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:55:04.247734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:02.082171Z","time spent":"2.165555496s","remote":"127.0.0.1:38198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":92,"response count":1,"response size":5608,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" "}
{"level":"warn","ts":"2026-02-10T14:55:04.247864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.286870409s","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-10T14:55:04.247923Z","caller":"traceutil/trace.go:171","msg":"trace[2042189808] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:517; }","duration":"2.286970294s","start":"2026-02-10T14:55:01.960944Z","end":"2026-02-10T14:55:04.247914Z","steps":["trace[2042189808] 'agreement among raft nodes before linearized reading'  (duration: 2.28689529s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:55:04.248013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:01.960929Z","time spent":"2.287052499s","remote":"127.0.0.1:38470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-10T14:55:04.248749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.937979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T14:55:04.248786Z","caller":"traceutil/trace.go:171","msg":"trace[2016288318] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:519; }","duration":"267.009133ms","start":"2026-02-10T14:55:03.981769Z","end":"2026-02-10T14:55:04.248779Z","steps":["trace[2016288318] 'agreement among raft nodes before linearized reading'  (duration: 266.924078ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:55:04.248994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.765725784s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T14:55:04.24969Z","caller":"traceutil/trace.go:171","msg":"trace[2095890584] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:519; }","duration":"2.766457066s","start":"2026-02-10T14:55:01.483216Z","end":"2026-02-10T14:55:04.249673Z","steps":["trace[2095890584] 'agreement among raft nodes before linearized reading'  (duration: 2.765728824s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:55:04.249728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:01.483198Z","time spent":"2.766520579s","remote":"127.0.0.1:38198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" "}
{"level":"warn","ts":"2026-02-10T14:55:04.249238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.964998784s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T14:55:04.251122Z","caller":"traceutil/trace.go:171","msg":"trace[1727042007] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:519; }","duration":"2.965696674s","start":"2026-02-10T14:55:01.284194Z","end":"2026-02-10T14:55:04.249891Z","steps":["trace[1727042007] 'agreement among raft nodes before linearized reading'  (duration: 2.965014155s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:55:04.251538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:01.284177Z","time spent":"2.966998138s","remote":"127.0.0.1:38198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" "}
{"level":"warn","ts":"2026-02-10T14:55:04.249282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.042099548s","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-10T14:55:04.252082Z","caller":"traceutil/trace.go:171","msg":"trace[1215865815] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:519; }","duration":"3.044906989s","start":"2026-02-10T14:55:01.207168Z","end":"2026-02-10T14:55:04.252075Z","steps":["trace[1215865815] 'agreement among raft nodes before linearized reading'  (duration: 3.042091168s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:55:04.252155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:01.207163Z","time spent":"3.044984233s","remote":"127.0.0.1:38470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-10T14:55:04.249311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.042715443s","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-10T14:55:04.252262Z","caller":"traceutil/trace.go:171","msg":"trace[1609818527] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:519; }","duration":"3.045701353s","start":"2026-02-10T14:55:01.206556Z","end":"2026-02-10T14:55:04.252257Z","steps":["trace[1609818527] 'agreement among raft nodes before linearized reading'  (duration: 3.042736624s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:55:04.252393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:01.206542Z","time spent":"3.045841401s","remote":"127.0.0.1:38470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-02-10T14:55:04.253221Z","caller":"traceutil/trace.go:171","msg":"trace[1566122039] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"500.12864ms","start":"2026-02-10T14:55:03.753081Z","end":"2026-02-10T14:55:04.25321Z","steps":["trace[1566122039] 'process raft request'  (duration: 495.577891ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:55:04.253274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:03.75306Z","time spent":"500.178602ms","remote":"127.0.0.1:38470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:479 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-10T14:55:04.253335Z","caller":"traceutil/trace.go:171","msg":"trace[1237796777] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"501.231192ms","start":"2026-02-10T14:55:03.752099Z","end":"2026-02-10T14:55:04.25333Z","steps":["trace[1237796777] 'process raft request'  (duration: 496.493492ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:55:04.253359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:03.752079Z","time spent":"501.265205ms","remote":"127.0.0.1:38198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4309,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" mod_revision:512 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" value_size:4218 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" > >"}
{"level":"warn","ts":"2026-02-10T14:55:12.796955Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16995349452064145172,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-10T14:55:13.297235Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16995349452064145172,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-10T14:55:13.797377Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16995349452064145172,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-10T14:55:14.139044Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.845930824s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-10T14:55:14.139332Z","caller":"traceutil/trace.go:171","msg":"trace[1902781759] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:605; }","duration":"1.843230334s","start":"2026-02-10T14:55:12.296084Z","end":"2026-02-10T14:55:14.139315Z","steps":["trace[1902781759] 'read index received'  (duration: 1.84305049s)","trace[1902781759] 'applied index is now lower than readState.Index'  (duration: 179.224µs)"],"step_count":2}
{"level":"info","ts":"2026-02-10T14:55:14.139571Z","caller":"traceutil/trace.go:171","msg":"trace[16092790] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"1.846562353s","start":"2026-02-10T14:55:12.293Z","end":"2026-02-10T14:55:14.139563Z","steps":["trace[16092790] 'process raft request'  (duration: 1.846198694s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:55:14.139674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:12.292981Z","time spent":"1.846626154s","remote":"127.0.0.1:38378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-gdb4b\" mod_revision:472 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-gdb4b\" value_size:16750 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-gdb4b\" > >"}
{"level":"warn","ts":"2026-02-10T14:55:14.139867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.843779147s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-10T14:55:14.139928Z","caller":"traceutil/trace.go:171","msg":"trace[726499422] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:581; }","duration":"1.843873678s","start":"2026-02-10T14:55:12.296047Z","end":"2026-02-10T14:55:14.139921Z","steps":["trace[726499422] 'agreement among raft nodes before linearized reading'  (duration: 1.843744712s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:55:14.140174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:12.29603Z","time spent":"1.843917758s","remote":"127.0.0.1:38470","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-10T14:55:14.140319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.807443238s","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-10T14:55:14.140343Z","caller":"traceutil/trace.go:171","msg":"trace[981181112] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:581; }","duration":"1.807496028s","start":"2026-02-10T14:55:12.332841Z","end":"2026-02-10T14:55:14.140337Z","steps":["trace[981181112] 'agreement among raft nodes before linearized reading'  (duration: 1.807436509s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:55:14.140364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:12.332825Z","time spent":"1.807534139s","remote":"127.0.0.1:38470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-10T14:55:14.140555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.110702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T14:55:14.140585Z","caller":"traceutil/trace.go:171","msg":"trace[1154390021] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:581; }","duration":"164.161622ms","start":"2026-02-10T14:55:13.976415Z","end":"2026-02-10T14:55:14.140576Z","steps":["trace[1154390021] 'agreement among raft nodes before linearized reading'  (duration: 164.121833ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:55:14.140719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.708791899s","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-10T14:55:14.140743Z","caller":"traceutil/trace.go:171","msg":"trace[714468271] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:581; }","duration":"1.70883485s","start":"2026-02-10T14:55:12.431902Z","end":"2026-02-10T14:55:14.140737Z","steps":["trace[714468271] 'agreement among raft nodes before linearized reading'  (duration: 1.708763382s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:55:14.140764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:12.431871Z","time spent":"1.708888331s","remote":"127.0.0.1:38470","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-10T14:55:14.140903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.774887643s","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-10T14:55:14.140925Z","caller":"traceutil/trace.go:171","msg":"trace[698490449] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:581; }","duration":"1.774928214s","start":"2026-02-10T14:55:12.365991Z","end":"2026-02-10T14:55:14.140919Z","steps":["trace[698490449] 'agreement among raft nodes before linearized reading'  (duration: 1.774854106s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:55:14.140946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:12.365973Z","time spent":"1.774968244s","remote":"127.0.0.1:38470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-10T14:55:14.141093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.800546205s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-02-10T14:55:14.141118Z","caller":"traceutil/trace.go:171","msg":"trace[323465867] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:581; }","duration":"1.800602024s","start":"2026-02-10T14:55:12.34051Z","end":"2026-02-10T14:55:14.141112Z","steps":["trace[323465867] 'agreement among raft nodes before linearized reading'  (duration: 1.800519146s)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:55:14.141138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:12.3405Z","time spent":"1.800633764s","remote":"127.0.0.1:38470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-02-10T14:55:34.404801Z","caller":"traceutil/trace.go:171","msg":"trace[801077875] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"118.277822ms","start":"2026-02-10T14:55:34.286507Z","end":"2026-02-10T14:55:34.404785Z","steps":["trace[801077875] 'process raft request'  (duration: 117.986125ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T14:55:35.296669Z","caller":"traceutil/trace.go:171","msg":"trace[1372748314] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"550.095011ms","start":"2026-02-10T14:55:34.746544Z","end":"2026-02-10T14:55:35.296639Z","steps":["trace[1372748314] 'process raft request'  (duration: 549.984562ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:55:35.29678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:34.746508Z","time spent":"550.21573ms","remote":"127.0.0.1:38470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:672 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-02-10T14:55:35.381554Z","caller":"traceutil/trace.go:171","msg":"trace[1069607798] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"268.664462ms","start":"2026-02-10T14:55:35.112871Z","end":"2026-02-10T14:55:35.381536Z","steps":["trace[1069607798] 'process raft request'  (duration: 251.200001ms)","trace[1069607798] 'compare'  (duration: 16.648178ms)"],"step_count":2}
{"level":"info","ts":"2026-02-10T14:56:02.933944Z","caller":"traceutil/trace.go:171","msg":"trace[918797667] transaction","detail":"{read_only:false; response_revision:830; number_of_response:1; }","duration":"314.986916ms","start":"2026-02-10T14:56:02.618918Z","end":"2026-02-10T14:56:02.933905Z","steps":["trace[918797667] 'process raft request'  (duration: 314.233306ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:56:02.934454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:56:02.618906Z","time spent":"315.371209ms","remote":"127.0.0.1:38470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:825 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-02-10T14:56:02.936785Z","caller":"traceutil/trace.go:171","msg":"trace[1296752937] linearizableReadLoop","detail":"{readStateIndex:870; appliedIndex:867; }","duration":"293.768594ms","start":"2026-02-10T14:56:02.643004Z","end":"2026-02-10T14:56:02.936772Z","steps":["trace[1296752937] 'read index received'  (duration: 290.170941ms)","trace[1296752937] 'applied index is now lower than readState.Index'  (duration: 3.596953ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T14:56:02.936877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.855515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-10T14:56:02.936898Z","caller":"traceutil/trace.go:171","msg":"trace[1090479020] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:832; }","duration":"293.919877ms","start":"2026-02-10T14:56:02.642973Z","end":"2026-02-10T14:56:02.936893Z","steps":["trace[1090479020] 'agreement among raft nodes before linearized reading'  (duration: 293.852236ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T14:56:02.937053Z","caller":"traceutil/trace.go:171","msg":"trace[651670882] transaction","detail":"{read_only:false; response_revision:831; number_of_response:1; }","duration":"316.24398ms","start":"2026-02-10T14:56:02.620804Z","end":"2026-02-10T14:56:02.937048Z","steps":["trace[651670882] 'process raft request'  (duration: 315.884245ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:56:02.937105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:56:02.62075Z","time spent":"316.32064ms","remote":"127.0.0.1:38470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:826 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-10T14:56:02.93723Z","caller":"traceutil/trace.go:171","msg":"trace[438616251] transaction","detail":"{read_only:false; response_revision:832; number_of_response:1; }","duration":"314.713191ms","start":"2026-02-10T14:56:02.622511Z","end":"2026-02-10T14:56:02.937225Z","steps":["trace[438616251] 'process raft request'  (duration: 314.240436ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:56:02.937263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:56:02.622501Z","time spent":"314.746301ms","remote":"127.0.0.1:38470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:827 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-10T14:56:33.637177Z","caller":"traceutil/trace.go:171","msg":"trace[703392667] transaction","detail":"{read_only:false; response_revision:935; number_of_response:1; }","duration":"120.201714ms","start":"2026-02-10T14:56:33.516945Z","end":"2026-02-10T14:56:33.637146Z","steps":["trace[703392667] 'process raft request'  (duration: 119.479065ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T14:56:34.697729Z","caller":"traceutil/trace.go:171","msg":"trace[1563343179] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"254.362486ms","start":"2026-02-10T14:56:34.443341Z","end":"2026-02-10T14:56:34.697704Z","steps":["trace[1563343179] 'process raft request'  (duration: 253.676717ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T14:56:34.809982Z","caller":"traceutil/trace.go:171","msg":"trace[1832554732] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"106.796131ms","start":"2026-02-10T14:56:34.703157Z","end":"2026-02-10T14:56:34.809953Z","steps":["trace[1832554732] 'process raft request'  (duration: 58.110935ms)","trace[1832554732] 'compare'  (duration: 48.258554ms)"],"step_count":2}
{"level":"info","ts":"2026-02-10T14:56:34.81077Z","caller":"traceutil/trace.go:171","msg":"trace[321794815] linearizableReadLoop","detail":"{readStateIndex:987; appliedIndex:986; }","duration":"105.267749ms","start":"2026-02-10T14:56:34.705486Z","end":"2026-02-10T14:56:34.810754Z","steps":["trace[321794815] 'read index received'  (duration: 55.918267ms)","trace[321794815] 'applied index is now lower than readState.Index'  (duration: 49.348292ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-10T14:56:34.811126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.618089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:1536"}
{"level":"info","ts":"2026-02-10T14:56:34.811322Z","caller":"traceutil/trace.go:171","msg":"trace[739756205] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:943; }","duration":"105.834415ms","start":"2026-02-10T14:56:34.70547Z","end":"2026-02-10T14:56:34.811305Z","steps":["trace[739756205] 'agreement among raft nodes before linearized reading'  (duration: 105.533366ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T14:56:34.812155Z","caller":"traceutil/trace.go:171","msg":"trace[18789538] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"104.352805ms","start":"2026-02-10T14:56:34.707787Z","end":"2026-02-10T14:56:34.81214Z","steps":["trace[18789538] 'process raft request'  (duration: 101.919701ms)"],"step_count":1}
{"level":"info","ts":"2026-02-10T14:56:34.964864Z","caller":"traceutil/trace.go:171","msg":"trace[237209005] linearizableReadLoop","detail":"{readStateIndex:991; appliedIndex:990; }","duration":"105.190147ms","start":"2026-02-10T14:56:34.859654Z","end":"2026-02-10T14:56:34.964845Z","steps":["trace[237209005] 'read index received'  (duration: 102.583688ms)","trace[237209005] 'applied index is now lower than readState.Index'  (duration: 2.605559ms)"],"step_count":2}
{"level":"info","ts":"2026-02-10T14:56:34.965496Z","caller":"traceutil/trace.go:171","msg":"trace[1376038255] transaction","detail":"{read_only:false; response_revision:946; number_of_response:1; }","duration":"147.363979ms","start":"2026-02-10T14:56:34.818119Z","end":"2026-02-10T14:56:34.965483Z","steps":["trace[1376038255] 'process raft request'  (duration: 144.160854ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-10T14:56:34.969095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.421049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:1 size:1465"}
{"level":"info","ts":"2026-02-10T14:56:34.969405Z","caller":"traceutil/trace.go:171","msg":"trace[1688480665] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:946; }","duration":"109.739498ms","start":"2026-02-10T14:56:34.859649Z","end":"2026-02-10T14:56:34.969388Z","steps":["trace[1688480665] 'agreement among raft nodes before linearized reading'  (duration: 109.289786ms)"],"step_count":1}