{"level":"warn","ts":"2026-02-11T03:12:46.409827Z","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-11T03:12:46.40993Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.43:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.43:2380","--initial-cluster=instance=https://162.253.55.43:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.43:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.43:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-02-11T03:12:46.410031Z","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-11T03:12:46.410046Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.43:2380"]} {"level":"info","ts":"2026-02-11T03:12:46.410079Z","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-11T03:12:46.410789Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.43:2379"]} {"level":"info","ts":"2026-02-11T03:12:46.410909Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.43:2380"],"listen-peer-urls":["https://162.253.55.43:2380"],"advertise-client-urls":["https://162.253.55.43:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.43:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.43:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-02-11T03:12:46.417887Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.723301ms"} {"level":"info","ts":"2026-02-11T03:12:46.427072Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"14f8f2dfdaccebdb","cluster-id":"5f02ccb15672f35d"} {"level":"info","ts":"2026-02-11T03:12:46.428415Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb switched to configuration voters=()"} {"level":"info","ts":"2026-02-11T03:12:46.428441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became follower at term 0"} {"level":"info","ts":"2026-02-11T03:12:46.428452Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 14f8f2dfdaccebdb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-11T03:12:46.428459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became follower at term 1"} {"level":"info","ts":"2026-02-11T03:12:46.428488Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb switched to configuration voters=(1511224718245293019)"} {"level":"warn","ts":"2026-02-11T03:12:46.435154Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-11T03:12:46.44041Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-11T03:12:46.44638Z","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-11T03:12:46.45334Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"14f8f2dfdaccebdb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-11T03:12:46.472861Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"14f8f2dfdaccebdb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-11T03:12:46.474363Z","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-11T03:12:46.474589Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"14f8f2dfdaccebdb","initial-advertise-peer-urls":["https://162.253.55.43:2380"],"listen-peer-urls":["https://162.253.55.43:2380"],"advertise-client-urls":["https://162.253.55.43:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.43:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-11T03:12:46.474614Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-11T03:12:46.474745Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.43:2380"} {"level":"info","ts":"2026-02-11T03:12:46.474753Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.43:2380"} {"level":"info","ts":"2026-02-11T03:12:46.47417Z","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-11T03:12:46.47566Z","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-11T03:12:46.475705Z","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-11T03:12:46.47833Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb switched to configuration voters=(1511224718245293019)"} {"level":"info","ts":"2026-02-11T03:12:46.478503Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5f02ccb15672f35d","local-member-id":"14f8f2dfdaccebdb","added-peer-id":"14f8f2dfdaccebdb","added-peer-peer-urls":["https://162.253.55.43:2380"]} {"level":"info","ts":"2026-02-11T03:12:46.529943Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb is starting a new election at term 1"} {"level":"info","ts":"2026-02-11T03:12:46.529996Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became pre-candidate at term 1"} {"level":"info","ts":"2026-02-11T03:12:46.530033Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb received MsgPreVoteResp from 14f8f2dfdaccebdb at term 1"} {"level":"info","ts":"2026-02-11T03:12:46.530066Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became candidate at term 2"} {"level":"info","ts":"2026-02-11T03:12:46.530073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb received MsgVoteResp from 14f8f2dfdaccebdb at term 2"} {"level":"info","ts":"2026-02-11T03:12:46.530081Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became leader at term 2"} {"level":"info","ts":"2026-02-11T03:12:46.530088Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 14f8f2dfdaccebdb elected leader 14f8f2dfdaccebdb at term 2"} {"level":"info","ts":"2026-02-11T03:12:46.533944Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T03:12:46.541005Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"14f8f2dfdaccebdb","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.43:2379]}","request-path":"/0/members/14f8f2dfdaccebdb/attributes","cluster-id":"5f02ccb15672f35d","publish-timeout":"7s"} {"level":"info","ts":"2026-02-11T03:12:46.54115Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-11T03:12:46.541453Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-11T03:12:46.54303Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.43:2379"} {"level":"info","ts":"2026-02-11T03:12:46.543135Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-11T03:12:46.543222Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-11T03:12:46.543354Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5f02ccb15672f35d","local-member-id":"14f8f2dfdaccebdb","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T03:12:46.543753Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T03:12:46.544129Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T03:12:46.548018Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-11T03:12:50.363823Z","caller":"traceutil/trace.go:171","msg":"trace[1258515739] transaction","detail":"{read_only:false; response_revision:100; number_of_response:1; }","duration":"115.469896ms","start":"2026-02-11T03:12:50.248333Z","end":"2026-02-11T03:12:50.363803Z","steps":["trace[1258515739] 'process raft request' (duration: 97.291167ms)","trace[1258515739] 'compare' (duration: 18.048347ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T03:12:50.626087Z","caller":"traceutil/trace.go:171","msg":"trace[189944370] transaction","detail":"{read_only:false; response_revision:105; number_of_response:1; }","duration":"196.47301ms","start":"2026-02-11T03:12:50.429588Z","end":"2026-02-11T03:12:50.626061Z","steps":["trace[189944370] 'process raft request' (duration: 97.027264ms)","trace[189944370] 'compare' (duration: 99.305985ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T03:12:50.878879Z","caller":"traceutil/trace.go:171","msg":"trace[196943656] linearizableReadLoop","detail":"{readStateIndex:112; appliedIndex:111; }","duration":"157.206509ms","start":"2026-02-11T03:12:50.721648Z","end":"2026-02-11T03:12:50.878855Z","steps":["trace[196943656] 'read index received' (duration: 81.988864ms)","trace[196943656] 'applied index is now lower than readState.Index' (duration: 75.216635ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:12:50.879366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.692693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:node-proxier\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-11T03:12:50.881681Z","caller":"traceutil/trace.go:171","msg":"trace[1397469074] range","detail":"{range_begin:/registry/clusterroles/system:node-proxier; range_end:; response_count:0; response_revision:107; }","duration":"160.049573ms","start":"2026-02-11T03:12:50.721614Z","end":"2026-02-11T03:12:50.881664Z","steps":["trace[1397469074] 'agreement among raft nodes before linearized reading' (duration: 157.601042ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:12:50.879579Z","caller":"traceutil/trace.go:171","msg":"trace[1471715086] transaction","detail":"{read_only:false; response_revision:107; number_of_response:1; }","duration":"217.299122ms","start":"2026-02-11T03:12:50.662266Z","end":"2026-02-11T03:12:50.879565Z","steps":["trace[1471715086] 'process raft request' (duration: 141.360971ms)","trace[1471715086] 'compare' (duration: 75.113884ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:12:51.234282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.568033ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-11T03:12:51.234499Z","caller":"traceutil/trace.go:171","msg":"trace[1778409038] linearizableReadLoop","detail":"{readStateIndex:113; appliedIndex:112; }","duration":"331.131285ms","start":"2026-02-11T03:12:50.903273Z","end":"2026-02-11T03:12:51.234404Z","steps":["trace[1778409038] 'read index received' (duration: 227.181458ms)","trace[1778409038] 'applied index is now lower than readState.Index' (duration: 103.948857ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T03:12:51.234891Z","caller":"traceutil/trace.go:171","msg":"trace[359215474] transaction","detail":"{read_only:false; response_revision:108; number_of_response:1; }","duration":"348.252893ms","start":"2026-02-11T03:12:50.886572Z","end":"2026-02-11T03:12:51.234825Z","steps":["trace[359215474] 'process raft request' (duration: 243.840183ms)","trace[359215474] 'compare' (duration: 103.413882ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:12:51.235055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:12:50.886553Z","time spent":"348.484815ms","remote":"127.0.0.1:37306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":699,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-11T03:12:51.235502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.219914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-11T03:12:51.237815Z","caller":"traceutil/trace.go:171","msg":"trace[1945391994] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:108; }","duration":"334.564974ms","start":"2026-02-11T03:12:50.903231Z","end":"2026-02-11T03:12:51.237796Z","steps":["trace[1945391994] 'agreement among raft nodes before linearized reading' (duration: 332.006832ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:12:51.23809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:12:50.903212Z","time spent":"334.861156ms","remote":"127.0.0.1:37220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-11T03:12:51.236073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.676969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-11T03:12:51.238553Z","caller":"traceutil/trace.go:171","msg":"trace[993043635] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:108; }","duration":"334.18812ms","start":"2026-02-11T03:12:50.904339Z","end":"2026-02-11T03:12:51.238527Z","steps":["trace[993043635] 'agreement among raft nodes before linearized reading' (duration: 331.217514ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:12:51.23861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:12:50.904327Z","time spent":"334.268911ms","remote":"127.0.0.1:37220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-11T03:12:51.236157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.895067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-11T03:12:51.238767Z","caller":"traceutil/trace.go:171","msg":"trace[1861215961] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:108; }","duration":"283.477309ms","start":"2026-02-11T03:12:50.955229Z","end":"2026-02-11T03:12:51.238706Z","steps":["trace[1861215961] 'agreement among raft nodes before linearized reading' (duration: 280.906706ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:12:51.485657Z","caller":"traceutil/trace.go:171","msg":"trace[1697702658] transaction","detail":"{read_only:false; response_revision:113; number_of_response:1; }","duration":"153.05511ms","start":"2026-02-11T03:12:51.332575Z","end":"2026-02-11T03:12:51.48563Z","steps":["trace[1697702658] 'process raft request' (duration: 53.848374ms)","trace[1697702658] 'compare' (duration: 99.055835ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T03:12:51.719462Z","caller":"traceutil/trace.go:171","msg":"trace[235844676] transaction","detail":"{read_only:false; response_revision:117; number_of_response:1; }","duration":"149.285708ms","start":"2026-02-11T03:12:51.570151Z","end":"2026-02-11T03:12:51.719437Z","steps":["trace[235844676] 'process raft request' (duration: 124.657665ms)","trace[235844676] 'compare' (duration: 24.477481ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:13:02.308213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.084573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T03:13:02.308008Z","caller":"traceutil/trace.go:171","msg":"trace[791061153] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"250.164016ms","start":"2026-02-11T03:13:02.057815Z","end":"2026-02-11T03:13:02.307979Z","steps":["trace[791061153] 'process raft request' (duration: 249.41189ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:02.308368Z","caller":"traceutil/trace.go:171","msg":"trace[924137331] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:372; }","duration":"213.372075ms","start":"2026-02-11T03:13:02.094955Z","end":"2026-02-11T03:13:02.308327Z","steps":["trace[924137331] 'agreement among raft nodes before linearized reading' (duration: 213.093482ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:02.308041Z","caller":"traceutil/trace.go:171","msg":"trace[448999867] linearizableReadLoop","detail":"{readStateIndex:384; appliedIndex:383; }","duration":"212.528298ms","start":"2026-02-11T03:13:02.095003Z","end":"2026-02-11T03:13:02.307532Z","steps":["trace[448999867] 'read index received' (duration: 211.795113ms)","trace[448999867] 'applied index is now lower than readState.Index' (duration: 731.805µs)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:13:02.31039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.344518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.43\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-11T03:13:02.313248Z","caller":"traceutil/trace.go:171","msg":"trace[2069123585] range","detail":"{range_begin:/registry/masterleases/162.253.55.43; range_end:; response_count:1; response_revision:372; }","duration":"154.46208ms","start":"2026-02-11T03:13:02.155965Z","end":"2026-02-11T03:13:02.310427Z","steps":["trace[2069123585] 'agreement among raft nodes before linearized reading' (duration: 154.347129ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:08.929507Z","caller":"traceutil/trace.go:171","msg":"trace[1261817852] linearizableReadLoop","detail":"{readStateIndex:434; appliedIndex:433; }","duration":"453.851965ms","start":"2026-02-11T03:13:08.475635Z","end":"2026-02-11T03:13:08.929486Z","steps":["trace[1261817852] 'read index received' (duration: 453.687234ms)","trace[1261817852] 'applied index is now lower than readState.Index' (duration: 163.921µs)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:13:08.929635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.978846ms","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-11T03:13:08.929667Z","caller":"traceutil/trace.go:171","msg":"trace[1958652253] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:419; }","duration":"454.025647ms","start":"2026-02-11T03:13:08.475631Z","end":"2026-02-11T03:13:08.929656Z","steps":["trace[1958652253] 'agreement among raft nodes before linearized reading' (duration: 453.936766ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:08.9297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:08.475593Z","time spent":"454.098887ms","remote":"127.0.0.1:37220","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":"info","ts":"2026-02-11T03:13:08.929991Z","caller":"traceutil/trace.go:171","msg":"trace[1305891443] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"591.706612ms","start":"2026-02-11T03:13:08.338271Z","end":"2026-02-11T03:13:08.929978Z","steps":["trace[1305891443] 'process raft request' (duration: 591.101587ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:08.930224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:08.338258Z","time spent":"591.763022ms","remote":"127.0.0.1:37220","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-11T03:13:09.114707Z","caller":"traceutil/trace.go:171","msg":"trace[307298277] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"180.564885ms","start":"2026-02-11T03:13:08.934105Z","end":"2026-02-11T03:13:09.11467Z","steps":["trace[307298277] 'process raft request' (duration: 180.136752ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:17.0844Z","caller":"traceutil/trace.go:171","msg":"trace[271162718] transaction","detail":"{read_only:false; response_revision:441; number_of_response:1; }","duration":"213.970833ms","start":"2026-02-11T03:13:16.87041Z","end":"2026-02-11T03:13:17.08438Z","steps":["trace[271162718] 'process raft request' (duration: 132.519673ms)","trace[271162718] 'compare' (duration: 81.017777ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T03:13:17.20849Z","caller":"traceutil/trace.go:171","msg":"trace[1140344429] transaction","detail":"{read_only:false; response_revision:442; number_of_response:1; }","duration":"113.989524ms","start":"2026-02-11T03:13:17.094478Z","end":"2026-02-11T03:13:17.208468Z","steps":["trace[1140344429] 'process raft request' (duration: 110.299227ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:17.208495Z","caller":"traceutil/trace.go:171","msg":"trace[2091316304] linearizableReadLoop","detail":"{readStateIndex:460; appliedIndex:457; }","duration":"112.680335ms","start":"2026-02-11T03:13:17.0958Z","end":"2026-02-11T03:13:17.20848Z","steps":["trace[2091316304] 'read index received' (duration: 109.128569ms)","trace[2091316304] 'applied index is now lower than readState.Index' (duration: 3.551066ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T03:13:17.208981Z","caller":"traceutil/trace.go:171","msg":"trace[223656125] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"114.038894ms","start":"2026-02-11T03:13:17.094931Z","end":"2026-02-11T03:13:17.20897Z","steps":["trace[223656125] 'process raft request' (duration: 113.47546ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:17.209354Z","caller":"traceutil/trace.go:171","msg":"trace[871649236] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"114.320446ms","start":"2026-02-11T03:13:17.095023Z","end":"2026-02-11T03:13:17.209344Z","steps":["trace[871649236] 'process raft request' (duration: 113.4302ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:17.209907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.090975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T03:13:17.209954Z","caller":"traceutil/trace.go:171","msg":"trace[425815976] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:444; }","duration":"114.162856ms","start":"2026-02-11T03:13:17.095778Z","end":"2026-02-11T03:13:17.209941Z","steps":["trace[425815976] 'agreement among raft nodes before linearized reading' (duration: 112.753185ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:19.752724Z","caller":"traceutil/trace.go:171","msg":"trace[1836487203] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"523.039568ms","start":"2026-02-11T03:13:19.229666Z","end":"2026-02-11T03:13:19.752705Z","steps":["trace[1836487203] 'process raft request' (duration: 522.897457ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:19.752779Z","caller":"traceutil/trace.go:171","msg":"trace[160106294] linearizableReadLoop","detail":"{readStateIndex:493; appliedIndex:493; }","duration":"477.205399ms","start":"2026-02-11T03:13:19.275554Z","end":"2026-02-11T03:13:19.75276Z","steps":["trace[160106294] 'read index received' (duration: 477.185759ms)","trace[160106294] 'applied index is now lower than readState.Index' (duration: 5.94µs)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:13:19.752876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:19.229649Z","time spent":"523.156228ms","remote":"127.0.0.1:37220","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-11T03:13:19.752986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.40778ms","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-11T03:13:19.753013Z","caller":"traceutil/trace.go:171","msg":"trace[1953470739] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:476; }","duration":"477.477841ms","start":"2026-02-11T03:13:19.275527Z","end":"2026-02-11T03:13:19.753005Z","steps":["trace[1953470739] 'agreement among raft nodes before linearized reading' (duration: 477.32528ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:19.753035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:19.275514Z","time spent":"477.516351ms","remote":"127.0.0.1:37220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-11T03:13:19.753499Z","caller":"traceutil/trace.go:171","msg":"trace[1691962867] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"238.072475ms","start":"2026-02-11T03:13:19.515417Z","end":"2026-02-11T03:13:19.75349Z","steps":["trace[1691962867] 'process raft request' (duration: 237.953774ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:19.75375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.057649ms","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-11T03:13:19.753767Z","caller":"traceutil/trace.go:171","msg":"trace[1674477388] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:477; }","duration":"212.098129ms","start":"2026-02-11T03:13:19.541663Z","end":"2026-02-11T03:13:19.753761Z","steps":["trace[1674477388] 'agreement among raft nodes before linearized reading' (duration: 212.067899ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:19.753473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.885819ms","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-11T03:13:19.75389Z","caller":"traceutil/trace.go:171","msg":"trace[1754931284] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:477; }","duration":"275.326663ms","start":"2026-02-11T03:13:19.478558Z","end":"2026-02-11T03:13:19.753885Z","steps":["trace[1754931284] 'agreement among raft nodes before linearized reading' (duration: 274.88326ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:22.201287Z","caller":"traceutil/trace.go:171","msg":"trace[703987564] linearizableReadLoop","detail":"{readStateIndex:500; appliedIndex:499; }","duration":"431.727021ms","start":"2026-02-11T03:13:21.769538Z","end":"2026-02-11T03:13:22.201265Z","steps":["trace[703987564] 'read index received' (duration: 431.5873ms)","trace[703987564] 'applied index is now lower than readState.Index' (duration: 138.331µs)"],"step_count":2} {"level":"info","ts":"2026-02-11T03:13:22.201556Z","caller":"traceutil/trace.go:171","msg":"trace[1829888866] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"441.798172ms","start":"2026-02-11T03:13:21.759744Z","end":"2026-02-11T03:13:22.201543Z","steps":["trace[1829888866] 'process raft request' (duration: 441.385159ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:22.201795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:21.759733Z","time spent":"441.971583ms","remote":"127.0.0.1:37220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T03:13:22.202097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.271364ms","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-11T03:13:22.202203Z","caller":"traceutil/trace.go:171","msg":"trace[1462176647] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:483; }","duration":"432.371035ms","start":"2026-02-11T03:13:21.769792Z","end":"2026-02-11T03:13:22.202163Z","steps":["trace[1462176647] 'agreement among raft nodes before linearized reading' (duration: 432.025652ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:22.202329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:21.769787Z","time spent":"432.492486ms","remote":"127.0.0.1:37220","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-11T03:13:22.202483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.990114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T03:13:22.202567Z","caller":"traceutil/trace.go:171","msg":"trace[1434720310] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:483; }","duration":"108.140915ms","start":"2026-02-11T03:13:22.094413Z","end":"2026-02-11T03:13:22.202554Z","steps":["trace[1434720310] 'agreement among raft nodes before linearized reading' (duration: 107.994904ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:22.202773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.293843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T03:13:22.202996Z","caller":"traceutil/trace.go:171","msg":"trace[1107999108] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:0; response_revision:483; }","duration":"353.375484ms","start":"2026-02-11T03:13:21.849449Z","end":"2026-02-11T03:13:22.202825Z","steps":["trace[1107999108] 'agreement among raft nodes before linearized reading' (duration: 353.300423ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:22.203135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:21.849438Z","time spent":"353.687776ms","remote":"127.0.0.1:37066","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" "} {"level":"warn","ts":"2026-02-11T03:13:22.203437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.464458ms","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-11T03:13:22.20462Z","caller":"traceutil/trace.go:171","msg":"trace[718606281] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:483; }","duration":"363.665296ms","start":"2026-02-11T03:13:21.84094Z","end":"2026-02-11T03:13:22.204605Z","steps":["trace[718606281] 'agreement among raft nodes before linearized reading' (duration: 362.446598ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:22.204678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:21.840924Z","time spent":"363.740517ms","remote":"127.0.0.1:37220","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-11T03:13:22.206849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.30321ms","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-11T03:13:22.206933Z","caller":"traceutil/trace.go:171","msg":"trace[390477423] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:483; }","duration":"437.402541ms","start":"2026-02-11T03:13:21.769519Z","end":"2026-02-11T03:13:22.206921Z","steps":["trace[390477423] 'agreement among raft nodes before linearized reading' (duration: 434.49218ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:22.206991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:21.769509Z","time spent":"437.472421ms","remote":"127.0.0.1:37220","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-11T03:13:22.585676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.44082ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T03:13:22.585792Z","caller":"traceutil/trace.go:171","msg":"trace[974497645] linearizableReadLoop","detail":"{readStateIndex:505; appliedIndex:504; }","duration":"285.305248ms","start":"2026-02-11T03:13:22.300472Z","end":"2026-02-11T03:13:22.585777Z","steps":["trace[974497645] 'read index received' (duration: 102.569036ms)","trace[974497645] 'applied index is now lower than readState.Index' (duration: 182.735172ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:13:22.58591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.429769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T03:13:22.585938Z","caller":"traceutil/trace.go:171","msg":"trace[1598658166] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:0; response_revision:487; }","duration":"285.478099ms","start":"2026-02-11T03:13:22.30045Z","end":"2026-02-11T03:13:22.585928Z","steps":["trace[1598658166] 'agreement among raft nodes before linearized reading' (duration: 285.368748ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:22.586172Z","caller":"traceutil/trace.go:171","msg":"trace[1542903018] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"333.371118ms","start":"2026-02-11T03:13:22.25279Z","end":"2026-02-11T03:13:22.586161Z","steps":["trace[1542903018] 'process raft request' (duration: 150.358713ms)","trace[1542903018] 'compare' (duration: 182.34778ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:13:22.586226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:22.252777Z","time spent":"333.417498ms","remote":"127.0.0.1:37000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T03:13:26.557708Z","caller":"traceutil/trace.go:171","msg":"trace[1153930673] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"237.560081ms","start":"2026-02-11T03:13:26.32014Z","end":"2026-02-11T03:13:26.5577Z","steps":["trace[1153930673] 'process raft request' (duration: 237.260577ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:26.557902Z","caller":"traceutil/trace.go:171","msg":"trace[1276217339] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"237.289749ms","start":"2026-02-11T03:13:26.32023Z","end":"2026-02-11T03:13:26.55752Z","steps":["trace[1276217339] 'process raft request' (duration: 237.265407ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:27.630799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.775926ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-02-11T03:13:28.475502Z","caller":"traceutil/trace.go:171","msg":"trace[708309918] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"111.846844ms","start":"2026-02-11T03:13:28.36364Z","end":"2026-02-11T03:13:28.475487Z","steps":["trace[708309918] 'process raft request' (duration: 111.75079ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:30.908423Z","caller":"traceutil/trace.go:171","msg":"trace[556964601] linearizableReadLoop","detail":"{readStateIndex:547; appliedIndex:546; }","duration":"238.886511ms","start":"2026-02-11T03:13:30.669522Z","end":"2026-02-11T03:13:30.908409Z","steps":["trace[556964601] 'read index received' (duration: 238.752775ms)","trace[556964601] 'applied index is now lower than readState.Index' (duration: 133.196µs)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:13:30.908706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.080999ms","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-11T03:13:30.908733Z","caller":"traceutil/trace.go:171","msg":"trace[1564014554] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:528; }","duration":"239.235045ms","start":"2026-02-11T03:13:30.66949Z","end":"2026-02-11T03:13:30.908725Z","steps":["trace[1564014554] 'agreement among raft nodes before linearized reading' (duration: 239.053738ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:30.908802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.246016ms","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-11T03:13:30.908814Z","caller":"traceutil/trace.go:171","msg":"trace[1090194521] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:528; }","duration":"239.264637ms","start":"2026-02-11T03:13:30.669546Z","end":"2026-02-11T03:13:30.90881Z","steps":["trace[1090194521] 'agreement among raft nodes before linearized reading' (duration: 239.117841ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:30.908916Z","caller":"traceutil/trace.go:171","msg":"trace[1412911195] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"426.226545ms","start":"2026-02-11T03:13:30.482684Z","end":"2026-02-11T03:13:30.908911Z","steps":["trace[1412911195] 'process raft request' (duration: 425.640519ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:30.909054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:30.482084Z","time spent":"426.936305ms","remote":"127.0.0.1:37220","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-11T03:13:31.406096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.95948ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T03:13:31.40622Z","caller":"traceutil/trace.go:171","msg":"trace[872894643] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"493.885045ms","start":"2026-02-11T03:13:30.912316Z","end":"2026-02-11T03:13:31.406201Z","steps":["trace[872894643] 'process raft request' (duration: 103.752007ms)","trace[872894643] 'compare' (duration: 389.842016ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T03:13:31.406248Z","caller":"traceutil/trace.go:171","msg":"trace[2022359099] linearizableReadLoop","detail":"{readStateIndex:549; appliedIndex:547; }","duration":"367.087569ms","start":"2026-02-11T03:13:31.039144Z","end":"2026-02-11T03:13:31.406232Z","steps":["trace[2022359099] 'read index received' (duration: 324.419189ms)","trace[2022359099] 'applied index is now lower than readState.Index' (duration: 42.66749ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:13:31.406316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:30.912302Z","time spent":"493.958208ms","remote":"127.0.0.1:37220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T03:13:31.406409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.263987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-bp7vg\" ","response":"range_response_count:1 size:16652"} {"level":"info","ts":"2026-02-11T03:13:31.406437Z","caller":"traceutil/trace.go:171","msg":"trace[40545387] range","detail":"{range_begin:/registry/pods/kube-system/cilium-bp7vg; range_end:; response_count:1; response_revision:530; }","duration":"367.32701ms","start":"2026-02-11T03:13:31.039101Z","end":"2026-02-11T03:13:31.406428Z","steps":["trace[40545387] 'agreement among raft nodes before linearized reading' (duration: 367.195604ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:31.406467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:31.039086Z","time spent":"367.374951ms","remote":"127.0.0.1:37146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16674,"request content":"key:\"/registry/pods/kube-system/cilium-bp7vg\" "} {"level":"info","ts":"2026-02-11T03:13:31.406489Z","caller":"traceutil/trace.go:171","msg":"trace[1622729785] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"492.616049ms","start":"2026-02-11T03:13:30.913867Z","end":"2026-02-11T03:13:31.406483Z","steps":["trace[1622729785] 'process raft request' (duration: 492.318746ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:31.406519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:30.913844Z","time spent":"492.659111ms","remote":"127.0.0.1:37220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T03:13:31.710039Z","caller":"traceutil/trace.go:171","msg":"trace[1006400289] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"288.134972ms","start":"2026-02-11T03:13:31.421887Z","end":"2026-02-11T03:13:31.710021Z","steps":["trace[1006400289] 'process raft request' (duration: 288.032217ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:33.970155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.829775187s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T03:13:33.970201Z","caller":"traceutil/trace.go:171","msg":"trace[1485810111] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:531; }","duration":"1.829852511s","start":"2026-02-11T03:13:32.140338Z","end":"2026-02-11T03:13:33.97019Z","steps":["trace[1485810111] 'range keys from in-memory index tree' (duration: 1.829728896s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:33.970222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:32.140326Z","time spent":"1.829891343s","remote":"127.0.0.1:36986","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-11T03:13:33.970363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.812715225s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.43\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-11T03:13:33.970382Z","caller":"traceutil/trace.go:171","msg":"trace[1632358391] range","detail":"{range_begin:/registry/masterleases/162.253.55.43; range_end:; response_count:1; response_revision:531; }","duration":"1.812753016s","start":"2026-02-11T03:13:32.157618Z","end":"2026-02-11T03:13:33.970371Z","steps":["trace[1632358391] 'range keys from in-memory index tree' (duration: 1.812629291s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:33.970394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:32.157604Z","time spent":"1.812786907s","remote":"127.0.0.1:37000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":155,"request content":"key:\"/registry/masterleases/162.253.55.43\" "} {"level":"warn","ts":"2026-02-11T03:13:33.970479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.694410139s","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-11T03:13:33.97049Z","caller":"traceutil/trace.go:171","msg":"trace[679850155] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:531; }","duration":"1.69444415s","start":"2026-02-11T03:13:32.276042Z","end":"2026-02-11T03:13:33.970486Z","steps":["trace[679850155] 'range keys from in-memory index tree' (duration: 1.694352206s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:33.970501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:32.276029Z","time spent":"1.694469031s","remote":"127.0.0.1:37220","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":"warn","ts":"2026-02-11T03:13:33.970577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.058352721s","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-11T03:13:33.970588Z","caller":"traceutil/trace.go:171","msg":"trace[1655861587] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:531; }","duration":"1.058399532s","start":"2026-02-11T03:13:32.912185Z","end":"2026-02-11T03:13:33.970585Z","steps":["trace[1655861587] 'range keys from in-memory index tree' (duration: 1.058250276s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:33.9706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:32.912163Z","time spent":"1.058434374s","remote":"127.0.0.1:37220","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-11T03:13:33.97083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.974868ms","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-11T03:13:33.970848Z","caller":"traceutil/trace.go:171","msg":"trace[37099398] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:531; }","duration":"547.025691ms","start":"2026-02-11T03:13:33.423816Z","end":"2026-02-11T03:13:33.970842Z","steps":["trace[37099398] 'range keys from in-memory index tree' (duration: 546.897575ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:33.970861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:33.423798Z","time spent":"547.059752ms","remote":"127.0.0.1:37220","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-11T03:13:33.97094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.088822ms","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-11T03:13:33.970951Z","caller":"traceutil/trace.go:171","msg":"trace[916284339] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:531; }","duration":"546.120052ms","start":"2026-02-11T03:13:33.424827Z","end":"2026-02-11T03:13:33.970948Z","steps":["trace[916284339] 'range keys from in-memory index tree' (duration: 546.026359ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:33.970963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:33.424818Z","time spent":"546.141944ms","remote":"127.0.0.1:37220","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-11T03:13:34.473839Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16995349463404994725,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-11T03:13:34.974682Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16995349463404994725,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-11T03:13:35.044874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:33.973177Z","time spent":"1.071691882s","remote":"127.0.0.1:37000","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-11T03:13:35.090271Z","caller":"traceutil/trace.go:171","msg":"trace[580668530] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"1.11301051s","start":"2026-02-11T03:13:33.977239Z","end":"2026-02-11T03:13:35.090249Z","steps":["trace[580668530] 'process raft request' (duration: 1.111351362s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:35.090392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:33.977231Z","time spent":"1.113098993s","remote":"127.0.0.1:37220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T03:13:35.09236Z","caller":"traceutil/trace.go:171","msg":"trace[1987599507] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"1.115072055s","start":"2026-02-11T03:13:33.977272Z","end":"2026-02-11T03:13:35.092344Z","steps":["trace[1987599507] 'process raft request' (duration: 1.1137424s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:35.092533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:33.977268Z","time spent":"1.115187029s","remote":"127.0.0.1:37220","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-11T03:13:35.093084Z","caller":"traceutil/trace.go:171","msg":"trace[48763914] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"1.115658428s","start":"2026-02-11T03:13:33.977415Z","end":"2026-02-11T03:13:35.093073Z","steps":["trace[48763914] 'process raft request' (duration: 1.114524382s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:35.093124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:33.97741Z","time spent":"1.11569403s","remote":"127.0.0.1:37220","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-11T03:13:35.095065Z","caller":"traceutil/trace.go:171","msg":"trace[1468654213] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"1.117598198s","start":"2026-02-11T03:13:33.977457Z","end":"2026-02-11T03:13:35.095056Z","steps":["trace[1468654213] 'process raft request' (duration: 1.114625266s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:35.095114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:33.977424Z","time spent":"1.11766263s","remote":"127.0.0.1:37220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T03:13:35.095228Z","caller":"traceutil/trace.go:171","msg":"trace[753610229] linearizableReadLoop","detail":"{readStateIndex:555; appliedIndex:550; }","duration":"1.121870006s","start":"2026-02-11T03:13:33.973351Z","end":"2026-02-11T03:13:35.095221Z","steps":["trace[753610229] 'read index received' (duration: 1.071314797s)","trace[753610229] 'applied index is now lower than readState.Index' (duration: 50.554079ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:13:35.095266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.121912498s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T03:13:35.095291Z","caller":"traceutil/trace.go:171","msg":"trace[261849299] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:535; }","duration":"1.12194061s","start":"2026-02-11T03:13:33.973339Z","end":"2026-02-11T03:13:35.09528Z","steps":["trace[261849299] 'agreement among raft nodes before linearized reading' (duration: 1.121906348s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:35.095307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:33.973333Z","time spent":"1.121971291s","remote":"127.0.0.1:36980","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-11T03:13:35.296314Z","caller":"traceutil/trace.go:171","msg":"trace[463610825] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"105.825871ms","start":"2026-02-11T03:13:35.190466Z","end":"2026-02-11T03:13:35.296292Z","steps":["trace[463610825] 'process raft request' (duration: 105.703216ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:35.339777Z","caller":"traceutil/trace.go:171","msg":"trace[1165110645] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"142.978882ms","start":"2026-02-11T03:13:35.196779Z","end":"2026-02-11T03:13:35.339757Z","steps":["trace[1165110645] 'process raft request' (duration: 142.877628ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:36.287889Z","caller":"traceutil/trace.go:171","msg":"trace[557671958] linearizableReadLoop","detail":"{readStateIndex:561; appliedIndex:560; }","duration":"135.592076ms","start":"2026-02-11T03:13:36.152278Z","end":"2026-02-11T03:13:36.28787Z","steps":["trace[557671958] 'read index received' (duration: 135.44095ms)","trace[557671958] 'applied index is now lower than readState.Index' (duration: 150.106µs)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:13:36.288072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.775613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-bp7vg\" ","response":"range_response_count:1 size:16912"} {"level":"info","ts":"2026-02-11T03:13:36.288106Z","caller":"traceutil/trace.go:171","msg":"trace[1605145031] range","detail":"{range_begin:/registry/pods/kube-system/cilium-bp7vg; range_end:; response_count:1; response_revision:541; }","duration":"135.851216ms","start":"2026-02-11T03:13:36.152248Z","end":"2026-02-11T03:13:36.288099Z","steps":["trace[1605145031] 'agreement among raft nodes before linearized reading' (duration: 135.689179ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:36.288303Z","caller":"traceutil/trace.go:171","msg":"trace[1610647560] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"180.281623ms","start":"2026-02-11T03:13:36.108014Z","end":"2026-02-11T03:13:36.288296Z","steps":["trace[1610647560] 'process raft request' (duration: 179.764512ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:36.452065Z","caller":"traceutil/trace.go:171","msg":"trace[777899017] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"127.601112ms","start":"2026-02-11T03:13:36.324075Z","end":"2026-02-11T03:13:36.451676Z","steps":["trace[777899017] 'process raft request' (duration: 127.441175ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:37.769002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.686226ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-02-11T03:13:39.347147Z","caller":"traceutil/trace.go:171","msg":"trace[1877195075] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"161.885785ms","start":"2026-02-11T03:13:39.185247Z","end":"2026-02-11T03:13:39.347133Z","steps":["trace[1877195075] 'process raft request' (duration: 161.803952ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:39.347349Z","caller":"traceutil/trace.go:171","msg":"trace[851868028] linearizableReadLoop","detail":"{readStateIndex:580; appliedIndex:580; }","duration":"148.834936ms","start":"2026-02-11T03:13:39.198508Z","end":"2026-02-11T03:13:39.347343Z","steps":["trace[851868028] 'read index received' (duration: 148.832755ms)","trace[851868028] 'applied index is now lower than readState.Index' (duration: 1.88µs)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:13:39.347425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.906129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-11T03:13:39.347442Z","caller":"traceutil/trace.go:171","msg":"trace[1050123392] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:559; }","duration":"148.956051ms","start":"2026-02-11T03:13:39.198481Z","end":"2026-02-11T03:13:39.347437Z","steps":["trace[1050123392] 'agreement among raft nodes before linearized reading' (duration: 148.881708ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:39.357218Z","caller":"traceutil/trace.go:171","msg":"trace[774358128] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"152.405906ms","start":"2026-02-11T03:13:39.204768Z","end":"2026-02-11T03:13:39.357174Z","steps":["trace[774358128] 'process raft request' (duration: 152.233369ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:40.206986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.077325ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-11T03:13:40.207058Z","caller":"traceutil/trace.go:171","msg":"trace[1485647933] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"661.441929ms","start":"2026-02-11T03:13:39.545607Z","end":"2026-02-11T03:13:40.207049Z","steps":["trace[1485647933] 'process raft request' (duration: 283.173156ms)","trace[1485647933] 'compare' (duration: 377.979242ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:13:40.20711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:39.545561Z","time spent":"661.515702ms","remote":"127.0.0.1:37018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4580,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-11T03:13:40.596181Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16995349463404994798,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-11T03:13:41.097347Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16995349463404994798,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-11T03:13:41.130095Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.301267275s","expected-duration":"1s"} {"level":"info","ts":"2026-02-11T03:13:41.130551Z","caller":"traceutil/trace.go:171","msg":"trace[37064025] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"1.432880398s","start":"2026-02-11T03:13:39.697658Z","end":"2026-02-11T03:13:41.130538Z","steps":["trace[37064025] 'process raft request' (duration: 1.432855487s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:41.13072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:39.697642Z","time spent":"1.433038604s","remote":"127.0.0.1:37018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-11T03:13:41.131095Z","caller":"traceutil/trace.go:171","msg":"trace[1888783360] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"1.577088732s","start":"2026-02-11T03:13:39.553997Z","end":"2026-02-11T03:13:41.131086Z","steps":["trace[1888783360] 'process raft request' (duration: 1.576379185s)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:41.131254Z","caller":"traceutil/trace.go:171","msg":"trace[963457938] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"1.480857542s","start":"2026-02-11T03:13:39.650389Z","end":"2026-02-11T03:13:41.131246Z","steps":["trace[963457938] 'process raft request' (duration: 1.480069101s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:41.133843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:39.650372Z","time spent":"1.483445101s","remote":"127.0.0.1:37046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":700,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-11T03:13:41.131455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:39.553988Z","time spent":"1.577438055s","remote":"127.0.0.1:37220","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-11T03:13:41.667001Z","caller":"traceutil/trace.go:171","msg":"trace[1179507042] linearizableReadLoop","detail":"{readStateIndex:598; appliedIndex:589; }","duration":"1.571407934s","start":"2026-02-11T03:13:40.09555Z","end":"2026-02-11T03:13:41.666958Z","steps":["trace[1179507042] 'read index received' (duration: 1.035636212s)","trace[1179507042] 'applied index is now lower than readState.Index' (duration: 535.771022ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T03:13:41.667134Z","caller":"traceutil/trace.go:171","msg":"trace[431989314] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"1.767407284s","start":"2026-02-11T03:13:39.89972Z","end":"2026-02-11T03:13:41.667127Z","steps":["trace[431989314] 'process raft request' (duration: 1.766904075s)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:41.667337Z","caller":"traceutil/trace.go:171","msg":"trace[963879244] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"1.562706199s","start":"2026-02-11T03:13:40.104623Z","end":"2026-02-11T03:13:41.667329Z","steps":["trace[963879244] 'process raft request' (duration: 1.562144357s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:41.668073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:40.104605Z","time spent":"1.563451386s","remote":"127.0.0.1:37018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-11T03:13:41.667395Z","caller":"traceutil/trace.go:171","msg":"trace[653228262] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"1.456480565s","start":"2026-02-11T03:13:40.210909Z","end":"2026-02-11T03:13:41.667389Z","steps":["trace[653228262] 'process raft request' (duration: 1.455884102s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:41.668181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:40.210893Z","time spent":"1.457276156s","remote":"127.0.0.1:37494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":932,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-11T03:13:41.667431Z","caller":"traceutil/trace.go:171","msg":"trace[904811240] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"1.454723117s","start":"2026-02-11T03:13:40.212703Z","end":"2026-02-11T03:13:41.667426Z","steps":["trace[904811240] 'process raft request' (duration: 1.454109074s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:41.668275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:40.212694Z","time spent":"1.455559829s","remote":"127.0.0.1:37018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5562,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T03:13:41.667445Z","caller":"traceutil/trace.go:171","msg":"trace[1036021964] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"1.370847117s","start":"2026-02-11T03:13:40.296594Z","end":"2026-02-11T03:13:41.667441Z","steps":["trace[1036021964] 'process raft request' (duration: 1.370248564s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:41.668362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:40.296572Z","time spent":"1.371780713s","remote":"127.0.0.1:37018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4234,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-11T03:13:41.66746Z","caller":"traceutil/trace.go:171","msg":"trace[994011448] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"1.1698191s","start":"2026-02-11T03:13:40.497637Z","end":"2026-02-11T03:13:41.667456Z","steps":["trace[994011448] 'process raft request' (duration: 1.169221448s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:41.668466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:40.49762Z","time spent":"1.1708345s","remote":"127.0.0.1:37018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9343,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-11T03:13:41.667478Z","caller":"traceutil/trace.go:171","msg":"trace[1772371357] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"769.787457ms","start":"2026-02-11T03:13:40.897686Z","end":"2026-02-11T03:13:41.667473Z","steps":["trace[1772371357] 'process raft request' (duration: 769.235696ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:41.668562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:40.897659Z","time spent":"770.893059ms","remote":"127.0.0.1:37018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-11T03:13:41.667492Z","caller":"traceutil/trace.go:171","msg":"trace[796941429] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"1.161687527s","start":"2026-02-11T03:13:40.5058Z","end":"2026-02-11T03:13:41.667488Z","steps":["trace[796941429] 'process raft request' (duration: 1.161074803s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:41.668667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:40.505792Z","time spent":"1.162857371s","remote":"127.0.0.1:37220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T03:13:41.667505Z","caller":"traceutil/trace.go:171","msg":"trace[1612848961] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"968.099388ms","start":"2026-02-11T03:13:40.699402Z","end":"2026-02-11T03:13:41.667502Z","steps":["trace[1612848961] 'process raft request' (duration: 967.500245ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:41.668768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:40.699375Z","time spent":"969.381577ms","remote":"127.0.0.1:37018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-11T03:13:41.66755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.571994677s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T03:13:41.668865Z","caller":"traceutil/trace.go:171","msg":"trace[252561238] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:578; }","duration":"1.573366329s","start":"2026-02-11T03:13:40.095492Z","end":"2026-02-11T03:13:41.668859Z","steps":["trace[252561238] 'agreement among raft nodes before linearized reading' (duration: 1.572026388s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:41.668883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:40.095469Z","time spent":"1.573409131s","remote":"127.0.0.1:36986","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-11T03:13:41.667567Z","caller":"traceutil/trace.go:171","msg":"trace[1115162704] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"568.766483ms","start":"2026-02-11T03:13:41.098796Z","end":"2026-02-11T03:13:41.667563Z","steps":["trace[1115162704] 'process raft request' (duration: 568.141789ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:41.668991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:41.098772Z","time spent":"570.208278ms","remote":"127.0.0.1:37018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12244,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-11T03:13:41.668037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:39.899694Z","time spent":"1.768310898s","remote":"127.0.0.1:37018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3104,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-11T03:13:42.209743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.881458ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-11T03:13:42.209832Z","caller":"traceutil/trace.go:171","msg":"trace[1043350196] linearizableReadLoop","detail":"{readStateIndex:600; appliedIndex:599; }","duration":"542.770272ms","start":"2026-02-11T03:13:41.667045Z","end":"2026-02-11T03:13:42.209816Z","steps":["trace[1043350196] 'read index received' (duration: 342.766449ms)","trace[1043350196] 'applied index is now lower than readState.Index' (duration: 200.002843ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:13:42.210144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.095494722s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-02-11T03:13:42.210146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.084047945s","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-11T03:13:42.210176Z","caller":"traceutil/trace.go:171","msg":"trace[1961841903] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:579; }","duration":"1.095547765s","start":"2026-02-11T03:13:41.114618Z","end":"2026-02-11T03:13:42.210166Z","steps":["trace[1961841903] 'agreement among raft nodes before linearized reading' (duration: 1.095397599s)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:42.210193Z","caller":"traceutil/trace.go:171","msg":"trace[801261933] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:579; }","duration":"1.084119957s","start":"2026-02-11T03:13:41.126062Z","end":"2026-02-11T03:13:42.210182Z","steps":["trace[801261933] 'agreement among raft nodes before linearized reading' (duration: 1.08394021s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:42.210209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:41.114608Z","time spent":"1.095592466s","remote":"127.0.0.1:37220","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-11T03:13:42.210242Z","caller":"traceutil/trace.go:171","msg":"trace[227865447] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"1.075903094s","start":"2026-02-11T03:13:41.134332Z","end":"2026-02-11T03:13:42.210235Z","steps":["trace[227865447] 'process raft request' (duration: 875.469405ms)","trace[227865447] 'compare' (duration: 199.553726ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:13:42.210302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:41.13432Z","time spent":"1.075937055s","remote":"127.0.0.1:37494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":950,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-11T03:13:42.210412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"714.45525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T03:13:42.21043Z","caller":"traceutil/trace.go:171","msg":"trace[474161973] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:579; }","duration":"714.488711ms","start":"2026-02-11T03:13:41.495935Z","end":"2026-02-11T03:13:42.210423Z","steps":["trace[474161973] 'agreement among raft nodes before linearized reading' (duration: 714.46353ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:42.210424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.099269026s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-02-11T03:13:42.210443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:41.495922Z","time spent":"714.518112ms","remote":"127.0.0.1:37018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" "} {"level":"info","ts":"2026-02-11T03:13:42.210455Z","caller":"traceutil/trace.go:171","msg":"trace[1247430335] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:579; }","duration":"1.099314688s","start":"2026-02-11T03:13:41.11113Z","end":"2026-02-11T03:13:42.210445Z","steps":["trace[1247430335] 'agreement among raft nodes before linearized reading' (duration: 1.099230795s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:42.210482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:41.111122Z","time spent":"1.099354209s","remote":"127.0.0.1:37220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-11T03:13:42.210513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"914.355804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T03:13:42.210528Z","caller":"traceutil/trace.go:171","msg":"trace[1613242831] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:579; }","duration":"914.404505ms","start":"2026-02-11T03:13:41.296118Z","end":"2026-02-11T03:13:42.210523Z","steps":["trace[1613242831] 'agreement among raft nodes before linearized reading' (duration: 914.382154ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:42.21054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:41.2961Z","time spent":"914.437127ms","remote":"127.0.0.1:37018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-02-11T03:13:42.210657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.084524613s","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-11T03:13:42.210673Z","caller":"traceutil/trace.go:171","msg":"trace[467577829] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:579; }","duration":"1.084575855s","start":"2026-02-11T03:13:41.126092Z","end":"2026-02-11T03:13:42.210668Z","steps":["trace[467577829] 'agreement among raft nodes before linearized reading' (duration: 1.084507422s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:42.210685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:41.126089Z","time spent":"1.084592805s","remote":"127.0.0.1:37220","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-11T03:13:42.21072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.009660779s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-bp7vg\" ","response":"range_response_count:1 size:17411"} {"level":"info","ts":"2026-02-11T03:13:42.210755Z","caller":"traceutil/trace.go:171","msg":"trace[1529903723] range","detail":"{range_begin:/registry/pods/kube-system/cilium-bp7vg; range_end:; response_count:1; response_revision:579; }","duration":"2.009731711s","start":"2026-02-11T03:13:40.201013Z","end":"2026-02-11T03:13:42.210745Z","steps":["trace[1529903723] 'agreement among raft nodes before linearized reading' (duration: 2.009569485s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:42.210782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:40.200996Z","time spent":"2.009780444s","remote":"127.0.0.1:37146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":17433,"request content":"key:\"/registry/pods/kube-system/cilium-bp7vg\" "} {"level":"warn","ts":"2026-02-11T03:13:42.210218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:41.126055Z","time spent":"1.084158768s","remote":"127.0.0.1:37220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-11T03:13:42.264042Z","caller":"traceutil/trace.go:171","msg":"trace[520290109] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"583.802827ms","start":"2026-02-11T03:13:41.680226Z","end":"2026-02-11T03:13:42.264028Z","steps":["trace[520290109] 'process raft request' (duration: 583.209014ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:42.26413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:41.680215Z","time spent":"583.870939ms","remote":"127.0.0.1:37018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5571,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T03:13:42.264207Z","caller":"traceutil/trace.go:171","msg":"trace[1121999681] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"582.59515ms","start":"2026-02-11T03:13:41.681606Z","end":"2026-02-11T03:13:42.264201Z","steps":["trace[1121999681] 'process raft request' (duration: 581.959056ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:42.264238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:41.681599Z","time spent":"582.621121ms","remote":"127.0.0.1:37018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4156,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T03:13:42.264452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.590766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4171"} {"level":"info","ts":"2026-02-11T03:13:42.264475Z","caller":"traceutil/trace.go:171","msg":"trace[1074740979] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:581; }","duration":"368.712001ms","start":"2026-02-11T03:13:41.895756Z","end":"2026-02-11T03:13:42.264468Z","steps":["trace[1074740979] 'agreement among raft nodes before linearized reading' (duration: 368.67622ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:42.264492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:41.895713Z","time spent":"368.774503ms","remote":"127.0.0.1:37018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4193,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" "} {"level":"warn","ts":"2026-02-11T03:13:42.264591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.485681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.43\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-11T03:13:42.264606Z","caller":"traceutil/trace.go:171","msg":"trace[998086680] range","detail":"{range_begin:/registry/masterleases/162.253.55.43; range_end:; response_count:1; response_revision:581; }","duration":"106.541793ms","start":"2026-02-11T03:13:42.15806Z","end":"2026-02-11T03:13:42.264602Z","steps":["trace[998086680] 'agreement among raft nodes before linearized reading' (duration: 106.493131ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:42.264797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.672636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-02-11T03:13:42.264815Z","caller":"traceutil/trace.go:171","msg":"trace[644566477] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:581; }","duration":"569.712618ms","start":"2026-02-11T03:13:41.695097Z","end":"2026-02-11T03:13:42.26481Z","steps":["trace[644566477] 'agreement among raft nodes before linearized reading' (duration: 569.679577ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:42.264832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:41.695091Z","time spent":"569.736859ms","remote":"127.0.0.1:37018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":92,"response count":1,"response size":5608,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" "} {"level":"warn","ts":"2026-02-11T03:13:42.265203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.336305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T03:13:42.265285Z","caller":"traceutil/trace.go:171","msg":"trace[1596766584] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:581; }","duration":"586.816881ms","start":"2026-02-11T03:13:41.67846Z","end":"2026-02-11T03:13:42.265277Z","steps":["trace[1596766584] 'agreement among raft nodes before linearized reading' (duration: 585.363516ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:42.265372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:41.678443Z","time spent":"586.920885ms","remote":"127.0.0.1:36980","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-11T03:13:42.539843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.952117ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T03:13:42.540039Z","caller":"traceutil/trace.go:171","msg":"trace[1861209448] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"325.498491ms","start":"2026-02-11T03:13:42.214517Z","end":"2026-02-11T03:13:42.540016Z","steps":["trace[1861209448] 'process raft request' (duration: 137.309324ms)","trace[1861209448] 'compare' (duration: 187.848204ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:13:42.54015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:42.214502Z","time spent":"325.585324ms","remote":"127.0.0.1:37220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T03:13:42.540223Z","caller":"traceutil/trace.go:171","msg":"trace[1437467073] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:602; }","duration":"248.427861ms","start":"2026-02-11T03:13:42.291777Z","end":"2026-02-11T03:13:42.540205Z","steps":["trace[1437467073] 'read index received' (duration: 60.056687ms)","trace[1437467073] 'applied index is now lower than readState.Index' (duration: 188.370504ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T03:13:42.540303Z","caller":"traceutil/trace.go:171","msg":"trace[1401318016] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"324.088707ms","start":"2026-02-11T03:13:42.216205Z","end":"2026-02-11T03:13:42.540294Z","steps":["trace[1401318016] 'process raft request' (duration: 323.704983ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:42.540359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:42.216198Z","time spent":"324.129039ms","remote":"127.0.0.1:37220","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-11T03:13:42.540561Z","caller":"traceutil/trace.go:171","msg":"trace[1599247234] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"315.68031ms","start":"2026-02-11T03:13:42.224872Z","end":"2026-02-11T03:13:42.540552Z","steps":["trace[1599247234] 'process raft request' (duration: 315.067337ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:42.540597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:42.224856Z","time spent":"315.724222ms","remote":"127.0.0.1:37046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":749,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-11T03:13:42.540662Z","caller":"traceutil/trace.go:171","msg":"trace[199561459] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"250.147486ms","start":"2026-02-11T03:13:42.290504Z","end":"2026-02-11T03:13:42.540651Z","steps":["trace[199561459] 'process raft request' (duration: 249.621846ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:42.540681Z","caller":"traceutil/trace.go:171","msg":"trace[428041894] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"315.722441ms","start":"2026-02-11T03:13:42.224949Z","end":"2026-02-11T03:13:42.540672Z","steps":["trace[428041894] 'process raft request' (duration: 315.025175ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:42.540712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:42.224946Z","time spent":"315.749422ms","remote":"127.0.0.1:37220","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-11T03:13:42.540793Z","caller":"traceutil/trace.go:171","msg":"trace[1095631122] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"250.218639ms","start":"2026-02-11T03:13:42.290564Z","end":"2026-02-11T03:13:42.540783Z","steps":["trace[1095631122] 'process raft request' (duration: 249.609926ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:42.540889Z","caller":"traceutil/trace.go:171","msg":"trace[1473142207] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"311.381107ms","start":"2026-02-11T03:13:42.2295Z","end":"2026-02-11T03:13:42.540881Z","steps":["trace[1473142207] 'process raft request' (duration: 310.524015ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:42.540923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:42.229479Z","time spent":"311.424899ms","remote":"127.0.0.1:37146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17558,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T03:13:42.540932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.149168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T03:13:42.540964Z","caller":"traceutil/trace.go:171","msg":"trace[2007292469] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:589; }","duration":"249.19829ms","start":"2026-02-11T03:13:42.291757Z","end":"2026-02-11T03:13:42.540955Z","steps":["trace[2007292469] 'agreement among raft nodes before linearized reading' (duration: 249.139858ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:42.541192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.424236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:1 size:3368"} {"level":"info","ts":"2026-02-11T03:13:42.541227Z","caller":"traceutil/trace.go:171","msg":"trace[1902195653] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:1; response_revision:589; }","duration":"246.470917ms","start":"2026-02-11T03:13:42.294747Z","end":"2026-02-11T03:13:42.541218Z","steps":["trace[1902195653] 'agreement among raft nodes before linearized reading' (duration: 246.353143ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:42.540798Z","caller":"traceutil/trace.go:171","msg":"trace[1056728801] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"315.814185ms","start":"2026-02-11T03:13:42.224978Z","end":"2026-02-11T03:13:42.540792Z","steps":["trace[1056728801] 'process raft request' (duration: 315.020465ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:42.541371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:42.224974Z","time spent":"316.375216ms","remote":"127.0.0.1:37220","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-11T03:13:43.002334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.141531ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T03:13:43.002459Z","caller":"traceutil/trace.go:171","msg":"trace[256013978] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:613; }","duration":"395.024597ms","start":"2026-02-11T03:13:42.607422Z","end":"2026-02-11T03:13:43.002447Z","steps":["trace[256013978] 'read index received' (duration: 173.618656ms)","trace[256013978] 'applied index is now lower than readState.Index' (duration: 221.405061ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T03:13:43.002621Z","caller":"traceutil/trace.go:171","msg":"trace[1428168515] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"438.635644ms","start":"2026-02-11T03:13:42.563975Z","end":"2026-02-11T03:13:43.00261Z","steps":["trace[1428168515] 'process raft request' (duration: 217.15878ms)","trace[1428168515] 'compare' (duration: 221.054428ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:13:43.002671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:42.563966Z","time spent":"438.677175ms","remote":"127.0.0.1:37018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":24220,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T03:13:43.002925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.498895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-11T03:13:43.003808Z","caller":"traceutil/trace.go:171","msg":"trace[478279163] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:593; }","duration":"396.407299ms","start":"2026-02-11T03:13:42.607392Z","end":"2026-02-11T03:13:43.003799Z","steps":["trace[478279163] 'agreement among raft nodes before linearized reading' (duration: 395.455523ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:43.003837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:42.607377Z","time spent":"396.449571ms","remote":"127.0.0.1:37000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":155,"request content":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" "} {"level":"info","ts":"2026-02-11T03:13:43.003048Z","caller":"traceutil/trace.go:171","msg":"trace[1606669819] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"434.449815ms","start":"2026-02-11T03:13:42.568591Z","end":"2026-02-11T03:13:43.003041Z","steps":["trace[1606669819] 'process raft request' (duration: 433.808461ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:43.006176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:42.568585Z","time spent":"437.566312ms","remote":"127.0.0.1:37146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17651,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T03:13:43.003418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.118407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24235"} {"level":"warn","ts":"2026-02-11T03:13:43.003472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.56783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:8285"} {"level":"info","ts":"2026-02-11T03:13:43.00636Z","caller":"traceutil/trace.go:171","msg":"trace[94738483] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:593; }","duration":"111.47558ms","start":"2026-02-11T03:13:42.894875Z","end":"2026-02-11T03:13:43.006351Z","steps":["trace[94738483] 'agreement among raft nodes before linearized reading' (duration: 108.55796ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:43.006515Z","caller":"traceutil/trace.go:171","msg":"trace[1981696977] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:593; }","duration":"310.252876ms","start":"2026-02-11T03:13:42.696255Z","end":"2026-02-11T03:13:43.006507Z","steps":["trace[1981696977] 'agreement among raft nodes before linearized reading' (duration: 307.133798ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:43.006601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:42.696222Z","time spent":"310.37047ms","remote":"127.0.0.1:37018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":24257,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" "} {"level":"warn","ts":"2026-02-11T03:13:43.418716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.155498ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T03:13:43.418881Z","caller":"traceutil/trace.go:171","msg":"trace[1743865218] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"384.158333ms","start":"2026-02-11T03:13:43.034635Z","end":"2026-02-11T03:13:43.418793Z","steps":["trace[1743865218] 'process raft request' (duration: 136.583559ms)","trace[1743865218] 'compare' (duration: 247.015633ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:13:43.419036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:43.03462Z","time spent":"384.373362ms","remote":"127.0.0.1:37018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5153,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T03:13:43.425685Z","caller":"traceutil/trace.go:171","msg":"trace[316664672] linearizableReadLoop","detail":"{readStateIndex:619; appliedIndex:615; }","duration":"316.173045ms","start":"2026-02-11T03:13:43.109499Z","end":"2026-02-11T03:13:43.425672Z","steps":["trace[316664672] 'read index received' (duration: 61.726144ms)","trace[316664672] 'applied index is now lower than readState.Index' (duration: 254.446341ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T03:13:43.425891Z","caller":"traceutil/trace.go:171","msg":"trace[677280454] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"382.983ms","start":"2026-02-11T03:13:43.042898Z","end":"2026-02-11T03:13:43.425881Z","steps":["trace[677280454] 'process raft request' (duration: 382.627487ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:43.425975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:43.042885Z","time spent":"383.036293ms","remote":"127.0.0.1:37018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":24229,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T03:13:43.426158Z","caller":"traceutil/trace.go:171","msg":"trace[412296686] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"361.135334ms","start":"2026-02-11T03:13:43.065015Z","end":"2026-02-11T03:13:43.426151Z","steps":["trace[412296686] 'process raft request' (duration: 360.591764ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:43.426197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:43.064998Z","time spent":"361.176206ms","remote":"127.0.0.1:37146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4609,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T03:13:43.426286Z","caller":"traceutil/trace.go:171","msg":"trace[617862981] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"317.865359ms","start":"2026-02-11T03:13:43.108415Z","end":"2026-02-11T03:13:43.42628Z","steps":["trace[617862981] 'process raft request' (duration: 317.227015ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:43.426315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:43.108398Z","time spent":"317.90266ms","remote":"127.0.0.1:37046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":712,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-11T03:13:43.426636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.132711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:12259"} {"level":"info","ts":"2026-02-11T03:13:43.426663Z","caller":"traceutil/trace.go:171","msg":"trace[1118377238] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:597; }","duration":"317.175033ms","start":"2026-02-11T03:13:43.10948Z","end":"2026-02-11T03:13:43.426655Z","steps":["trace[1118377238] 'agreement among raft nodes before linearized reading' (duration: 317.076489ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:43.426688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:43.109473Z","time spent":"317.210124ms","remote":"127.0.0.1:37018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":1,"response size":12281,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" "} {"level":"warn","ts":"2026-02-11T03:13:44.086503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.376913ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T03:13:44.086566Z","caller":"traceutil/trace.go:171","msg":"trace[1614184554] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:619; }","duration":"660.840749ms","start":"2026-02-11T03:13:43.425714Z","end":"2026-02-11T03:13:44.086554Z","steps":["trace[1614184554] 'read index received' (duration: 402.433845ms)","trace[1614184554] 'applied index is now lower than readState.Index' (duration: 258.406174ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T03:13:44.08666Z","caller":"traceutil/trace.go:171","msg":"trace[623475047] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"662.926127ms","start":"2026-02-11T03:13:43.423728Z","end":"2026-02-11T03:13:44.086654Z","steps":["trace[623475047] 'process raft request' (duration: 404.346587ms)","trace[623475047] 'compare' (duration: 258.243997ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:13:44.086689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:43.423711Z","time spent":"662.962838ms","remote":"127.0.0.1:37018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10353,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T03:13:44.086815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"791.329901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5168"} {"level":"info","ts":"2026-02-11T03:13:44.086828Z","caller":"traceutil/trace.go:171","msg":"trace[1623566445] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:598; }","duration":"791.374653ms","start":"2026-02-11T03:13:43.295449Z","end":"2026-02-11T03:13:44.086823Z","steps":["trace[1623566445] 'agreement among raft nodes before linearized reading' (duration: 791.313181ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:44.086842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:43.295429Z","time spent":"791.409924ms","remote":"127.0.0.1:37018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":5190,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" "} {"level":"warn","ts":"2026-02-11T03:13:44.086917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"946.700083ms","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-11T03:13:44.086928Z","caller":"traceutil/trace.go:171","msg":"trace[1499186926] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:598; }","duration":"946.737074ms","start":"2026-02-11T03:13:43.140188Z","end":"2026-02-11T03:13:44.086925Z","steps":["trace[1499186926] 'agreement among raft nodes before linearized reading' (duration: 946.700512ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:44.086942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:43.140174Z","time spent":"946.763875ms","remote":"127.0.0.1:37220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-11T03:13:44.087001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"977.463191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T03:13:44.087011Z","caller":"traceutil/trace.go:171","msg":"trace[334500829] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:598; }","duration":"977.480162ms","start":"2026-02-11T03:13:43.109528Z","end":"2026-02-11T03:13:44.087008Z","steps":["trace[334500829] 'agreement among raft nodes before linearized reading' (duration: 977.461621ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:44.087022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:43.109524Z","time spent":"977.495552ms","remote":"127.0.0.1:36980","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-11T03:13:44.320201Z","caller":"traceutil/trace.go:171","msg":"trace[1205183538] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"874.085393ms","start":"2026-02-11T03:13:43.446095Z","end":"2026-02-11T03:13:44.32018Z","steps":["trace[1205183538] 'process raft request' (duration: 805.239001ms)","trace[1205183538] 'compare' (duration: 68.617454ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:13:44.320292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:43.446079Z","time spent":"874.166307ms","remote":"127.0.0.1:37018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5162,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T03:13:44.320563Z","caller":"traceutil/trace.go:171","msg":"trace[2003672913] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"871.914942ms","start":"2026-02-11T03:13:43.448642Z","end":"2026-02-11T03:13:44.320557Z","steps":["trace[2003672913] 'process raft request' (duration: 871.419204ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:44.320591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:43.448635Z","time spent":"871.940533ms","remote":"127.0.0.1:37440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4365,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T03:13:44.32077Z","caller":"traceutil/trace.go:171","msg":"trace[2004734516] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"872.086799ms","start":"2026-02-11T03:13:43.448678Z","end":"2026-02-11T03:13:44.320765Z","steps":["trace[2004734516] 'process raft request' (duration: 871.456246ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:44.320793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:43.448673Z","time spent":"872.108759ms","remote":"127.0.0.1:37046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":712,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-11T03:13:44.320826Z","caller":"traceutil/trace.go:171","msg":"trace[138857430] linearizableReadLoop","detail":"{readStateIndex:625; appliedIndex:620; }","duration":"234.228877ms","start":"2026-02-11T03:13:44.086579Z","end":"2026-02-11T03:13:44.320808Z","steps":["trace[138857430] 'read index received' (duration: 164.766473ms)","trace[138857430] 'applied index is now lower than readState.Index' (duration: 69.461664ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T03:13:44.320885Z","caller":"traceutil/trace.go:171","msg":"trace[1810660172] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"792.793618ms","start":"2026-02-11T03:13:43.528087Z","end":"2026-02-11T03:13:44.320881Z","steps":["trace[1810660172] 'process raft request' (duration: 792.242468ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:44.320908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:43.528071Z","time spent":"792.82664ms","remote":"127.0.0.1:37018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187455,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-11T03:13:44.320923Z","caller":"traceutil/trace.go:171","msg":"trace[1025476158] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"601.791106ms","start":"2026-02-11T03:13:43.71912Z","end":"2026-02-11T03:13:44.320911Z","steps":["trace[1025476158] 'process raft request' (duration: 601.530767ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:44.320995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:43.719099Z","time spent":"601.848329ms","remote":"127.0.0.1:37018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187246,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-11T03:13:44.321202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.033464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"} {"level":"info","ts":"2026-02-11T03:13:44.321231Z","caller":"traceutil/trace.go:171","msg":"trace[1598700092] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:603; }","duration":"426.090936ms","start":"2026-02-11T03:13:43.895135Z","end":"2026-02-11T03:13:44.321226Z","steps":["trace[1598700092] 'agreement among raft nodes before linearized reading' (duration: 425.990562ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:44.321246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:43.895117Z","time spent":"426.125377ms","remote":"127.0.0.1:37018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4202,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" "} {"level":"info","ts":"2026-02-11T03:13:44.328717Z","caller":"traceutil/trace.go:171","msg":"trace[1087119715] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"234.460877ms","start":"2026-02-11T03:13:44.094239Z","end":"2026-02-11T03:13:44.3287Z","steps":["trace[1087119715] 'process raft request' (duration: 234.295241ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:44.331366Z","caller":"traceutil/trace.go:171","msg":"trace[1258850280] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"233.865304ms","start":"2026-02-11T03:13:44.097494Z","end":"2026-02-11T03:13:44.331359Z","steps":["trace[1258850280] 'process raft request' (duration: 231.152414ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:44.331448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.62861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:1 size:3368"} {"level":"info","ts":"2026-02-11T03:13:44.331729Z","caller":"traceutil/trace.go:171","msg":"trace[1713680761] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:1; response_revision:605; }","duration":"235.93527ms","start":"2026-02-11T03:13:44.095787Z","end":"2026-02-11T03:13:44.331722Z","steps":["trace[1713680761] 'agreement among raft nodes before linearized reading' (duration: 235.595088ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:44.331585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.965307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T03:13:44.331819Z","caller":"traceutil/trace.go:171","msg":"trace[1226461101] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:605; }","duration":"231.219187ms","start":"2026-02-11T03:13:44.100595Z","end":"2026-02-11T03:13:44.331814Z","steps":["trace[1226461101] 'agreement among raft nodes before linearized reading' (duration: 230.942617ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:44.643585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.681828ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T03:13:44.643709Z","caller":"traceutil/trace.go:171","msg":"trace[1214384877] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"169.989906ms","start":"2026-02-11T03:13:44.473709Z","end":"2026-02-11T03:13:44.643699Z","steps":["trace[1214384877] 'process raft request' (duration: 169.967915ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:44.643911Z","caller":"traceutil/trace.go:171","msg":"trace[939626675] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"306.681964ms","start":"2026-02-11T03:13:44.337223Z","end":"2026-02-11T03:13:44.643905Z","steps":["trace[939626675] 'process raft request' (duration: 150.611321ms)","trace[939626675] 'compare' (duration: 155.575274ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:13:44.64394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:44.337217Z","time spent":"306.706994ms","remote":"127.0.0.1:37420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T03:13:44.644047Z","caller":"traceutil/trace.go:171","msg":"trace[1197514156] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"286.109734ms","start":"2026-02-11T03:13:44.357932Z","end":"2026-02-11T03:13:44.644042Z","steps":["trace[1197514156] 'process raft request' (duration: 285.710119ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:44.64411Z","caller":"traceutil/trace.go:171","msg":"trace[1304944924] linearizableReadLoop","detail":"{readStateIndex:629; appliedIndex:628; }","duration":"297.961101ms","start":"2026-02-11T03:13:44.346132Z","end":"2026-02-11T03:13:44.644093Z","steps":["trace[1304944924] 'read index received' (duration: 60.306186ms)","trace[1304944924] 'applied index is now lower than readState.Index' (duration: 237.654405ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:13:44.644212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.078446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T03:13:44.644225Z","caller":"traceutil/trace.go:171","msg":"trace[3471105] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:609; }","duration":"298.109856ms","start":"2026-02-11T03:13:44.346111Z","end":"2026-02-11T03:13:44.644221Z","steps":["trace[3471105] 'agreement among raft nodes before linearized reading' (duration: 298.084995ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:44.664094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.110858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-02-11T03:13:44.664103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.195312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-bp7vg\" ","response":"range_response_count:1 size:17666"} {"level":"info","ts":"2026-02-11T03:13:44.664139Z","caller":"traceutil/trace.go:171","msg":"trace[1597025725] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:610; }","duration":"109.198881ms","start":"2026-02-11T03:13:44.554929Z","end":"2026-02-11T03:13:44.664128Z","steps":["trace[1597025725] 'agreement among raft nodes before linearized reading' (duration: 109.030135ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:44.664177Z","caller":"traceutil/trace.go:171","msg":"trace[2115058209] range","detail":"{range_begin:/registry/pods/kube-system/cilium-bp7vg; range_end:; response_count:1; response_revision:610; }","duration":"190.305036ms","start":"2026-02-11T03:13:44.473841Z","end":"2026-02-11T03:13:44.664146Z","steps":["trace[2115058209] 'agreement among raft nodes before linearized reading' (duration: 190.110709ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:44.66437Z","caller":"traceutil/trace.go:171","msg":"trace[321869325] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"141.086689ms","start":"2026-02-11T03:13:44.523277Z","end":"2026-02-11T03:13:44.664363Z","steps":["trace[321869325] 'process raft request' (duration: 140.490177ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:44.664435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.544829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-02-11T03:13:44.664474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.361268ms","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-11T03:13:44.664474Z","caller":"traceutil/trace.go:171","msg":"trace[1335118392] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:610; }","duration":"114.58195ms","start":"2026-02-11T03:13:44.549869Z","end":"2026-02-11T03:13:44.664451Z","steps":["trace[1335118392] 'agreement among raft nodes before linearized reading' (duration: 114.494667ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:44.66449Z","caller":"traceutil/trace.go:171","msg":"trace[1517424893] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:610; }","duration":"109.401899ms","start":"2026-02-11T03:13:44.555084Z","end":"2026-02-11T03:13:44.664486Z","steps":["trace[1517424893] 'agreement among raft nodes before linearized reading' (duration: 109.354647ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:44.664663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.150681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-02-11T03:13:44.664672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.461902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"info","ts":"2026-02-11T03:13:44.664691Z","caller":"traceutil/trace.go:171","msg":"trace[1859335694] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:610; }","duration":"141.500564ms","start":"2026-02-11T03:13:44.523184Z","end":"2026-02-11T03:13:44.664685Z","steps":["trace[1859335694] 'agreement among raft nodes before linearized reading' (duration: 141.451792ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:44.664685Z","caller":"traceutil/trace.go:171","msg":"trace[612336139] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:610; }","duration":"115.201384ms","start":"2026-02-11T03:13:44.549477Z","end":"2026-02-11T03:13:44.664678Z","steps":["trace[612336139] 'agreement among raft nodes before linearized reading' (duration: 115.123891ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:44.911527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.757199ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T03:13:44.911607Z","caller":"traceutil/trace.go:171","msg":"trace[1571746122] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"255.844375ms","start":"2026-02-11T03:13:44.655738Z","end":"2026-02-11T03:13:44.911583Z","steps":["trace[1571746122] 'process raft request' (duration: 105.971932ms)","trace[1571746122] 'compare' (duration: 149.523981ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T03:13:44.936268Z","caller":"traceutil/trace.go:171","msg":"trace[803450931] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:632; }","duration":"241.534967ms","start":"2026-02-11T03:13:44.694717Z","end":"2026-02-11T03:13:44.936252Z","steps":["trace[803450931] 'read index received' (duration: 67.010624ms)","trace[803450931] 'applied index is now lower than readState.Index' (duration: 174.523823ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T03:13:44.936488Z","caller":"traceutil/trace.go:171","msg":"trace[1370438245] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"260.701926ms","start":"2026-02-11T03:13:44.675779Z","end":"2026-02-11T03:13:44.936481Z","steps":["trace[1370438245] 'process raft request' (duration: 260.27165ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:44.936662Z","caller":"traceutil/trace.go:171","msg":"trace[1938144166] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"249.558264ms","start":"2026-02-11T03:13:44.687089Z","end":"2026-02-11T03:13:44.936647Z","steps":["trace[1938144166] 'process raft request' (duration: 249.047875ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:44.936728Z","caller":"traceutil/trace.go:171","msg":"trace[80901631] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"249.574865ms","start":"2026-02-11T03:13:44.687148Z","end":"2026-02-11T03:13:44.936723Z","steps":["trace[80901631] 'process raft request' (duration: 249.020864ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:44.936777Z","caller":"traceutil/trace.go:171","msg":"trace[1066284589] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"249.548323ms","start":"2026-02-11T03:13:44.687225Z","end":"2026-02-11T03:13:44.936773Z","steps":["trace[1066284589] 'process raft request' (duration: 248.970452ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:44.936829Z","caller":"traceutil/trace.go:171","msg":"trace[171338649] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"249.538353ms","start":"2026-02-11T03:13:44.687284Z","end":"2026-02-11T03:13:44.936822Z","steps":["trace[171338649] 'process raft request' (duration: 248.926471ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:44.936925Z","caller":"traceutil/trace.go:171","msg":"trace[523880379] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"249.615296ms","start":"2026-02-11T03:13:44.687306Z","end":"2026-02-11T03:13:44.936921Z","steps":["trace[523880379] 'process raft request' (duration: 248.92181ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:44.937028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.300655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"} {"level":"info","ts":"2026-02-11T03:13:44.937043Z","caller":"traceutil/trace.go:171","msg":"trace[1912690263] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:617; }","duration":"242.325276ms","start":"2026-02-11T03:13:44.694713Z","end":"2026-02-11T03:13:44.937038Z","steps":["trace[1912690263] 'agreement among raft nodes before linearized reading' (duration: 242.253464ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:45.626671Z","caller":"traceutil/trace.go:171","msg":"trace[966039484] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"368.509105ms","start":"2026-02-11T03:13:45.258142Z","end":"2026-02-11T03:13:45.626651Z","steps":["trace[966039484] 'process raft request' (duration: 368.216174ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:45.626774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:45.258124Z","time spent":"368.594178ms","remote":"127.0.0.1:37018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188228,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T03:13:45.62824Z","caller":"traceutil/trace.go:171","msg":"trace[281663649] linearizableReadLoop","detail":"{readStateIndex:644; appliedIndex:644; }","duration":"331.647898ms","start":"2026-02-11T03:13:45.296584Z","end":"2026-02-11T03:13:45.628232Z","steps":["trace[281663649] 'read index received' (duration: 331.644768ms)","trace[281663649] 'applied index is now lower than readState.Index' (duration: 2.5µs)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:13:45.639952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.346725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"} {"level":"info","ts":"2026-02-11T03:13:45.640025Z","caller":"traceutil/trace.go:171","msg":"trace[813130204] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:622; }","duration":"343.447189ms","start":"2026-02-11T03:13:45.296557Z","end":"2026-02-11T03:13:45.640004Z","steps":["trace[813130204] 'agreement among raft nodes before linearized reading' (duration: 331.711421ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:45.640056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:45.296542Z","time spent":"343.507612ms","remote":"127.0.0.1:37018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":5199,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" "} {"level":"warn","ts":"2026-02-11T03:13:45.640333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.606747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-bp7vg\" ","response":"range_response_count:1 size:17914"} {"level":"info","ts":"2026-02-11T03:13:45.640353Z","caller":"traceutil/trace.go:171","msg":"trace[1512568128] range","detail":"{range_begin:/registry/pods/kube-system/cilium-bp7vg; range_end:; response_count:1; response_revision:624; }","duration":"179.650009ms","start":"2026-02-11T03:13:45.460698Z","end":"2026-02-11T03:13:45.640348Z","steps":["trace[1512568128] 'agreement among raft nodes before linearized reading' (duration: 179.569416ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:45.640468Z","caller":"traceutil/trace.go:171","msg":"trace[508688526] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"179.718761ms","start":"2026-02-11T03:13:45.460732Z","end":"2026-02-11T03:13:45.640451Z","steps":["trace[508688526] 'process raft request' (duration: 179.490763ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:45.640575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.091331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:1 size:4333"} {"level":"info","ts":"2026-02-11T03:13:45.640592Z","caller":"traceutil/trace.go:171","msg":"trace[1874220626] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:1; response_revision:624; }","duration":"144.133062ms","start":"2026-02-11T03:13:45.496452Z","end":"2026-02-11T03:13:45.640585Z","steps":["trace[1874220626] 'agreement among raft nodes before linearized reading' (duration: 144.07811ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:45.640642Z","caller":"traceutil/trace.go:171","msg":"trace[616587657] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"343.573234ms","start":"2026-02-11T03:13:45.297063Z","end":"2026-02-11T03:13:45.640636Z","steps":["trace[616587657] 'process raft request' (duration: 342.263396ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:45.64069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:13:45.297052Z","time spent":"343.603165ms","remote":"127.0.0.1:37018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188480,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T03:13:47.416428Z","caller":"traceutil/trace.go:171","msg":"trace[727714630] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"108.139351ms","start":"2026-02-11T03:13:47.308269Z","end":"2026-02-11T03:13:47.416409Z","steps":["trace[727714630] 'process raft request' (duration: 107.715436ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:47.51476Z","caller":"traceutil/trace.go:171","msg":"trace[1227089469] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"120.948878ms","start":"2026-02-11T03:13:47.393794Z","end":"2026-02-11T03:13:47.514742Z","steps":["trace[1227089469] 'process raft request' (duration: 120.570335ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:13:53.101093Z","caller":"traceutil/trace.go:171","msg":"trace[1962323606] linearizableReadLoop","detail":"{readStateIndex:704; appliedIndex:703; }","duration":"107.375615ms","start":"2026-02-11T03:13:52.993704Z","end":"2026-02-11T03:13:53.10108Z","steps":["trace[1962323606] 'read index received' (duration: 107.280732ms)","trace[1962323606] 'applied index is now lower than readState.Index' (duration: 92.433µs)"],"step_count":2} {"level":"info","ts":"2026-02-11T03:13:53.101178Z","caller":"traceutil/trace.go:171","msg":"trace[776122474] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"108.3987ms","start":"2026-02-11T03:13:52.992774Z","end":"2026-02-11T03:13:53.101172Z","steps":["trace[776122474] 'process raft request' (duration: 108.217994ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:53.101333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.750661ms","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-11T03:13:53.101385Z","caller":"traceutil/trace.go:171","msg":"trace[916029216] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:679; }","duration":"100.814434ms","start":"2026-02-11T03:13:53.000556Z","end":"2026-02-11T03:13:53.10137Z","steps":["trace[916029216] 'agreement among raft nodes before linearized reading' (duration: 100.687489ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:53.10147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.752187ms","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-11T03:13:53.101495Z","caller":"traceutil/trace.go:171","msg":"trace[1957448413] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:679; }","duration":"107.795378ms","start":"2026-02-11T03:13:52.993692Z","end":"2026-02-11T03:13:53.101487Z","steps":["trace[1957448413] 'agreement among raft nodes before linearized reading' (duration: 107.717466ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:13:53.101541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.157751ms","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-11T03:13:53.101575Z","caller":"traceutil/trace.go:171","msg":"trace[118855500] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:679; }","duration":"100.218783ms","start":"2026-02-11T03:13:53.001337Z","end":"2026-02-11T03:13:53.101556Z","steps":["trace[118855500] 'agreement among raft nodes before linearized reading' (duration: 100.159751ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:14:05.302073Z","caller":"traceutil/trace.go:171","msg":"trace[192816156] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"144.286346ms","start":"2026-02-11T03:14:05.157762Z","end":"2026-02-11T03:14:05.302048Z","steps":["trace[192816156] 'process raft request' (duration: 144.030369ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:14:05.43452Z","caller":"traceutil/trace.go:171","msg":"trace[2132717434] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"124.527204ms","start":"2026-02-11T03:14:05.309975Z","end":"2026-02-11T03:14:05.434503Z","steps":["trace[2132717434] 'process raft request' (duration: 86.711198ms)","trace[2132717434] 'compare' (duration: 37.139876ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T03:14:05.435733Z","caller":"traceutil/trace.go:171","msg":"trace[1252102263] linearizableReadLoop","detail":"{readStateIndex:796; appliedIndex:795; }","duration":"124.310527ms","start":"2026-02-11T03:14:05.31003Z","end":"2026-02-11T03:14:05.434341Z","steps":["trace[1252102263] 'read index received' (duration: 4.980526ms)","trace[1252102263] 'applied index is now lower than readState.Index' (duration: 119.329071ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T03:14:05.436632Z","caller":"traceutil/trace.go:171","msg":"trace[1921947563] transaction","detail":"{read_only:false; response_revision:769; number_of_response:1; }","duration":"124.927236ms","start":"2026-02-11T03:14:05.311669Z","end":"2026-02-11T03:14:05.436597Z","steps":["trace[1921947563] 'process raft request' (duration: 122.33501ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:14:05.436901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.856162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T03:14:05.437053Z","caller":"traceutil/trace.go:171","msg":"trace[782813381] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:769; }","duration":"127.407199ms","start":"2026-02-11T03:14:05.309635Z","end":"2026-02-11T03:14:05.437042Z","steps":["trace[782813381] 'agreement among raft nodes before linearized reading' (duration: 126.140242ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:14:07.607072Z","caller":"traceutil/trace.go:171","msg":"trace[2065762523] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"152.554461ms","start":"2026-02-11T03:14:07.454499Z","end":"2026-02-11T03:14:07.607053Z","steps":["trace[2065762523] 'process raft request' (duration: 76.746479ms)","trace[2065762523] 'compare' (duration: 75.73015ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T03:14:07.86832Z","caller":"traceutil/trace.go:171","msg":"trace[1746414326] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"412.666623ms","start":"2026-02-11T03:14:07.455628Z","end":"2026-02-11T03:14:07.868294Z","steps":["trace[1746414326] 'process raft request' (duration: 366.105236ms)","trace[1746414326] 'compare' (duration: 46.457964ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:14:07.869058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:14:07.455619Z","time spent":"413.338843ms","remote":"127.0.0.1:37220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T03:14:10.78895Z","caller":"traceutil/trace.go:171","msg":"trace[33908874] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"179.027016ms","start":"2026-02-11T03:14:10.609888Z","end":"2026-02-11T03:14:10.788915Z","steps":["trace[33908874] 'process raft request' (duration: 178.81071ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:14:17.829281Z","caller":"traceutil/trace.go:171","msg":"trace[753480446] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"105.316494ms","start":"2026-02-11T03:14:17.723929Z","end":"2026-02-11T03:14:17.829246Z","steps":["trace[753480446] 'process raft request' (duration: 105.135779ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:14:20.061634Z","caller":"traceutil/trace.go:171","msg":"trace[1460482517] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"138.239367ms","start":"2026-02-11T03:14:19.923364Z","end":"2026-02-11T03:14:20.061603Z","steps":["trace[1460482517] 'process raft request' (duration: 68.076263ms)","trace[1460482517] 'compare' (duration: 70.044931ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T03:14:33.267426Z","caller":"traceutil/trace.go:171","msg":"trace[1922426913] linearizableReadLoop","detail":"{readStateIndex:879; appliedIndex:878; }","duration":"173.409416ms","start":"2026-02-11T03:14:33.093992Z","end":"2026-02-11T03:14:33.267402Z","steps":["trace[1922426913] 'read index received' (duration: 173.168071ms)","trace[1922426913] 'applied index is now lower than readState.Index' (duration: 240.095µs)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:14:33.267626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.60387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T03:14:33.267664Z","caller":"traceutil/trace.go:171","msg":"trace[779039539] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:845; }","duration":"173.713533ms","start":"2026-02-11T03:14:33.093932Z","end":"2026-02-11T03:14:33.267646Z","steps":["trace[779039539] 'agreement among raft nodes before linearized reading' (duration: 173.59765ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:14:33.268102Z","caller":"traceutil/trace.go:171","msg":"trace[934738863] transaction","detail":"{read_only:false; response_revision:845; number_of_response:1; }","duration":"192.188333ms","start":"2026-02-11T03:14:33.075877Z","end":"2026-02-11T03:14:33.268065Z","steps":["trace[934738863] 'process raft request' (duration: 191.367144ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:14:53.997121Z","caller":"traceutil/trace.go:171","msg":"trace[1645944968] linearizableReadLoop","detail":"{readStateIndex:956; appliedIndex:955; }","duration":"182.493583ms","start":"2026-02-11T03:14:53.814607Z","end":"2026-02-11T03:14:53.997101Z","steps":["trace[1645944968] 'read index received' (duration: 182.403921ms)","trace[1645944968] 'applied index is now lower than readState.Index' (duration: 88.712µs)"],"step_count":2} {"level":"info","ts":"2026-02-11T03:14:53.997262Z","caller":"traceutil/trace.go:171","msg":"trace[1984544538] transaction","detail":"{read_only:false; response_revision:918; number_of_response:1; }","duration":"211.655461ms","start":"2026-02-11T03:14:53.785599Z","end":"2026-02-11T03:14:53.997254Z","steps":["trace[1984544538] 'process raft request' (duration: 211.366325ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:14:53.997454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.840649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5cf6ac2e-b4e4-40fe-a4b3-1edba8d2535f\" ","response":"range_response_count:1 size:3805"} {"level":"info","ts":"2026-02-11T03:14:53.997484Z","caller":"traceutil/trace.go:171","msg":"trace[771762597] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5cf6ac2e-b4e4-40fe-a4b3-1edba8d2535f; range_end:; response_count:1; response_revision:918; }","duration":"182.922791ms","start":"2026-02-11T03:14:53.814551Z","end":"2026-02-11T03:14:53.997473Z","steps":["trace[771762597] 'agreement among raft nodes before linearized reading' (duration: 182.811179ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:14:54.354756Z","caller":"traceutil/trace.go:171","msg":"trace[1943466535] linearizableReadLoop","detail":"{readStateIndex:958; appliedIndex:957; }","duration":"102.375249ms","start":"2026-02-11T03:14:54.252353Z","end":"2026-02-11T03:14:54.354728Z","steps":["trace[1943466535] 'read index received' (duration: 26.564573ms)","trace[1943466535] 'applied index is now lower than readState.Index' (duration: 75.809086ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:14:54.355356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.957ms","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-11T03:14:54.355679Z","caller":"traceutil/trace.go:171","msg":"trace[2025893220] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:920; }","duration":"103.334928ms","start":"2026-02-11T03:14:54.25232Z","end":"2026-02-11T03:14:54.355655Z","steps":["trace[2025893220] 'agreement among raft nodes before linearized reading' (duration: 102.686085ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:14:54.355743Z","caller":"traceutil/trace.go:171","msg":"trace[1531442412] transaction","detail":"{read_only:false; response_revision:920; number_of_response:1; }","duration":"209.834056ms","start":"2026-02-11T03:14:54.145889Z","end":"2026-02-11T03:14:54.355723Z","steps":["trace[1531442412] 'process raft request' (duration: 133.108673ms)","trace[1531442412] 'compare' (duration: 75.418408ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T03:14:54.877344Z","caller":"traceutil/trace.go:171","msg":"trace[1316736494] transaction","detail":"{read_only:false; response_revision:923; number_of_response:1; }","duration":"116.605724ms","start":"2026-02-11T03:14:54.760704Z","end":"2026-02-11T03:14:54.87731Z","steps":["trace[1316736494] 'process raft request' (duration: 116.300278ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:15:06.751649Z","caller":"traceutil/trace.go:171","msg":"trace[370619419] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"193.434197ms","start":"2026-02-11T03:15:06.558183Z","end":"2026-02-11T03:15:06.751617Z","steps":["trace[370619419] 'process raft request' (duration: 193.197983ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:15:07.263664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.10917ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-11T03:15:07.26385Z","caller":"traceutil/trace.go:171","msg":"trace[1250631415] linearizableReadLoop","detail":"{readStateIndex:1018; appliedIndex:1016; }","duration":"161.517701ms","start":"2026-02-11T03:15:07.102312Z","end":"2026-02-11T03:15:07.26383Z","steps":["trace[1250631415] 'read index received' (duration: 27.501µs)","trace[1250631415] 'applied index is now lower than readState.Index' (duration: 161.48932ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:15:07.263937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.616393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T03:15:07.263964Z","caller":"traceutil/trace.go:171","msg":"trace[158026632] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:976; }","duration":"161.673723ms","start":"2026-02-11T03:15:07.102279Z","end":"2026-02-11T03:15:07.263953Z","steps":["trace[158026632] 'agreement among raft nodes before linearized reading' (duration: 161.607752ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:15:07.264149Z","caller":"traceutil/trace.go:171","msg":"trace[894766404] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"493.20247ms","start":"2026-02-11T03:15:06.770935Z","end":"2026-02-11T03:15:07.264137Z","steps":["trace[894766404] 'process raft request' (duration: 242.554691ms)","trace[894766404] 'compare' (duration: 249.914706ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:15:07.264205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:15:06.770928Z","time spent":"493.251971ms","remote":"127.0.0.1:37046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":705,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-11T03:15:07.264412Z","caller":"traceutil/trace.go:171","msg":"trace[1190892981] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"493.406014ms","start":"2026-02-11T03:15:06.770995Z","end":"2026-02-11T03:15:07.264401Z","steps":["trace[1190892981] 'process raft request' (duration: 492.761923ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:15:07.264476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:15:06.77099Z","time spent":"493.452115ms","remote":"127.0.0.1:37220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T03:15:07.771017Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16995349463404995788,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-11T03:15:08.226108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.941913ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-02-11T03:15:08.227448Z","caller":"traceutil/trace.go:171","msg":"trace[1682105216] linearizableReadLoop","detail":"{readStateIndex:1020; appliedIndex:1018; }","duration":"956.692397ms","start":"2026-02-11T03:15:07.270718Z","end":"2026-02-11T03:15:08.227411Z","steps":["trace[1682105216] 'read index received' (duration: 610.509591ms)","trace[1682105216] 'applied index is now lower than readState.Index' (duration: 346.181126ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T03:15:08.227688Z","caller":"traceutil/trace.go:171","msg":"trace[940985838] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"986.435634ms","start":"2026-02-11T03:15:07.241231Z","end":"2026-02-11T03:15:08.227667Z","steps":["trace[940985838] 'process raft request' (duration: 985.010479ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:15:08.227914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:15:07.241214Z","time spent":"986.516165ms","remote":"127.0.0.1:37220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T03:15:08.230005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"959.275522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T03:15:08.230219Z","caller":"traceutil/trace.go:171","msg":"trace[1888775006] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:977; }","duration":"959.505197ms","start":"2026-02-11T03:15:07.270692Z","end":"2026-02-11T03:15:08.230198Z","steps":["trace[1888775006] 'agreement among raft nodes before linearized reading' (duration: 959.257642ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:15:08.230567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:15:07.270681Z","time spent":"959.871123ms","remote":"127.0.0.1:36980","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-11T03:15:08.230972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.156156ms","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-11T03:15:08.231052Z","caller":"traceutil/trace.go:171","msg":"trace[1478530049] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:977; }","duration":"721.271529ms","start":"2026-02-11T03:15:07.509767Z","end":"2026-02-11T03:15:08.231039Z","steps":["trace[1478530049] 'agreement among raft nodes before linearized reading' (duration: 721.101716ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:15:08.233112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:15:07.509753Z","time spent":"723.314984ms","remote":"127.0.0.1:37220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-11T03:15:08.231448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.295592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T03:15:08.233391Z","caller":"traceutil/trace.go:171","msg":"trace[740611014] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:977; }","duration":"586.273087ms","start":"2026-02-11T03:15:07.647109Z","end":"2026-02-11T03:15:08.233382Z","steps":["trace[740611014] 'agreement among raft nodes before linearized reading' (duration: 584.319512ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:15:08.23369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:15:07.647078Z","time spent":"586.580533ms","remote":"127.0.0.1:37110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":27,"request content":"key:\"/registry/persistentvolumes/test-pv\" "} {"level":"warn","ts":"2026-02-11T03:15:08.461057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.840214ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T03:15:08.461836Z","caller":"traceutil/trace.go:171","msg":"trace[1745337465] linearizableReadLoop","detail":"{readStateIndex:1022; appliedIndex:1021; }","duration":"217.214483ms","start":"2026-02-11T03:15:08.244597Z","end":"2026-02-11T03:15:08.461811Z","steps":["trace[1745337465] 'read index received' (duration: 77.055727ms)","trace[1745337465] 'applied index is now lower than readState.Index' (duration: 140.156906ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:15:08.462115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.495748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T03:15:08.462153Z","caller":"traceutil/trace.go:171","msg":"trace[19167445] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:979; }","duration":"217.60843ms","start":"2026-02-11T03:15:08.244529Z","end":"2026-02-11T03:15:08.462138Z","steps":["trace[19167445] 'agreement among raft nodes before linearized reading' (duration: 217.530529ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:15:08.461715Z","caller":"traceutil/trace.go:171","msg":"trace[1881050388] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"217.394846ms","start":"2026-02-11T03:15:08.244288Z","end":"2026-02-11T03:15:08.461683Z","steps":["trace[1881050388] 'process raft request' (duration: 102.607645ms)","trace[1881050388] 'compare' (duration: 113.667281ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:15:08.463068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.132859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T03:15:08.4631Z","caller":"traceutil/trace.go:171","msg":"trace[582865129] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:979; }","duration":"218.17763ms","start":"2026-02-11T03:15:08.244914Z","end":"2026-02-11T03:15:08.463092Z","steps":["trace[582865129] 'agreement among raft nodes before linearized reading' (duration: 218.125379ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:15:08.671696Z","caller":"traceutil/trace.go:171","msg":"trace[1577138232] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"176.459956ms","start":"2026-02-11T03:15:08.495208Z","end":"2026-02-11T03:15:08.671668Z","steps":["trace[1577138232] 'process raft request' (duration: 110.087378ms)","trace[1577138232] 'compare' (duration: 66.168994ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:15:09.84992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.034491353s","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-11T03:15:09.850354Z","caller":"traceutil/trace.go:171","msg":"trace[1923274105] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:980; }","duration":"1.034997592s","start":"2026-02-11T03:15:08.815285Z","end":"2026-02-11T03:15:09.850282Z","steps":["trace[1923274105] 'range keys from in-memory index tree' (duration: 1.034232399s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:15:09.850552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:15:08.815255Z","time spent":"1.035275096s","remote":"127.0.0.1:37220","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-11T03:15:09.853248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.60698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-02-11T03:15:09.853457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.750101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T03:15:09.853555Z","caller":"traceutil/trace.go:171","msg":"trace[1459759861] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:980; }","duration":"467.899853ms","start":"2026-02-11T03:15:09.385603Z","end":"2026-02-11T03:15:09.853502Z","steps":["trace[1459759861] 'range keys from in-memory index tree' (duration: 467.638788ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:15:09.853654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:15:09.385571Z","time spent":"468.031845ms","remote":"127.0.0.1:36986","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-11T03:15:09.853458Z","caller":"traceutil/trace.go:171","msg":"trace[470344578] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:980; }","duration":"578.859394ms","start":"2026-02-11T03:15:09.274576Z","end":"2026-02-11T03:15:09.853435Z","steps":["trace[470344578] 'range keys from in-memory index tree' (duration: 577.384718ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:15:09.85419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T03:15:09.274549Z","time spent":"579.620927ms","remote":"127.0.0.1:37220","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":"info","ts":"2026-02-11T03:15:09.975697Z","caller":"traceutil/trace.go:171","msg":"trace[602940393] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"115.49595ms","start":"2026-02-11T03:15:09.86017Z","end":"2026-02-11T03:15:09.975666Z","steps":["trace[602940393] 'process raft request' (duration: 115.306786ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T03:15:10.016196Z","caller":"traceutil/trace.go:171","msg":"trace[1146229373] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"155.427627ms","start":"2026-02-11T03:15:09.860743Z","end":"2026-02-11T03:15:10.016171Z","steps":["trace[1146229373] 'process raft request' (duration: 155.304814ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:15:34.377922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.868208ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T03:15:34.378224Z","caller":"traceutil/trace.go:171","msg":"trace[8308961] linearizableReadLoop","detail":"{readStateIndex:1102; appliedIndex:1101; }","duration":"199.118155ms","start":"2026-02-11T03:15:34.179084Z","end":"2026-02-11T03:15:34.378202Z","steps":["trace[8308961] 'read index received' (duration: 53.904682ms)","trace[8308961] 'applied index is now lower than readState.Index' (duration: 145.211953ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T03:15:34.378602Z","caller":"traceutil/trace.go:171","msg":"trace[137683813] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"234.774309ms","start":"2026-02-11T03:15:34.143799Z","end":"2026-02-11T03:15:34.378574Z","steps":["trace[137683813] 'process raft request' (duration: 89.143729ms)","trace[137683813] 'compare' (duration: 144.719576ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T03:15:34.378966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.869766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/kubeadm-config\" ","response":"range_response_count:1 size:999"} {"level":"info","ts":"2026-02-11T03:15:34.379126Z","caller":"traceutil/trace.go:171","msg":"trace[1409960232] range","detail":"{range_begin:/registry/configmaps/kube-system/kubeadm-config; range_end:; response_count:1; response_revision:1054; }","duration":"200.06217ms","start":"2026-02-11T03:15:34.179049Z","end":"2026-02-11T03:15:34.379111Z","steps":["trace[1409960232] 'agreement among raft nodes before linearized reading' (duration: 199.845036ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:15:34.379952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.105061ms","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-11T03:15:34.380055Z","caller":"traceutil/trace.go:171","msg":"trace[1073615167] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1054; }","duration":"183.238223ms","start":"2026-02-11T03:15:34.196805Z","end":"2026-02-11T03:15:34.380043Z","steps":["trace[1073615167] 'agreement among raft nodes before linearized reading' (duration: 182.679274ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:15:34.380637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.077037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/kube-root-ca.crt\" ","response":"range_response_count:1 size:1746"} {"level":"info","ts":"2026-02-11T03:15:34.380726Z","caller":"traceutil/trace.go:171","msg":"trace[1054082686] range","detail":"{range_begin:/registry/configmaps/kube-system/kube-root-ca.crt; range_end:; response_count:1; response_revision:1054; }","duration":"127.174128ms","start":"2026-02-11T03:15:34.253541Z","end":"2026-02-11T03:15:34.380715Z","steps":["trace[1054082686] 'agreement among raft nodes before linearized reading' (duration: 127.029016ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T03:15:34.380983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.301381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/kube-system/\" range_end:\"/registry/persistentvolumeclaims/kube-system0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T03:15:34.381061Z","caller":"traceutil/trace.go:171","msg":"trace[409499072] range","detail":"{range_begin:/registry/persistentvolumeclaims/kube-system/; range_end:/registry/persistentvolumeclaims/kube-system0; response_count:0; response_revision:1054; }","duration":"129.417363ms","start":"2026-02-11T03:15:34.251631Z","end":"2026-02-11T03:15:34.381048Z","steps":["trace[409499072] 'agreement among raft nodes before linearized reading' (duration: 129.317272ms)"],"step_count":1}