{"level":"warn","ts":"2026-02-09T08:36:17.715492Z","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-09T08:36:17.71558Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.209: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.209:2380","--initial-cluster=instance=https://162.253.55.209:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.209:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.209: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-09T08:36:17.715651Z","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-09T08:36:17.715665Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.209:2380"]} {"level":"info","ts":"2026-02-09T08:36:17.715688Z","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-09T08:36:17.717716Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.209:2379"]} {"level":"info","ts":"2026-02-09T08:36:17.717957Z","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.209:2380"],"listen-peer-urls":["https://162.253.55.209:2380"],"advertise-client-urls":["https://162.253.55.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.209: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-09T08:36:17.725536Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.112821ms"} {"level":"info","ts":"2026-02-09T08:36:17.747895Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"53de2bdd9aa7b793","cluster-id":"385802231390d48c"} {"level":"info","ts":"2026-02-09T08:36:17.748078Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 switched to configuration voters=()"} {"level":"info","ts":"2026-02-09T08:36:17.74817Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 became follower at term 0"} {"level":"info","ts":"2026-02-09T08:36:17.748257Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 53de2bdd9aa7b793 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-09T08:36:17.748335Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 became follower at term 1"} {"level":"info","ts":"2026-02-09T08:36:17.748499Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 switched to configuration voters=(6043315980760233875)"} {"level":"warn","ts":"2026-02-09T08:36:17.756742Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-09T08:36:17.760919Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-09T08:36:17.764929Z","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-09T08:36:17.770253Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"53de2bdd9aa7b793","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-09T08:36:17.782688Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"53de2bdd9aa7b793","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-09T08:36:17.791087Z","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-09T08:36:17.791331Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"53de2bdd9aa7b793","initial-advertise-peer-urls":["https://162.253.55.209:2380"],"listen-peer-urls":["https://162.253.55.209:2380"],"advertise-client-urls":["https://162.253.55.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-09T08:36:17.79136Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-09T08:36:17.791339Z","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-09T08:36:17.79158Z","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-09T08:36:17.791637Z","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-09T08:36:17.792201Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.209:2380"} {"level":"info","ts":"2026-02-09T08:36:17.792248Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.209:2380"} {"level":"info","ts":"2026-02-09T08:36:17.794243Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 switched to configuration voters=(6043315980760233875)"} {"level":"info","ts":"2026-02-09T08:36:17.794514Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"385802231390d48c","local-member-id":"53de2bdd9aa7b793","added-peer-id":"53de2bdd9aa7b793","added-peer-peer-urls":["https://162.253.55.209:2380"]} {"level":"info","ts":"2026-02-09T08:36:18.249656Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 is starting a new election at term 1"} {"level":"info","ts":"2026-02-09T08:36:18.24984Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-09T08:36:18.249916Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 received MsgPreVoteResp from 53de2bdd9aa7b793 at term 1"} {"level":"info","ts":"2026-02-09T08:36:18.249945Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 became candidate at term 2"} {"level":"info","ts":"2026-02-09T08:36:18.249995Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 received MsgVoteResp from 53de2bdd9aa7b793 at term 2"} {"level":"info","ts":"2026-02-09T08:36:18.250015Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 became leader at term 2"} {"level":"info","ts":"2026-02-09T08:36:18.250035Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 53de2bdd9aa7b793 elected leader 53de2bdd9aa7b793 at term 2"} {"level":"info","ts":"2026-02-09T08:36:18.251361Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-09T08:36:18.252508Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"53de2bdd9aa7b793","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.209:2379]}","request-path":"/0/members/53de2bdd9aa7b793/attributes","cluster-id":"385802231390d48c","publish-timeout":"7s"} {"level":"info","ts":"2026-02-09T08:36:18.252686Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-09T08:36:18.253035Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-09T08:36:18.253148Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"385802231390d48c","local-member-id":"53de2bdd9aa7b793","cluster-version":"3.5"} {"level":"info","ts":"2026-02-09T08:36:18.253335Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-09T08:36:18.253487Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-09T08:36:18.253617Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-09T08:36:18.25364Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-09T08:36:18.256963Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.209:2379"} {"level":"info","ts":"2026-02-09T08:36:18.261821Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-09T08:36:20.253092Z","caller":"traceutil/trace.go:171","msg":"trace[236556895] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"208.581162ms","start":"2026-02-09T08:36:20.04449Z","end":"2026-02-09T08:36:20.253071Z","steps":["trace[236556895] 'read index received' (duration: 39.467081ms)","trace[236556895] 'applied index is now lower than readState.Index' (duration: 169.113111ms)"],"step_count":2} {"level":"info","ts":"2026-02-09T08:36:20.253211Z","caller":"traceutil/trace.go:171","msg":"trace[1529094684] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"208.856419ms","start":"2026-02-09T08:36:20.044346Z","end":"2026-02-09T08:36:20.253202Z","steps":["trace[1529094684] 'process raft request' (duration: 208.319177ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:36:20.253906Z","caller":"traceutil/trace.go:171","msg":"trace[408625626] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"206.448344ms","start":"2026-02-09T08:36:20.047446Z","end":"2026-02-09T08:36:20.253894Z","steps":["trace[408625626] 'process raft request' (duration: 205.332359ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:36:20.254183Z","caller":"traceutil/trace.go:171","msg":"trace[347338860] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"206.627337ms","start":"2026-02-09T08:36:20.047545Z","end":"2026-02-09T08:36:20.254172Z","steps":["trace[347338860] 'process raft request' (duration: 205.269047ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:36:20.254677Z","caller":"traceutil/trace.go:171","msg":"trace[378110090] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"205.846879ms","start":"2026-02-09T08:36:20.048819Z","end":"2026-02-09T08:36:20.254666Z","steps":["trace[378110090] 'process raft request' (duration: 204.030839ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:36:20.255047Z","caller":"traceutil/trace.go:171","msg":"trace[1508318449] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"206.190487ms","start":"2026-02-09T08:36:20.048845Z","end":"2026-02-09T08:36:20.255035Z","steps":["trace[1508318449] 'process raft request' (duration: 204.026319ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:36:20.255332Z","caller":"traceutil/trace.go:171","msg":"trace[891185155] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"206.458824ms","start":"2026-02-09T08:36:20.048863Z","end":"2026-02-09T08:36:20.255321Z","steps":["trace[891185155] 'process raft request' (duration: 204.124321ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:36:20.255798Z","caller":"traceutil/trace.go:171","msg":"trace[1504821020] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"206.204308ms","start":"2026-02-09T08:36:20.049581Z","end":"2026-02-09T08:36:20.255786Z","steps":["trace[1504821020] 'process raft request' (duration: 203.432345ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:36:20.256289Z","caller":"traceutil/trace.go:171","msg":"trace[269446722] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"179.721909ms","start":"2026-02-09T08:36:20.076555Z","end":"2026-02-09T08:36:20.256277Z","steps":["trace[269446722] 'process raft request' (duration: 176.485876ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:20.256642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.130571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-09T08:36:20.256698Z","caller":"traceutil/trace.go:171","msg":"trace[820102757] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"212.206964ms","start":"2026-02-09T08:36:20.044479Z","end":"2026-02-09T08:36:20.256686Z","steps":["trace[820102757] 'agreement among raft nodes before linearized reading' (duration: 212.076441ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:36:20.275354Z","caller":"traceutil/trace.go:171","msg":"trace[583235969] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"166.551403ms","start":"2026-02-09T08:36:20.108785Z","end":"2026-02-09T08:36:20.275337Z","steps":["trace[583235969] 'process raft request' (duration: 166.497061ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:20.275969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.051927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-09T08:36:20.275987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.784356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-09T08:36:20.276003Z","caller":"traceutil/trace.go:171","msg":"trace[566951244] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"188.092878ms","start":"2026-02-09T08:36:20.087902Z","end":"2026-02-09T08:36:20.275995Z","steps":["trace[566951244] 'agreement among raft nodes before linearized reading' (duration: 187.930435ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:36:20.276157Z","caller":"traceutil/trace.go:171","msg":"trace[871786678] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"173.974899ms","start":"2026-02-09T08:36:20.102161Z","end":"2026-02-09T08:36:20.276136Z","steps":["trace[871786678] 'agreement among raft nodes before linearized reading' (duration: 173.423407ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:20.276337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.566223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-09T08:36:20.276367Z","caller":"traceutil/trace.go:171","msg":"trace[207887881] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"174.624674ms","start":"2026-02-09T08:36:20.101735Z","end":"2026-02-09T08:36:20.27636Z","steps":["trace[207887881] 'agreement among raft nodes before linearized reading' (duration: 174.578253ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:20.276546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.379064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-09T08:36:20.27657Z","caller":"traceutil/trace.go:171","msg":"trace[883628422] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"184.423936ms","start":"2026-02-09T08:36:20.092141Z","end":"2026-02-09T08:36:20.276565Z","steps":["trace[883628422] 'agreement among raft nodes before linearized reading' (duration: 184.386575ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:20.277989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.660433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-09T08:36:20.278108Z","caller":"traceutil/trace.go:171","msg":"trace[328215635] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"227.780846ms","start":"2026-02-09T08:36:20.050318Z","end":"2026-02-09T08:36:20.278099Z","steps":["trace[328215635] 'agreement among raft nodes before linearized reading' (duration: 226.919346ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:20.278349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.624766ms","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-09T08:36:20.278483Z","caller":"traceutil/trace.go:171","msg":"trace[628357848] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"229.76669ms","start":"2026-02-09T08:36:20.048703Z","end":"2026-02-09T08:36:20.27847Z","steps":["trace[628357848] 'agreement among raft nodes before linearized reading' (duration: 229.626607ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:20.278692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.17556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.209\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-09T08:36:20.278796Z","caller":"traceutil/trace.go:171","msg":"trace[513130415] range","detail":"{range_begin:/registry/masterleases/162.253.55.209; range_end:; response_count:0; response_revision:11; }","duration":"234.292902ms","start":"2026-02-09T08:36:20.044489Z","end":"2026-02-09T08:36:20.278782Z","steps":["trace[513130415] 'agreement among raft nodes before linearized reading' (duration: 234.1855ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:36:20.406563Z","caller":"traceutil/trace.go:171","msg":"trace[693788063] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"117.644558ms","start":"2026-02-09T08:36:20.288892Z","end":"2026-02-09T08:36:20.406537Z","steps":["trace[693788063] 'process raft request' (duration: 87.951086ms)","trace[693788063] 'compare' (duration: 28.648417ms)"],"step_count":2} {"level":"info","ts":"2026-02-09T08:36:20.406576Z","caller":"traceutil/trace.go:171","msg":"trace[1371670200] transaction","detail":"{read_only:false; number_of_response:0; response_revision:19; }","duration":"117.534585ms","start":"2026-02-09T08:36:20.289019Z","end":"2026-02-09T08:36:20.406553Z","steps":["trace[1371670200] 'process raft request' (duration: 117.353381ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:20.406893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.368332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-09T08:36:20.407408Z","caller":"traceutil/trace.go:171","msg":"trace[360614021] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19; }","duration":"121.902545ms","start":"2026-02-09T08:36:20.285488Z","end":"2026-02-09T08:36:20.407391Z","steps":["trace[360614021] 'agreement among raft nodes before linearized reading' (duration: 121.329572ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:20.406943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.466704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3179"} {"level":"info","ts":"2026-02-09T08:36:20.407873Z","caller":"traceutil/trace.go:171","msg":"trace[123261572] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:19; }","duration":"122.406626ms","start":"2026-02-09T08:36:20.285447Z","end":"2026-02-09T08:36:20.407853Z","steps":["trace[123261572] 'agreement among raft nodes before linearized reading' (duration: 121.473905ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:36:20.4069Z","caller":"traceutil/trace.go:171","msg":"trace[981440602] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"117.921003ms","start":"2026-02-09T08:36:20.288966Z","end":"2026-02-09T08:36:20.406886Z","steps":["trace[981440602] 'process raft request' (duration: 116.640864ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:36:20.573185Z","caller":"traceutil/trace.go:171","msg":"trace[871520542] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"159.611215ms","start":"2026-02-09T08:36:20.41356Z","end":"2026-02-09T08:36:20.573172Z","steps":["trace[871520542] 'process raft request' (duration: 159.588074ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:36:20.573772Z","caller":"traceutil/trace.go:171","msg":"trace[999103368] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"252.138016ms","start":"2026-02-09T08:36:20.321606Z","end":"2026-02-09T08:36:20.573744Z","steps":["trace[999103368] 'process raft request' (duration: 251.4313ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:36:20.57383Z","caller":"traceutil/trace.go:171","msg":"trace[1386794862] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"256.763669ms","start":"2026-02-09T08:36:20.317055Z","end":"2026-02-09T08:36:20.573819Z","steps":["trace[1386794862] 'process raft request' (duration: 218.878324ms)","trace[1386794862] 'compare' (duration: 36.950134ms)"],"step_count":2} {"level":"info","ts":"2026-02-09T08:36:20.573856Z","caller":"traceutil/trace.go:171","msg":"trace[860937872] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"255.421629ms","start":"2026-02-09T08:36:20.318428Z","end":"2026-02-09T08:36:20.573849Z","steps":["trace[860937872] 'process raft request' (duration: 254.546169ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:36:20.573882Z","caller":"traceutil/trace.go:171","msg":"trace[634040395] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"255.281746ms","start":"2026-02-09T08:36:20.318594Z","end":"2026-02-09T08:36:20.573875Z","steps":["trace[634040395] 'process raft request' (duration: 254.407617ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:36:20.573906Z","caller":"traceutil/trace.go:171","msg":"trace[1498382785] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"254.791795ms","start":"2026-02-09T08:36:20.319107Z","end":"2026-02-09T08:36:20.573898Z","steps":["trace[1498382785] 'process raft request' (duration: 253.912175ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:36:20.573943Z","caller":"traceutil/trace.go:171","msg":"trace[1472118783] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"252.175866ms","start":"2026-02-09T08:36:20.321759Z","end":"2026-02-09T08:36:20.573935Z","steps":["trace[1472118783] 'process raft request' (duration: 251.295716ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:36:20.57409Z","caller":"traceutil/trace.go:171","msg":"trace[139671786] linearizableReadLoop","detail":"{readStateIndex:29; appliedIndex:23; }","duration":"167.678456ms","start":"2026-02-09T08:36:20.406402Z","end":"2026-02-09T08:36:20.57408Z","steps":["trace[139671786] 'read index received' (duration: 129.542896ms)","trace[139671786] 'applied index is now lower than readState.Index' (duration: 38.13426ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T08:36:20.574274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.367194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-02-09T08:36:20.578055Z","caller":"traceutil/trace.go:171","msg":"trace[636628295] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:26; }","duration":"238.189581ms","start":"2026-02-09T08:36:20.339827Z","end":"2026-02-09T08:36:20.578016Z","steps":["trace[636628295] 'agreement among raft nodes before linearized reading' (duration: 234.301092ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:20.578361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.048351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-02-09T08:36:20.578402Z","caller":"traceutil/trace.go:171","msg":"trace[1848403419] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:26; }","duration":"166.797398ms","start":"2026-02-09T08:36:20.411595Z","end":"2026-02-09T08:36:20.578392Z","steps":["trace[1848403419] 'agreement among raft nodes before linearized reading' (duration: 166.713726ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:20.578848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.406596ms","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-09T08:36:20.578893Z","caller":"traceutil/trace.go:171","msg":"trace[1061033779] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:26; }","duration":"165.496208ms","start":"2026-02-09T08:36:20.413383Z","end":"2026-02-09T08:36:20.57888Z","steps":["trace[1061033779] 'agreement among raft nodes before linearized reading' (duration: 165.440227ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:22.836014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.512188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-02-09T08:36:22.836101Z","caller":"traceutil/trace.go:171","msg":"trace[146125055] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:225; }","duration":"103.630331ms","start":"2026-02-09T08:36:22.732452Z","end":"2026-02-09T08:36:22.836082Z","steps":["trace[146125055] 'range keys from in-memory index tree' (duration: 103.415476ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:36:31.612159Z","caller":"traceutil/trace.go:171","msg":"trace[439818348] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"169.963949ms","start":"2026-02-09T08:36:31.442181Z","end":"2026-02-09T08:36:31.612145Z","steps":["trace[439818348] 'process raft request' (duration: 169.665622ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:31.923489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.665539ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-09T08:36:31.923675Z","caller":"traceutil/trace.go:171","msg":"trace[1806292119] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"298.020243ms","start":"2026-02-09T08:36:31.625583Z","end":"2026-02-09T08:36:31.923603Z","steps":["trace[1806292119] 'process raft request' (duration: 109.418402ms)","trace[1806292119] 'compare' (duration: 187.491785ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T08:36:32.200257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.372051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-09T08:36:32.200336Z","caller":"traceutil/trace.go:171","msg":"trace[742586862] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:365; }","duration":"121.594447ms","start":"2026-02-09T08:36:32.078722Z","end":"2026-02-09T08:36:32.200316Z","steps":["trace[742586862] 'range keys from in-memory index tree' (duration: 121.29569ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:42.107592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:36:41.513336Z","time spent":"594.253114ms","remote":"127.0.0.1:35528","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-09T08:36:48.070922Z","caller":"traceutil/trace.go:171","msg":"trace[899804992] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"766.367452ms","start":"2026-02-09T08:36:47.304542Z","end":"2026-02-09T08:36:48.070909Z","steps":["trace[899804992] 'process raft request' (duration: 765.880221ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:48.071089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:36:47.304533Z","time spent":"766.470464ms","remote":"127.0.0.1:35752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T08:36:48.070662Z","caller":"traceutil/trace.go:171","msg":"trace[1239103734] linearizableReadLoop","detail":"{readStateIndex:494; appliedIndex:493; }","duration":"343.184013ms","start":"2026-02-09T08:36:47.727458Z","end":"2026-02-09T08:36:48.070642Z","steps":["trace[1239103734] 'read index received' (duration: 342.877076ms)","trace[1239103734] 'applied index is now lower than readState.Index' (duration: 306.017µs)"],"step_count":2} {"level":"warn","ts":"2026-02-09T08:36:48.071523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.063802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T08:36:48.071553Z","caller":"traceutil/trace.go:171","msg":"trace[231505587] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:473; }","duration":"344.115703ms","start":"2026-02-09T08:36:47.727426Z","end":"2026-02-09T08:36:48.071542Z","steps":["trace[231505587] 'agreement among raft nodes before linearized reading' (duration: 344.034571ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:48.071606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:36:47.7274Z","time spent":"344.199325ms","remote":"127.0.0.1:35486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-09T08:36:48.810914Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13228088335842072600,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-09T08:36:49.267251Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.175717948s","expected-duration":"1s"} {"level":"info","ts":"2026-02-09T08:36:49.268245Z","caller":"traceutil/trace.go:171","msg":"trace[799614831] linearizableReadLoop","detail":"{readStateIndex:495; appliedIndex:494; }","duration":"958.047711ms","start":"2026-02-09T08:36:48.310178Z","end":"2026-02-09T08:36:49.268226Z","steps":["trace[799614831] 'read index received' (duration: 957.259373ms)","trace[799614831] 'applied index is now lower than readState.Index' (duration: 787.148µs)"],"step_count":2} {"level":"info","ts":"2026-02-09T08:36:49.268747Z","caller":"traceutil/trace.go:171","msg":"trace[960410589] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"1.177259742s","start":"2026-02-09T08:36:48.091436Z","end":"2026-02-09T08:36:49.268696Z","steps":["trace[960410589] 'process raft request' (duration: 1.176041235s)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:49.26892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:36:48.091422Z","time spent":"1.177438566s","remote":"127.0.0.1:35670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4299,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-09T08:36:49.269152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"958.976502ms","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-09T08:36:49.269284Z","caller":"traceutil/trace.go:171","msg":"trace[381945905] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:474; }","duration":"959.174447ms","start":"2026-02-09T08:36:48.310096Z","end":"2026-02-09T08:36:49.26927Z","steps":["trace[381945905] 'agreement among raft nodes before linearized reading' (duration: 959.020394ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:49.269349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:36:48.310083Z","time spent":"959.256059ms","remote":"127.0.0.1:35752","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-09T08:36:49.269652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"930.680103ms","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-09T08:36:49.269743Z","caller":"traceutil/trace.go:171","msg":"trace[1416638824] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:474; }","duration":"930.805245ms","start":"2026-02-09T08:36:48.338925Z","end":"2026-02-09T08:36:49.26973Z","steps":["trace[1416638824] 'agreement among raft nodes before linearized reading' (duration: 930.596001ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:49.269806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:36:48.33891Z","time spent":"930.886027ms","remote":"127.0.0.1:35752","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-09T08:36:49.270133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"652.13663ms","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-09T08:36:49.270359Z","caller":"traceutil/trace.go:171","msg":"trace[587143123] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:474; }","duration":"652.392906ms","start":"2026-02-09T08:36:48.617953Z","end":"2026-02-09T08:36:49.270346Z","steps":["trace[587143123] 'agreement among raft nodes before linearized reading' (duration: 652.143681ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:49.270431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:36:48.617935Z","time spent":"652.480779ms","remote":"127.0.0.1:35752","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-09T08:36:52.148402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.170031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T08:36:52.148446Z","caller":"traceutil/trace.go:171","msg":"trace[1088090717] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:483; }","duration":"424.235562ms","start":"2026-02-09T08:36:51.724198Z","end":"2026-02-09T08:36:52.148434Z","steps":["trace[1088090717] 'range keys from in-memory index tree' (duration: 424.12726ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:52.148463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:36:51.724186Z","time spent":"424.272314ms","remote":"127.0.0.1:35486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-09T08:36:52.416224Z","caller":"traceutil/trace.go:171","msg":"trace[207565196] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"264.098785ms","start":"2026-02-09T08:36:52.152103Z","end":"2026-02-09T08:36:52.416202Z","steps":["trace[207565196] 'process raft request' (duration: 263.961262ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:53.055867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.025571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T08:36:53.055935Z","caller":"traceutil/trace.go:171","msg":"trace[1708169406] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:484; }","duration":"329.144324ms","start":"2026-02-09T08:36:52.726775Z","end":"2026-02-09T08:36:53.055919Z","steps":["trace[1708169406] 'range keys from in-memory index tree' (duration: 328.94924ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:53.055974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:36:52.726755Z","time spent":"329.211876ms","remote":"127.0.0.1:35486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-09T08:36:53.05621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.684584ms","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-09T08:36:53.056268Z","caller":"traceutil/trace.go:171","msg":"trace[1483118505] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:484; }","duration":"444.746006ms","start":"2026-02-09T08:36:52.611513Z","end":"2026-02-09T08:36:53.056259Z","steps":["trace[1483118505] 'range keys from in-memory index tree' (duration: 444.675883ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:36:53.529562Z","caller":"traceutil/trace.go:171","msg":"trace[994625334] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"139.263766ms","start":"2026-02-09T08:36:53.390279Z","end":"2026-02-09T08:36:53.529543Z","steps":["trace[994625334] 'process raft request' (duration: 83.986168ms)","trace[994625334] 'compare' (duration: 55.150125ms)"],"step_count":2} {"level":"info","ts":"2026-02-09T08:36:53.52971Z","caller":"traceutil/trace.go:171","msg":"trace[277886558] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"138.066278ms","start":"2026-02-09T08:36:53.391638Z","end":"2026-02-09T08:36:53.529705Z","steps":["trace[277886558] 'process raft request' (duration: 137.870704ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:58.131928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.753541ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-02-09T08:36:58.132026Z","caller":"traceutil/trace.go:171","msg":"trace[788423715] linearizableReadLoop","detail":"{readStateIndex:519; appliedIndex:518; }","duration":"732.760291ms","start":"2026-02-09T08:36:57.39925Z","end":"2026-02-09T08:36:58.132011Z","steps":["trace[788423715] 'read index received' (duration: 127.916859ms)","trace[788423715] 'applied index is now lower than readState.Index' (duration: 604.842132ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T08:36:58.132308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.480849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T08:36:58.132338Z","caller":"traceutil/trace.go:171","msg":"trace[1198684792] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:496; }","duration":"405.54165ms","start":"2026-02-09T08:36:57.726787Z","end":"2026-02-09T08:36:58.132328Z","steps":["trace[1198684792] 'agreement among raft nodes before linearized reading' (duration: 405.492419ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:58.132368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:36:57.726773Z","time spent":"405.587611ms","remote":"127.0.0.1:35492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-09T08:36:58.132379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"733.097689ms","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-09T08:36:58.132457Z","caller":"traceutil/trace.go:171","msg":"trace[146414714] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:496; }","duration":"733.227072ms","start":"2026-02-09T08:36:57.399211Z","end":"2026-02-09T08:36:58.132438Z","steps":["trace[146414714] 'agreement among raft nodes before linearized reading' (duration: 732.935805ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:58.132503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:36:57.399189Z","time spent":"733.305655ms","remote":"127.0.0.1:35752","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-09T08:36:58.13256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.368495ms","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-09T08:36:58.132589Z","caller":"traceutil/trace.go:171","msg":"trace[1065560496] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:496; }","duration":"578.416736ms","start":"2026-02-09T08:36:57.554164Z","end":"2026-02-09T08:36:58.132581Z","steps":["trace[1065560496] 'agreement among raft nodes before linearized reading' (duration: 578.347284ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:58.132644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:36:57.554153Z","time spent":"578.484068ms","remote":"127.0.0.1:35752","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-09T08:36:58.132837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.599848ms","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-09T08:36:58.132873Z","caller":"traceutil/trace.go:171","msg":"trace[512270149] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:496; }","duration":"589.6721ms","start":"2026-02-09T08:36:57.54319Z","end":"2026-02-09T08:36:58.132862Z","steps":["trace[512270149] 'agreement among raft nodes before linearized reading' (duration: 589.335923ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:58.132902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:36:57.543171Z","time spent":"589.724172ms","remote":"127.0.0.1:35752","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-09T08:36:58.132993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.293504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-p9mvj\" ","response":"range_response_count:1 size:16656"} {"level":"info","ts":"2026-02-09T08:36:58.133025Z","caller":"traceutil/trace.go:171","msg":"trace[859371752] range","detail":"{range_begin:/registry/pods/kube-system/cilium-p9mvj; range_end:; response_count:1; response_revision:496; }","duration":"609.337295ms","start":"2026-02-09T08:36:57.523679Z","end":"2026-02-09T08:36:58.133016Z","steps":["trace[859371752] 'agreement among raft nodes before linearized reading' (duration: 608.563116ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:58.133054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:36:57.523672Z","time spent":"609.376425ms","remote":"127.0.0.1:35676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16678,"request content":"key:\"/registry/pods/kube-system/cilium-p9mvj\" "} {"level":"info","ts":"2026-02-09T08:36:58.92441Z","caller":"traceutil/trace.go:171","msg":"trace[348370707] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"786.902356ms","start":"2026-02-09T08:36:58.137493Z","end":"2026-02-09T08:36:58.924395Z","steps":["trace[348370707] 'process raft request' (duration: 786.814554ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:58.9245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:36:58.137404Z","time spent":"787.047279ms","remote":"127.0.0.1:35752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T08:36:58.985907Z","caller":"traceutil/trace.go:171","msg":"trace[1701000014] linearizableReadLoop","detail":"{readStateIndex:523; appliedIndex:520; }","duration":"552.49187ms","start":"2026-02-09T08:36:58.4334Z","end":"2026-02-09T08:36:58.985892Z","steps":["trace[1701000014] 'read index received' (duration: 491.347698ms)","trace[1701000014] 'applied index is now lower than readState.Index' (duration: 61.143612ms)"],"step_count":2} {"level":"info","ts":"2026-02-09T08:36:58.986052Z","caller":"traceutil/trace.go:171","msg":"trace[217424554] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"847.522874ms","start":"2026-02-09T08:36:58.138523Z","end":"2026-02-09T08:36:58.986046Z","steps":["trace[217424554] 'process raft request' (duration: 847.253868ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:58.986105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:36:58.138515Z","time spent":"847.550244ms","remote":"127.0.0.1:35752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T08:36:58.98619Z","caller":"traceutil/trace.go:171","msg":"trace[702846206] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"846.952191ms","start":"2026-02-09T08:36:58.139233Z","end":"2026-02-09T08:36:58.986186Z","steps":["trace[702846206] 'process raft request' (duration: 846.615004ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:58.98623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:36:58.139225Z","time spent":"846.975051ms","remote":"127.0.0.1:35752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T08:36:58.98637Z","caller":"traceutil/trace.go:171","msg":"trace[1129009346] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"838.93008ms","start":"2026-02-09T08:36:58.147435Z","end":"2026-02-09T08:36:58.986365Z","steps":["trace[1129009346] 'process raft request' (duration: 838.433079ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:58.986394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:36:58.147426Z","time spent":"838.95443ms","remote":"127.0.0.1:35676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-09T08:36:58.986455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.066362ms","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-09T08:36:58.986471Z","caller":"traceutil/trace.go:171","msg":"trace[2118136660] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:500; }","duration":"553.119353ms","start":"2026-02-09T08:36:58.433346Z","end":"2026-02-09T08:36:58.986465Z","steps":["trace[2118136660] 'agreement among raft nodes before linearized reading' (duration: 553.092063ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:36:58.986502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:36:58.433322Z","time spent":"553.160905ms","remote":"127.0.0.1:35752","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-09T08:36:58.98657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.980982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T08:36:58.986581Z","caller":"traceutil/trace.go:171","msg":"trace[945835624] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:500; }","duration":"259.992182ms","start":"2026-02-09T08:36:58.726586Z","end":"2026-02-09T08:36:58.986578Z","steps":["trace[945835624] 'agreement among raft nodes before linearized reading' (duration: 259.974091ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:37:01.102629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.518856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T08:37:01.102764Z","caller":"traceutil/trace.go:171","msg":"trace[445882292] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:509; }","duration":"376.615067ms","start":"2026-02-09T08:37:00.726065Z","end":"2026-02-09T08:37:01.10268Z","steps":["trace[445882292] 'range keys from in-memory index tree' (duration: 376.459675ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:37:01.102804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:37:00.726035Z","time spent":"376.759791ms","remote":"127.0.0.1:35486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-09T08:37:01.103142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.533575ms","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-09T08:37:01.103178Z","caller":"traceutil/trace.go:171","msg":"trace[1925563212] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:509; }","duration":"175.563546ms","start":"2026-02-09T08:37:00.9276Z","end":"2026-02-09T08:37:01.103164Z","steps":["trace[1925563212] 'range keys from in-memory index tree' (duration: 175.469274ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:37:01.103389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.351288ms","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-09T08:37:01.103416Z","caller":"traceutil/trace.go:171","msg":"trace[635593090] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:509; }","duration":"112.41534ms","start":"2026-02-09T08:37:00.990993Z","end":"2026-02-09T08:37:01.103408Z","steps":["trace[635593090] 'range keys from in-memory index tree' (duration: 112.233856ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:37:01.103622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.622128ms","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-09T08:37:01.103649Z","caller":"traceutil/trace.go:171","msg":"trace[202818821] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:509; }","duration":"110.6954ms","start":"2026-02-09T08:37:00.992946Z","end":"2026-02-09T08:37:01.103641Z","steps":["trace[202818821] 'range keys from in-memory index tree' (duration: 110.528256ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:37:01.10376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.721161ms","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-09T08:37:01.103783Z","caller":"traceutil/trace.go:171","msg":"trace[2136470435] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:509; }","duration":"102.757222ms","start":"2026-02-09T08:37:01.001019Z","end":"2026-02-09T08:37:01.103777Z","steps":["trace[2136470435] 'range keys from in-memory index tree' (duration: 102.682729ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:37:05.369837Z","caller":"traceutil/trace.go:171","msg":"trace[23330130] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"122.846565ms","start":"2026-02-09T08:37:05.246964Z","end":"2026-02-09T08:37:05.369811Z","steps":["trace[23330130] 'process raft request' (duration: 121.879074ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:37:08.368107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.606317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" ","response":"range_response_count:1 size:2252"} {"level":"info","ts":"2026-02-09T08:37:08.368202Z","caller":"traceutil/trace.go:171","msg":"trace[396366259] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:1; response_revision:613; }","duration":"229.747909ms","start":"2026-02-09T08:37:08.138431Z","end":"2026-02-09T08:37:08.368179Z","steps":["trace[396366259] 'range keys from in-memory index tree' (duration: 229.382981ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:37:09.912509Z","caller":"traceutil/trace.go:171","msg":"trace[662176976] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"164.038171ms","start":"2026-02-09T08:37:09.748451Z","end":"2026-02-09T08:37:09.912489Z","steps":["trace[662176976] 'process raft request' (duration: 107.399997ms)","trace[662176976] 'compare' (duration: 54.752789ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T08:37:17.983863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.722403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T08:37:17.983922Z","caller":"traceutil/trace.go:171","msg":"trace[953401481] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:683; }","duration":"255.817237ms","start":"2026-02-09T08:37:17.72809Z","end":"2026-02-09T08:37:17.983907Z","steps":["trace[953401481] 'range keys from in-memory index tree' (duration: 255.640469ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:37:17.984143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.561726ms","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-09T08:37:17.984163Z","caller":"traceutil/trace.go:171","msg":"trace[128437169] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:683; }","duration":"219.607217ms","start":"2026-02-09T08:37:17.764549Z","end":"2026-02-09T08:37:17.984156Z","steps":["trace[128437169] 'range keys from in-memory index tree' (duration: 219.461393ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:37:20.675313Z","caller":"traceutil/trace.go:171","msg":"trace[596998815] transaction","detail":"{read_only:false; response_revision:689; number_of_response:1; }","duration":"646.167412ms","start":"2026-02-09T08:37:20.029123Z","end":"2026-02-09T08:37:20.67529Z","steps":["trace[596998815] 'process raft request' (duration: 646.043048ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:37:20.675467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:37:20.029111Z","time spent":"646.264194ms","remote":"127.0.0.1:35752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T08:37:33.69595Z","caller":"traceutil/trace.go:171","msg":"trace[2029407755] linearizableReadLoop","detail":"{readStateIndex:763; appliedIndex:762; }","duration":"313.535605ms","start":"2026-02-09T08:37:33.382394Z","end":"2026-02-09T08:37:33.695929Z","steps":["trace[2029407755] 'read index received' (duration: 313.378022ms)","trace[2029407755] 'applied index is now lower than readState.Index' (duration: 156.943µs)"],"step_count":2} {"level":"info","ts":"2026-02-09T08:37:33.696071Z","caller":"traceutil/trace.go:171","msg":"trace[488144927] transaction","detail":"{read_only:false; response_revision:731; number_of_response:1; }","duration":"330.13249ms","start":"2026-02-09T08:37:33.365932Z","end":"2026-02-09T08:37:33.696064Z","steps":["trace[488144927] 'process raft request' (duration: 329.849193ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:37:33.696169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:37:33.365917Z","time spent":"330.173052ms","remote":"127.0.0.1:35752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-09T08:37:33.696217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.146292ms","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-09T08:37:33.69625Z","caller":"traceutil/trace.go:171","msg":"trace[128548662] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:731; }","duration":"305.192593ms","start":"2026-02-09T08:37:33.391049Z","end":"2026-02-09T08:37:33.696242Z","steps":["trace[128548662] 'agreement among raft nodes before linearized reading' (duration: 305.096841ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:37:33.696272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:37:33.391042Z","time spent":"305.225124ms","remote":"127.0.0.1:35752","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-09T08:37:33.696348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.953585ms","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-09T08:37:33.696363Z","caller":"traceutil/trace.go:171","msg":"trace[1686988920] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:731; }","duration":"314.009417ms","start":"2026-02-09T08:37:33.382349Z","end":"2026-02-09T08:37:33.696358Z","steps":["trace[1686988920] 'agreement among raft nodes before linearized reading' (duration: 313.965066ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:37:33.696379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:37:33.382338Z","time spent":"314.037437ms","remote":"127.0.0.1:35752","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-09T08:37:33.696514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.615532ms","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-09T08:37:33.696557Z","caller":"traceutil/trace.go:171","msg":"trace[1393344284] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:731; }","duration":"259.676744ms","start":"2026-02-09T08:37:33.436874Z","end":"2026-02-09T08:37:33.69655Z","steps":["trace[1393344284] 'agreement among raft nodes before linearized reading' (duration: 259.595662ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:37:33.800194Z","caller":"traceutil/trace.go:171","msg":"trace[2054358495] transaction","detail":"{read_only:false; response_revision:732; number_of_response:1; }","duration":"100.13746ms","start":"2026-02-09T08:37:33.700038Z","end":"2026-02-09T08:37:33.800176Z","steps":["trace[2054358495] 'process raft request' (duration: 93.613226ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:37:36.030436Z","caller":"traceutil/trace.go:171","msg":"trace[1287305071] linearizableReadLoop","detail":"{readStateIndex:769; appliedIndex:768; }","duration":"226.056645ms","start":"2026-02-09T08:37:35.804358Z","end":"2026-02-09T08:37:36.030415Z","steps":["trace[1287305071] 'read index received' (duration: 225.80115ms)","trace[1287305071] 'applied index is now lower than readState.Index' (duration: 254.675µs)"],"step_count":2} {"level":"info","ts":"2026-02-09T08:37:36.030701Z","caller":"traceutil/trace.go:171","msg":"trace[1503198850] transaction","detail":"{read_only:false; response_revision:737; number_of_response:1; }","duration":"326.390049ms","start":"2026-02-09T08:37:35.704297Z","end":"2026-02-09T08:37:36.030687Z","steps":["trace[1503198850] 'process raft request' (duration: 325.95067ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:37:36.030788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:37:35.704285Z","time spent":"326.44316ms","remote":"127.0.0.1:35752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-09T08:37:36.031012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.651478ms","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-09T08:37:36.031041Z","caller":"traceutil/trace.go:171","msg":"trace[2088527174] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:737; }","duration":"226.70006ms","start":"2026-02-09T08:37:35.804332Z","end":"2026-02-09T08:37:36.031032Z","steps":["trace[2088527174] 'agreement among raft nodes before linearized reading' (duration: 226.605828ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:37:36.031239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.833062ms","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-09T08:37:36.031266Z","caller":"traceutil/trace.go:171","msg":"trace[1051988692] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:737; }","duration":"226.860292ms","start":"2026-02-09T08:37:35.804398Z","end":"2026-02-09T08:37:36.031258Z","steps":["trace[1051988692] 'agreement among raft nodes before linearized reading' (duration: 226.784021ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:37:36.031497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.168207ms","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-09T08:37:36.031523Z","caller":"traceutil/trace.go:171","msg":"trace[469060096] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:737; }","duration":"226.206478ms","start":"2026-02-09T08:37:35.80531Z","end":"2026-02-09T08:37:36.031516Z","steps":["trace[469060096] 'agreement among raft nodes before linearized reading' (duration: 226.134726ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:37:38.221401Z","caller":"traceutil/trace.go:171","msg":"trace[862603049] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"105.393105ms","start":"2026-02-09T08:37:38.115969Z","end":"2026-02-09T08:37:38.221362Z","steps":["trace[862603049] 'process raft request' (duration: 105.350444ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:37:38.221651Z","caller":"traceutil/trace.go:171","msg":"trace[1970142783] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"106.365606ms","start":"2026-02-09T08:37:38.115241Z","end":"2026-02-09T08:37:38.221607Z","steps":["trace[1970142783] 'process raft request' (duration: 34.877005ms)","trace[1970142783] 'compare' (duration: 70.893628ms)"],"step_count":2} {"level":"info","ts":"2026-02-09T08:37:38.221849Z","caller":"traceutil/trace.go:171","msg":"trace[1196048960] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"106.390156ms","start":"2026-02-09T08:37:38.11541Z","end":"2026-02-09T08:37:38.2218Z","steps":["trace[1196048960] 'process raft request' (duration: 105.812714ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:37:39.382074Z","caller":"traceutil/trace.go:171","msg":"trace[371338966] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"575.930208ms","start":"2026-02-09T08:37:38.806126Z","end":"2026-02-09T08:37:39.382056Z","steps":["trace[371338966] 'process raft request' (duration: 575.764165ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:37:39.382833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:37:38.806108Z","time spent":"576.636954ms","remote":"127.0.0.1:35752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-09T08:37:44.649909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.935142ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-09T08:37:44.650328Z","caller":"traceutil/trace.go:171","msg":"trace[996484001] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"387.196915ms","start":"2026-02-09T08:37:44.263115Z","end":"2026-02-09T08:37:44.650312Z","steps":["trace[996484001] 'process raft request' (duration: 387.076152ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:37:44.650413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:37:44.263108Z","time spent":"387.278227ms","remote":"127.0.0.1:35752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T08:37:44.65067Z","caller":"traceutil/trace.go:171","msg":"trace[668762400] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"388.72078ms","start":"2026-02-09T08:37:44.261938Z","end":"2026-02-09T08:37:44.650659Z","steps":["trace[668762400] 'process raft request' (duration: 32.923733ms)","trace[668762400] 'compare' (duration: 351.742038ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T08:37:44.650745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:37:44.261921Z","time spent":"388.800301ms","remote":"127.0.0.1:35752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T08:37:45.251494Z","caller":"traceutil/trace.go:171","msg":"trace[1060546065] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"149.057492ms","start":"2026-02-09T08:37:45.102419Z","end":"2026-02-09T08:37:45.251476Z","steps":["trace[1060546065] 'process raft request' (duration: 148.93323ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:37:45.772375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.871159ms","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-09T08:37:45.772443Z","caller":"traceutil/trace.go:171","msg":"trace[1836519222] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:763; }","duration":"331.983251ms","start":"2026-02-09T08:37:45.440444Z","end":"2026-02-09T08:37:45.772428Z","steps":["trace[1836519222] 'range keys from in-memory index tree' (duration: 331.714115ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:37:45.772482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:37:45.440426Z","time spent":"332.047623ms","remote":"127.0.0.1:35752","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-09T08:37:46.196671Z","caller":"traceutil/trace.go:171","msg":"trace[218625392] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"418.012171ms","start":"2026-02-09T08:37:45.77864Z","end":"2026-02-09T08:37:46.196652Z","steps":["trace[218625392] 'process raft request' (duration: 417.711394ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:37:46.196844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:37:45.778617Z","time spent":"418.169873ms","remote":"127.0.0.1:35752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-09T08:37:46.969271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.910542ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-09T08:37:46.969448Z","caller":"traceutil/trace.go:171","msg":"trace[1119669701] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"769.019282ms","start":"2026-02-09T08:37:46.2004Z","end":"2026-02-09T08:37:46.969419Z","steps":["trace[1119669701] 'process raft request' (duration: 394.853854ms)","trace[1119669701] 'compare' (duration: 373.80441ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T08:37:46.969602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:37:46.200383Z","time spent":"769.131994ms","remote":"127.0.0.1:35752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T08:37:46.969995Z","caller":"traceutil/trace.go:171","msg":"trace[1605204445] linearizableReadLoop","detail":"{readStateIndex:799; appliedIndex:798; }","duration":"713.589234ms","start":"2026-02-09T08:37:46.256363Z","end":"2026-02-09T08:37:46.969952Z","steps":["trace[1605204445] 'read index received' (duration: 338.844514ms)","trace[1605204445] 'applied index is now lower than readState.Index' (duration: 374.74378ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T08:37:47.006105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"629.335503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T08:37:47.00618Z","caller":"traceutil/trace.go:171","msg":"trace[1656344576] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:765; }","duration":"629.441476ms","start":"2026-02-09T08:37:46.37672Z","end":"2026-02-09T08:37:47.006161Z","steps":["trace[1656344576] 'agreement among raft nodes before linearized reading' (duration: 629.327963ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:37:47.006192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.226171ms","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-09T08:37:47.006243Z","caller":"traceutil/trace.go:171","msg":"trace[492614777] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:765; }","duration":"350.272752ms","start":"2026-02-09T08:37:46.655962Z","end":"2026-02-09T08:37:47.006235Z","steps":["trace[492614777] 'agreement among raft nodes before linearized reading' (duration: 350.193211ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:37:47.006254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:37:46.376707Z","time spent":"629.536188ms","remote":"127.0.0.1:35800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"warn","ts":"2026-02-09T08:37:47.006273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:37:46.655937Z","time spent":"350.329194ms","remote":"127.0.0.1:35752","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-09T08:37:47.006681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.749153ms","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-09T08:37:47.006716Z","caller":"traceutil/trace.go:171","msg":"trace[1074390831] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:765; }","duration":"350.823284ms","start":"2026-02-09T08:37:46.655883Z","end":"2026-02-09T08:37:47.006706Z","steps":["trace[1074390831] 'agreement among raft nodes before linearized reading' (duration: 350.699362ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:37:47.006743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:37:46.655862Z","time spent":"350.874515ms","remote":"127.0.0.1:35752","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":"warn","ts":"2026-02-09T08:37:47.006123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"749.751999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-09T08:37:47.006824Z","caller":"traceutil/trace.go:171","msg":"trace[1688661830] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:765; }","duration":"750.492815ms","start":"2026-02-09T08:37:46.256322Z","end":"2026-02-09T08:37:47.006814Z","steps":["trace[1688661830] 'agreement among raft nodes before linearized reading' (duration: 713.816089ms)","trace[1688661830] 'range keys from in-memory index tree' (duration: 35.882708ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T08:37:47.006856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:37:46.256303Z","time spent":"750.546266ms","remote":"127.0.0.1:35752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-09T08:37:47.226821Z","caller":"traceutil/trace.go:171","msg":"trace[70308751] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"213.50757ms","start":"2026-02-09T08:37:47.013292Z","end":"2026-02-09T08:37:47.226799Z","steps":["trace[70308751] 'process raft request' (duration: 213.464219ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:37:47.227588Z","caller":"traceutil/trace.go:171","msg":"trace[1955234734] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"214.303457ms","start":"2026-02-09T08:37:47.013254Z","end":"2026-02-09T08:37:47.227557Z","steps":["trace[1955234734] 'process raft request' (duration: 210.818381ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:37:58.532669Z","caller":"traceutil/trace.go:171","msg":"trace[472368862] transaction","detail":"{read_only:false; response_revision:848; number_of_response:1; }","duration":"276.202166ms","start":"2026-02-09T08:37:58.256449Z","end":"2026-02-09T08:37:58.532652Z","steps":["trace[472368862] 'process raft request' (duration: 276.060523ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:37:59.606269Z","caller":"traceutil/trace.go:171","msg":"trace[1165458220] linearizableReadLoop","detail":"{readStateIndex:890; appliedIndex:889; }","duration":"290.933031ms","start":"2026-02-09T08:37:59.315321Z","end":"2026-02-09T08:37:59.606254Z","steps":["trace[1165458220] 'read index received' (duration: 290.775188ms)","trace[1165458220] 'applied index is now lower than readState.Index' (duration: 157.353µs)"],"step_count":2} {"level":"info","ts":"2026-02-09T08:37:59.60645Z","caller":"traceutil/trace.go:171","msg":"trace[1804735357] transaction","detail":"{read_only:false; response_revision:850; number_of_response:1; }","duration":"450.082666ms","start":"2026-02-09T08:37:59.156362Z","end":"2026-02-09T08:37:59.606444Z","steps":["trace[1804735357] 'process raft request' (duration: 449.777469ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:37:59.606508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:37:59.156353Z","time spent":"450.112047ms","remote":"127.0.0.1:35752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-09T08:37:59.606656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.33488ms","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-09T08:37:59.606674Z","caller":"traceutil/trace.go:171","msg":"trace[363104096] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:850; }","duration":"291.37443ms","start":"2026-02-09T08:37:59.315293Z","end":"2026-02-09T08:37:59.606668Z","steps":["trace[363104096] 'agreement among raft nodes before linearized reading' (duration: 291.299378ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:37:59.606758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.36058ms","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-09T08:37:59.60677Z","caller":"traceutil/trace.go:171","msg":"trace[994043408] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:850; }","duration":"286.3833ms","start":"2026-02-09T08:37:59.320383Z","end":"2026-02-09T08:37:59.606766Z","steps":["trace[994043408] 'agreement among raft nodes before linearized reading' (duration: 286.348819ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:38:00.635922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"645.279702ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-09T08:38:00.635991Z","caller":"traceutil/trace.go:171","msg":"trace[682527873] transaction","detail":"{read_only:false; response_revision:851; number_of_response:1; }","duration":"1.025948413s","start":"2026-02-09T08:37:59.610031Z","end":"2026-02-09T08:38:00.635979Z","steps":["trace[682527873] 'process raft request' (duration: 380.562769ms)","trace[682527873] 'compare' (duration: 645.17885ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T08:38:00.63602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:37:59.610019Z","time spent":"1.025988034s","remote":"127.0.0.1:35752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-09T08:38:01.227232Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.236601029s","expected-duration":"1s"} {"level":"info","ts":"2026-02-09T08:38:01.228209Z","caller":"traceutil/trace.go:171","msg":"trace[333312532] linearizableReadLoop","detail":"{readStateIndex:892; appliedIndex:890; }","duration":"1.499584266s","start":"2026-02-09T08:37:59.72861Z","end":"2026-02-09T08:38:01.228194Z","steps":["trace[333312532] 'read index received' (duration: 262.050726ms)","trace[333312532] 'applied index is now lower than readState.Index' (duration: 1.2375327s)"],"step_count":2} {"level":"warn","ts":"2026-02-09T08:38:01.228307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.499686128s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T08:38:01.228282Z","caller":"traceutil/trace.go:171","msg":"trace[1521772907] transaction","detail":"{read_only:false; response_revision:852; number_of_response:1; }","duration":"1.615794708s","start":"2026-02-09T08:37:59.612469Z","end":"2026-02-09T08:38:01.228263Z","steps":["trace[1521772907] 'process raft request' (duration: 1.614877067s)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:38:01.228325Z","caller":"traceutil/trace.go:171","msg":"trace[653906580] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:852; }","duration":"1.499717229s","start":"2026-02-09T08:37:59.728602Z","end":"2026-02-09T08:38:01.228319Z","steps":["trace[653906580] 'agreement among raft nodes before linearized reading' (duration: 1.499652267s)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:38:01.228344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:37:59.728546Z","time spent":"1.499792911s","remote":"127.0.0.1:35638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":27,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"warn","ts":"2026-02-09T08:38:01.228392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:37:59.612462Z","time spent":"1.61587776s","remote":"127.0.0.1:35752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-09T08:38:01.22852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"691.411796ms","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-09T08:38:01.228534Z","caller":"traceutil/trace.go:171","msg":"trace[581268917] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:852; }","duration":"691.450666ms","start":"2026-02-09T08:38:00.53708Z","end":"2026-02-09T08:38:01.22853Z","steps":["trace[581268917] 'agreement among raft nodes before linearized reading' (duration: 691.383825ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:38:01.228546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:38:00.537065Z","time spent":"691.479057ms","remote":"127.0.0.1:35752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-09T08:38:01.228633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.919427ms","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-09T08:38:01.228647Z","caller":"traceutil/trace.go:171","msg":"trace[185338361] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:852; }","duration":"202.955579ms","start":"2026-02-09T08:38:01.025688Z","end":"2026-02-09T08:38:01.228643Z","steps":["trace[185338361] 'agreement among raft nodes before linearized reading' (duration: 202.917728ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:38:01.228693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.399241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T08:38:01.228704Z","caller":"traceutil/trace.go:171","msg":"trace[313986182] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:852; }","duration":"505.432122ms","start":"2026-02-09T08:38:00.723267Z","end":"2026-02-09T08:38:01.228699Z","steps":["trace[313986182] 'agreement among raft nodes before linearized reading' (duration: 505.414131ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:38:01.228714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:38:00.723219Z","time spent":"505.493383ms","remote":"127.0.0.1:35486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-09T08:38:08.846679Z","caller":"traceutil/trace.go:171","msg":"trace[1429768556] linearizableReadLoop","detail":"{readStateIndex:916; appliedIndex:915; }","duration":"121.244403ms","start":"2026-02-09T08:38:08.72541Z","end":"2026-02-09T08:38:08.846655Z","steps":["trace[1429768556] 'read index received' (duration: 121.069379ms)","trace[1429768556] 'applied index is now lower than readState.Index' (duration: 173.974µs)"],"step_count":2} {"level":"warn","ts":"2026-02-09T08:38:08.84681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.386486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T08:38:08.846842Z","caller":"traceutil/trace.go:171","msg":"trace[730632556] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:874; }","duration":"121.462077ms","start":"2026-02-09T08:38:08.725369Z","end":"2026-02-09T08:38:08.846831Z","steps":["trace[730632556] 'agreement among raft nodes before linearized reading' (duration: 121.374115ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:38:08.84718Z","caller":"traceutil/trace.go:171","msg":"trace[5735187] transaction","detail":"{read_only:false; response_revision:874; number_of_response:1; }","duration":"173.143972ms","start":"2026-02-09T08:38:08.674026Z","end":"2026-02-09T08:38:08.84717Z","steps":["trace[5735187] 'process raft request' (duration: 172.483578ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:38:09.678869Z","caller":"traceutil/trace.go:171","msg":"trace[403791860] transaction","detail":"{read_only:false; response_revision:875; number_of_response:1; }","duration":"352.610584ms","start":"2026-02-09T08:38:09.326245Z","end":"2026-02-09T08:38:09.678856Z","steps":["trace[403791860] 'process raft request' (duration: 352.530473ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:38:09.678955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:38:09.326202Z","time spent":"352.708257ms","remote":"127.0.0.1:35752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T08:38:09.759585Z","caller":"traceutil/trace.go:171","msg":"trace[81737175] linearizableReadLoop","detail":"{readStateIndex:919; appliedIndex:917; }","duration":"124.103915ms","start":"2026-02-09T08:38:09.635464Z","end":"2026-02-09T08:38:09.759568Z","steps":["trace[81737175] 'read index received' (duration: 43.462624ms)","trace[81737175] 'applied index is now lower than readState.Index' (duration: 80.640551ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T08:38:09.759725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.234898ms","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-09T08:38:09.759749Z","caller":"traceutil/trace.go:171","msg":"trace[1907803597] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:877; }","duration":"124.31283ms","start":"2026-02-09T08:38:09.635428Z","end":"2026-02-09T08:38:09.759741Z","steps":["trace[1907803597] 'agreement among raft nodes before linearized reading' (duration: 124.202578ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:38:09.759777Z","caller":"traceutil/trace.go:171","msg":"trace[424710638] transaction","detail":"{read_only:false; response_revision:876; number_of_response:1; }","duration":"433.350997ms","start":"2026-02-09T08:38:09.326409Z","end":"2026-02-09T08:38:09.75976Z","steps":["trace[424710638] 'process raft request' (duration: 421.394015ms)","trace[424710638] 'compare' (duration: 11.650196ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T08:38:09.759862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:38:09.326402Z","time spent":"433.413579ms","remote":"127.0.0.1:35752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T08:38:09.759896Z","caller":"traceutil/trace.go:171","msg":"trace[1698207640] transaction","detail":"{read_only:false; response_revision:877; number_of_response:1; }","duration":"431.268961ms","start":"2026-02-09T08:38:09.328619Z","end":"2026-02-09T08:38:09.759888Z","steps":["trace[1698207640] 'process raft request' (duration: 430.916844ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:38:09.759954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:38:09.328606Z","time spent":"431.309283ms","remote":"127.0.0.1:35752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T08:38:16.302331Z","caller":"traceutil/trace.go:171","msg":"trace[1508819472] transaction","detail":"{read_only:false; response_revision:896; number_of_response:1; }","duration":"330.172191ms","start":"2026-02-09T08:38:15.972122Z","end":"2026-02-09T08:38:16.302294Z","steps":["trace[1508819472] 'process raft request' (duration: 329.986387ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:38:16.302494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:38:15.972095Z","time spent":"330.303965ms","remote":"127.0.0.1:35752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T08:38:17.014569Z","caller":"traceutil/trace.go:171","msg":"trace[87965382] transaction","detail":"{read_only:false; response_revision:897; number_of_response:1; }","duration":"138.053989ms","start":"2026-02-09T08:38:16.876501Z","end":"2026-02-09T08:38:17.014555Z","steps":["trace[87965382] 'process raft request' (duration: 137.959617ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:38:25.37454Z","caller":"traceutil/trace.go:171","msg":"trace[1708735597] transaction","detail":"{read_only:false; response_revision:939; number_of_response:1; }","duration":"323.595072ms","start":"2026-02-09T08:38:25.050926Z","end":"2026-02-09T08:38:25.374521Z","steps":["trace[1708735597] 'process raft request' (duration: 323.466669ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:38:25.374796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:38:25.050915Z","time spent":"323.827616ms","remote":"127.0.0.1:35752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-09T08:38:25.918429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.58606ms","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-09T08:38:25.918483Z","caller":"traceutil/trace.go:171","msg":"trace[606273655] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:939; }","duration":"177.672841ms","start":"2026-02-09T08:38:25.740798Z","end":"2026-02-09T08:38:25.918471Z","steps":["trace[606273655] 'range keys from in-memory index tree' (duration: 177.501498ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:38:26.041603Z","caller":"traceutil/trace.go:171","msg":"trace[1961095901] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"117.636104ms","start":"2026-02-09T08:38:25.92395Z","end":"2026-02-09T08:38:26.041587Z","steps":["trace[1961095901] 'process raft request' (duration: 115.239562ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:38:26.041793Z","caller":"traceutil/trace.go:171","msg":"trace[341860612] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"114.576677ms","start":"2026-02-09T08:38:25.927209Z","end":"2026-02-09T08:38:26.041786Z","steps":["trace[341860612] 'process raft request' (duration: 114.067967ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:38:26.041891Z","caller":"traceutil/trace.go:171","msg":"trace[1558757631] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"114.25505ms","start":"2026-02-09T08:38:25.927629Z","end":"2026-02-09T08:38:26.041884Z","steps":["trace[1558757631] 'process raft request' (duration: 113.676507ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:38:34.57864Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13228088335842073737,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-09T08:38:34.875354Z","caller":"traceutil/trace.go:171","msg":"trace[1013245766] linearizableReadLoop","detail":"{readStateIndex:1018; appliedIndex:1017; }","duration":"797.282863ms","start":"2026-02-09T08:38:34.078049Z","end":"2026-02-09T08:38:34.875332Z","steps":["trace[1013245766] 'read index received' (duration: 797.10799ms)","trace[1013245766] 'applied index is now lower than readState.Index' (duration: 173.983µs)"],"step_count":2} {"level":"warn","ts":"2026-02-09T08:38:34.875676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"797.624251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-09T08:38:34.875713Z","caller":"traceutil/trace.go:171","msg":"trace[1991648365] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:971; }","duration":"797.703733ms","start":"2026-02-09T08:38:34.077996Z","end":"2026-02-09T08:38:34.8757Z","steps":["trace[1991648365] 'agreement among raft nodes before linearized reading' (duration: 797.586061ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:38:34.875738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:38:34.077977Z","time spent":"797.755244ms","remote":"127.0.0.1:35752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-09T08:38:34.875864Z","caller":"traceutil/trace.go:171","msg":"trace[1049537251] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"835.554388ms","start":"2026-02-09T08:38:34.040303Z","end":"2026-02-09T08:38:34.875857Z","steps":["trace[1049537251] 'process raft request' (duration: 834.910924ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:38:34.875862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"793.367429ms","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-09T08:38:34.875898Z","caller":"traceutil/trace.go:171","msg":"trace[520352304] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:971; }","duration":"793.428639ms","start":"2026-02-09T08:38:34.082459Z","end":"2026-02-09T08:38:34.875888Z","steps":["trace[520352304] 'agreement among raft nodes before linearized reading' (duration: 793.333347ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:38:34.875923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:38:34.040288Z","time spent":"835.592558ms","remote":"127.0.0.1:35752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-09T08:38:34.875926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:38:34.082447Z","time spent":"793.472271ms","remote":"127.0.0.1:35752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-09T08:38:34.876041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.015628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T08:38:34.876068Z","caller":"traceutil/trace.go:171","msg":"trace[545240166] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:971; }","duration":"149.091759ms","start":"2026-02-09T08:38:34.726968Z","end":"2026-02-09T08:38:34.87606Z","steps":["trace[545240166] 'agreement among raft nodes before linearized reading' (duration: 149.050358ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:38:34.876232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"790.038516ms","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-09T08:38:34.876253Z","caller":"traceutil/trace.go:171","msg":"trace[1100005550] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:971; }","duration":"790.071437ms","start":"2026-02-09T08:38:34.086175Z","end":"2026-02-09T08:38:34.876246Z","steps":["trace[1100005550] 'agreement among raft nodes before linearized reading' (duration: 790.012766ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:38:34.876272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T08:38:34.086155Z","time spent":"790.111698ms","remote":"127.0.0.1:35752","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-09T08:38:35.150971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.888461ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-09T08:38:35.151162Z","caller":"traceutil/trace.go:171","msg":"trace[1039369204] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"267.475028ms","start":"2026-02-09T08:38:34.883668Z","end":"2026-02-09T08:38:35.151143Z","steps":["trace[1039369204] 'process raft request' (duration: 267.441137ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:38:35.151478Z","caller":"traceutil/trace.go:171","msg":"trace[659156828] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"271.486036ms","start":"2026-02-09T08:38:34.879979Z","end":"2026-02-09T08:38:35.151465Z","steps":["trace[659156828] 'process raft request' (duration: 40.028753ms)","trace[659156828] 'compare' (duration: 230.714197ms)"],"step_count":2} {"level":"info","ts":"2026-02-09T08:38:35.15159Z","caller":"traceutil/trace.go:171","msg":"trace[1198637185] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"269.776799ms","start":"2026-02-09T08:38:34.881806Z","end":"2026-02-09T08:38:35.151582Z","steps":["trace[1198637185] 'process raft request' (duration: 269.255977ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:38:37.260248Z","caller":"traceutil/trace.go:171","msg":"trace[563054582] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"100.223344ms","start":"2026-02-09T08:38:37.160009Z","end":"2026-02-09T08:38:37.260232Z","steps":["trace[563054582] 'process raft request' (duration: 100.081601ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:38:37.263094Z","caller":"traceutil/trace.go:171","msg":"trace[1244649272] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"102.088135ms","start":"2026-02-09T08:38:37.160999Z","end":"2026-02-09T08:38:37.263087Z","steps":["trace[1244649272] 'process raft request' (duration: 102.067955ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:38:37.26323Z","caller":"traceutil/trace.go:171","msg":"trace[574387297] transaction","detail":"{read_only:false; response_revision:987; number_of_response:1; }","duration":"102.642447ms","start":"2026-02-09T08:38:37.160583Z","end":"2026-02-09T08:38:37.263225Z","steps":["trace[574387297] 'process raft request' (duration: 102.456053ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:38:41.652615Z","caller":"traceutil/trace.go:171","msg":"trace[216225183] linearizableReadLoop","detail":"{readStateIndex:1059; appliedIndex:1058; }","duration":"104.306503ms","start":"2026-02-09T08:38:41.548291Z","end":"2026-02-09T08:38:41.652597Z","steps":["trace[216225183] 'read index received' (duration: 99.069599ms)","trace[216225183] 'applied index is now lower than readState.Index' (duration: 5.236344ms)"],"step_count":2} {"level":"info","ts":"2026-02-09T08:38:41.652695Z","caller":"traceutil/trace.go:171","msg":"trace[45945448] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"112.584473ms","start":"2026-02-09T08:38:41.540102Z","end":"2026-02-09T08:38:41.652687Z","steps":["trace[45945448] 'process raft request' (duration: 107.295898ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T08:38:41.653242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.934376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-09T08:38:41.653272Z","caller":"traceutil/trace.go:171","msg":"trace[1290334468] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:1010; }","duration":"105.004477ms","start":"2026-02-09T08:38:41.548259Z","end":"2026-02-09T08:38:41.653263Z","steps":["trace[1290334468] 'agreement among raft nodes before linearized reading' (duration: 104.949596ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T08:38:42.277268Z","caller":"traceutil/trace.go:171","msg":"trace[1334875046] transaction","detail":"{read_only:false; response_revision:1017; number_of_response:1; }","duration":"134.175264ms","start":"2026-02-09T08:38:42.143077Z","end":"2026-02-09T08:38:42.277253Z","steps":["trace[1334875046] 'process raft request' (duration: 118.166755ms)","trace[1334875046] 'compare' (duration: 15.750334ms)"],"step_count":2}