{"level":"warn","ts":"2026-04-02T16:37:41.832585Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-02T16:37:41.83274Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.244:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.244:2380","--initial-cluster=instance=https://199.204.45.244:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.244:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.244: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-04-02T16:37:41.832841Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-02T16:37:41.832902Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.244:2380"]} {"level":"info","ts":"2026-04-02T16:37:41.832946Z","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-04-02T16:37:41.8338Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"]} {"level":"info","ts":"2026-04-02T16:37:41.834427Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.244:2380"],"listen-peer-urls":["https://199.204.45.244:2380"],"advertise-client-urls":["https://199.204.45.244:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.244: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-04-02T16:37:41.839478Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.660789ms"} {"level":"info","ts":"2026-04-02T16:37:41.846734Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1686e9b1ea717edf","cluster-id":"71c60fe001ca5b3c"} {"level":"info","ts":"2026-04-02T16:37:41.846861Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=()"} {"level":"info","ts":"2026-04-02T16:37:41.846904Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became follower at term 0"} {"level":"info","ts":"2026-04-02T16:37:41.846942Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1686e9b1ea717edf [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-02T16:37:41.846975Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became follower at term 1"} {"level":"info","ts":"2026-04-02T16:37:41.847058Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=(1623241666065432287)"} {"level":"warn","ts":"2026-04-02T16:37:41.853862Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-02T16:37:41.855249Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-02T16:37:41.856295Z","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-04-02T16:37:41.858287Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1686e9b1ea717edf","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-02T16:37:41.858653Z","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-04-02T16:37:41.858749Z","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-04-02T16:37:41.860045Z","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-04-02T16:37:41.85918Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1686e9b1ea717edf","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-02T16:37:41.869395Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=(1623241666065432287)"} {"level":"info","ts":"2026-04-02T16:37:41.869614Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"71c60fe001ca5b3c","local-member-id":"1686e9b1ea717edf","added-peer-id":"1686e9b1ea717edf","added-peer-peer-urls":["https://199.204.45.244:2380"]} {"level":"info","ts":"2026-04-02T16:37:41.869773Z","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-04-02T16:37:41.869929Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1686e9b1ea717edf","initial-advertise-peer-urls":["https://199.204.45.244:2380"],"listen-peer-urls":["https://199.204.45.244:2380"],"advertise-client-urls":["https://199.204.45.244:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-02T16:37:41.86996Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-02T16:37:41.870023Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.244:2380"} {"level":"info","ts":"2026-04-02T16:37:41.870087Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.244:2380"} {"level":"info","ts":"2026-04-02T16:37:42.74793Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf is starting a new election at term 1"} {"level":"info","ts":"2026-04-02T16:37:42.747988Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became pre-candidate at term 1"} {"level":"info","ts":"2026-04-02T16:37:42.748041Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf received MsgPreVoteResp from 1686e9b1ea717edf at term 1"} {"level":"info","ts":"2026-04-02T16:37:42.748061Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became candidate at term 2"} {"level":"info","ts":"2026-04-02T16:37:42.748079Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf received MsgVoteResp from 1686e9b1ea717edf at term 2"} {"level":"info","ts":"2026-04-02T16:37:42.748095Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became leader at term 2"} {"level":"info","ts":"2026-04-02T16:37:42.748118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1686e9b1ea717edf elected leader 1686e9b1ea717edf at term 2"} {"level":"info","ts":"2026-04-02T16:37:42.749455Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1686e9b1ea717edf","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.244:2379]}","request-path":"/0/members/1686e9b1ea717edf/attributes","cluster-id":"71c60fe001ca5b3c","publish-timeout":"7s"} {"level":"info","ts":"2026-04-02T16:37:42.749628Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-02T16:37:42.749698Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-02T16:37:42.749768Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T16:37:42.752852Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.244:2379"} {"level":"info","ts":"2026-04-02T16:37:42.75305Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"71c60fe001ca5b3c","local-member-id":"1686e9b1ea717edf","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T16:37:42.753125Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T16:37:42.753163Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T16:37:42.756065Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-02T16:37:42.756252Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-02T16:37:42.756082Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-02T16:37:47.052676Z","caller":"traceutil/trace.go:171","msg":"trace[496720964] transaction","detail":"{read_only:false; response_revision:250; number_of_response:1; }","duration":"505.601261ms","start":"2026-04-02T16:37:46.547048Z","end":"2026-04-02T16:37:47.052649Z","steps":["trace[496720964] 'process raft request' (duration: 505.404899ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:37:47.053245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:37:46.547027Z","time spent":"505.747712ms","remote":"127.0.0.1:47332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3695,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T16:37:47.690765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.666634ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-02T16:37:47.690865Z","caller":"traceutil/trace.go:171","msg":"trace[1251781957] linearizableReadLoop","detail":"{readStateIndex:256; appliedIndex:255; }","duration":"374.943145ms","start":"2026-04-02T16:37:47.315908Z","end":"2026-04-02T16:37:47.690851Z","steps":["trace[1251781957] 'read index received' (duration: 55.531µs)","trace[1251781957] 'applied index is now lower than readState.Index' (duration: 374.886654ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:37:47.690876Z","caller":"traceutil/trace.go:171","msg":"trace[597542184] transaction","detail":"{read_only:false; response_revision:251; number_of_response:1; }","duration":"631.172767ms","start":"2026-04-02T16:37:47.059685Z","end":"2026-04-02T16:37:47.690858Z","steps":["trace[597542184] 'process raft request' (duration: 62.24789ms)","trace[597542184] 'compare' (duration: 568.540593ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T16:37:47.690934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.028686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T16:37:47.690959Z","caller":"traceutil/trace.go:171","msg":"trace[510760126] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:251; }","duration":"375.087776ms","start":"2026-04-02T16:37:47.315863Z","end":"2026-04-02T16:37:47.690951Z","steps":["trace[510760126] 'agreement among raft nodes before linearized reading' (duration: 375.020345ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:37:47.69096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:37:47.059666Z","time spent":"631.265658ms","remote":"127.0.0.1:47234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":525,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T16:37:47.690983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:37:47.315792Z","time spent":"375.184877ms","remote":"127.0.0.1:47292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" "} {"level":"info","ts":"2026-04-02T16:37:47.804987Z","caller":"traceutil/trace.go:171","msg":"trace[936003784] linearizableReadLoop","detail":"{readStateIndex:257; appliedIndex:256; }","duration":"110.968275ms","start":"2026-04-02T16:37:47.693994Z","end":"2026-04-02T16:37:47.804962Z","steps":["trace[936003784] 'read index received' (duration: 110.210948ms)","trace[936003784] 'applied index is now lower than readState.Index' (duration: 756.337µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:37:47.805087Z","caller":"traceutil/trace.go:171","msg":"trace[1825134825] transaction","detail":"{read_only:false; response_revision:252; number_of_response:1; }","duration":"112.150067ms","start":"2026-04-02T16:37:47.692907Z","end":"2026-04-02T16:37:47.805057Z","steps":["trace[1825134825] 'process raft request' (duration: 111.305449ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:37:47.80513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.111427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-v6oz8k\" ","response":"range_response_count:1 size:540"} {"level":"info","ts":"2026-04-02T16:37:47.805305Z","caller":"traceutil/trace.go:171","msg":"trace[1169802711] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-v6oz8k; range_end:; response_count:1; response_revision:252; }","duration":"111.313319ms","start":"2026-04-02T16:37:47.693978Z","end":"2026-04-02T16:37:47.805291Z","steps":["trace[1169802711] 'agreement among raft nodes before linearized reading' (duration: 111.072376ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:38:11.864494Z","caller":"traceutil/trace.go:171","msg":"trace[198114202] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"642.719528ms","start":"2026-04-02T16:38:11.221749Z","end":"2026-04-02T16:38:11.864468Z","steps":["trace[198114202] 'process raft request' (duration: 642.570153ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:11.86489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:38:11.221724Z","time spent":"642.852473ms","remote":"127.0.0.1:47194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T16:38:12.370556Z","caller":"traceutil/trace.go:171","msg":"trace[673619451] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"1.141655543s","start":"2026-04-02T16:38:11.228879Z","end":"2026-04-02T16:38:12.370535Z","steps":["trace[673619451] 'process raft request' (duration: 1.141459896s)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:38:12.370828Z","caller":"traceutil/trace.go:171","msg":"trace[51425195] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"1.132951536s","start":"2026-04-02T16:38:11.23786Z","end":"2026-04-02T16:38:12.370811Z","steps":["trace[51425195] 'process raft request' (duration: 1.132551562s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:12.370921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:38:11.23785Z","time spent":"1.133027999s","remote":"127.0.0.1:47194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T16:38:12.371045Z","caller":"traceutil/trace.go:171","msg":"trace[1484953695] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"1.136450683s","start":"2026-04-02T16:38:11.234587Z","end":"2026-04-02T16:38:12.371038Z","steps":["trace[1484953695] 'process raft request' (duration: 1.135787979s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:12.37108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:38:11.234576Z","time spent":"1.136488395s","remote":"127.0.0.1:47194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T16:38:12.370986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:38:11.228873Z","time spent":"1.14186453s","remote":"127.0.0.1:47194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T16:38:12.371307Z","caller":"traceutil/trace.go:171","msg":"trace[255073917] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"1.129007103s","start":"2026-04-02T16:38:11.242293Z","end":"2026-04-02T16:38:12.3713Z","steps":["trace[255073917] 'process raft request' (duration: 1.128313338s)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:38:12.371268Z","caller":"traceutil/trace.go:171","msg":"trace[84481049] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"1.141732256s","start":"2026-04-02T16:38:11.228707Z","end":"2026-04-02T16:38:12.370439Z","steps":["trace[84481049] 'process raft request' (duration: 1.141514648s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:12.372189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:38:11.228684Z","time spent":"1.143477329s","remote":"127.0.0.1:47194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T16:38:12.372303Z","caller":"traceutil/trace.go:171","msg":"trace[580283112] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"1.106541795s","start":"2026-04-02T16:38:11.265707Z","end":"2026-04-02T16:38:12.372248Z","steps":["trace[580283112] 'process raft request' (duration: 1.105204977s)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:38:12.37263Z","caller":"traceutil/trace.go:171","msg":"trace[1389145713] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"1.132405836s","start":"2026-04-02T16:38:11.240209Z","end":"2026-04-02T16:38:12.372615Z","steps":["trace[1389145713] 'process raft request' (duration: 1.13029707s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:12.372683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:38:11.265688Z","time spent":"1.106703441s","remote":"127.0.0.1:47194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T16:38:12.372703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:38:11.2402Z","time spent":"1.132466858s","remote":"127.0.0.1:47194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T16:38:12.373185Z","caller":"traceutil/trace.go:171","msg":"trace[1849347609] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"1.128706591s","start":"2026-04-02T16:38:11.244355Z","end":"2026-04-02T16:38:12.373062Z","steps":["trace[1849347609] 'process raft request' (duration: 1.126333256s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:12.373308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:38:11.244347Z","time spent":"1.128858996s","remote":"127.0.0.1:47194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T16:38:12.373673Z","caller":"traceutil/trace.go:171","msg":"trace[1053087018] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"1.132154206s","start":"2026-04-02T16:38:11.241488Z","end":"2026-04-02T16:38:12.373642Z","steps":["trace[1053087018] 'process raft request' (duration: 1.129069715s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:12.373754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:38:11.241479Z","time spent":"1.13223589s","remote":"127.0.0.1:47194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T16:38:12.374197Z","caller":"traceutil/trace.go:171","msg":"trace[1497215427] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"1.098235962s","start":"2026-04-02T16:38:11.275718Z","end":"2026-04-02T16:38:12.373954Z","steps":["trace[1497215427] 'process raft request' (duration: 1.095343578s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:12.374257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:38:11.275707Z","time spent":"1.098518402s","remote":"127.0.0.1:47194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T16:38:12.38165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:38:11.242231Z","time spent":"1.129099826s","remote":"127.0.0.1:47194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T16:38:12.385701Z","caller":"traceutil/trace.go:171","msg":"trace[1590932279] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"997.844535ms","start":"2026-04-02T16:38:11.387839Z","end":"2026-04-02T16:38:12.385683Z","steps":["trace[1590932279] 'process raft request' (duration: 983.478507ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:12.385768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:38:11.387804Z","time spent":"997.922857ms","remote":"127.0.0.1:47194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T16:38:12.533822Z","caller":"traceutil/trace.go:171","msg":"trace[2078564619] linearizableReadLoop","detail":"{readStateIndex:542; appliedIndex:528; }","duration":"448.447258ms","start":"2026-04-02T16:38:12.085148Z","end":"2026-04-02T16:38:12.533595Z","steps":["trace[2078564619] 'read index received' (duration: 285.103866ms)","trace[2078564619] 'applied index is now lower than readState.Index' (duration: 163.342552ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:38:12.533925Z","caller":"traceutil/trace.go:171","msg":"trace[871568145] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"661.377964ms","start":"2026-04-02T16:38:11.87254Z","end":"2026-04-02T16:38:12.533918Z","steps":["trace[871568145] 'process raft request' (duration: 660.9784ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:38:12.533949Z","caller":"traceutil/trace.go:171","msg":"trace[19635434] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"662.655801ms","start":"2026-04-02T16:38:11.871256Z","end":"2026-04-02T16:38:12.533912Z","steps":["trace[19635434] 'process raft request' (duration: 649.213027ms)","trace[19635434] 'compare' (duration: 12.925955ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T16:38:12.53403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:38:11.872495Z","time spent":"661.454467ms","remote":"127.0.0.1:47194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7317,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T16:38:12.534086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:38:11.871191Z","time spent":"662.828357ms","remote":"127.0.0.1:60924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T16:38:12.53408Z","caller":"traceutil/trace.go:171","msg":"trace[1407816308] transaction","detail":"{read_only:false; number_of_response:1; response_revision:524; }","duration":"661.337903ms","start":"2026-04-02T16:38:11.872717Z","end":"2026-04-02T16:38:12.534055Z","steps":["trace[1407816308] 'process raft request' (duration: 660.846516ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:12.5342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:38:11.872689Z","time spent":"661.446437ms","remote":"127.0.0.1:47194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7365,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T16:38:12.534312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.167433ms","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-04-02T16:38:12.534344Z","caller":"traceutil/trace.go:171","msg":"trace[1100266971] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:524; }","duration":"449.229985ms","start":"2026-04-02T16:38:12.085106Z","end":"2026-04-02T16:38:12.534336Z","steps":["trace[1100266971] 'agreement among raft nodes before linearized reading' (duration: 449.124792ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:12.534368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:38:12.085061Z","time spent":"449.301558ms","remote":"127.0.0.1:47414","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-04-02T16:38:12.536976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.009042ms","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-04-02T16:38:12.537033Z","caller":"traceutil/trace.go:171","msg":"trace[1712155567] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:533; }","duration":"185.127956ms","start":"2026-04-02T16:38:12.351893Z","end":"2026-04-02T16:38:12.537021Z","steps":["trace[1712155567] 'agreement among raft nodes before linearized reading' (duration: 184.987471ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:38:12.537013Z","caller":"traceutil/trace.go:171","msg":"trace[1917923078] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"151.167093ms","start":"2026-04-02T16:38:12.385839Z","end":"2026-04-02T16:38:12.537006Z","steps":["trace[1917923078] 'process raft request' (duration: 150.574442ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:38:12.537179Z","caller":"traceutil/trace.go:171","msg":"trace[1426533753] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"151.09111ms","start":"2026-04-02T16:38:12.386077Z","end":"2026-04-02T16:38:12.537168Z","steps":["trace[1426533753] 'process raft request' (duration: 150.395505ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:38:12.537267Z","caller":"traceutil/trace.go:171","msg":"trace[1859985632] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"151.314988ms","start":"2026-04-02T16:38:12.38594Z","end":"2026-04-02T16:38:12.537255Z","steps":["trace[1859985632] 'process raft request' (duration: 150.503419ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:38:12.53745Z","caller":"traceutil/trace.go:171","msg":"trace[1759082040] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"149.822494ms","start":"2026-04-02T16:38:12.387617Z","end":"2026-04-02T16:38:12.537439Z","steps":["trace[1759082040] 'process raft request' (duration: 148.903091ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:38:12.537544Z","caller":"traceutil/trace.go:171","msg":"trace[709101908] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"149.230384ms","start":"2026-04-02T16:38:12.388306Z","end":"2026-04-02T16:38:12.537536Z","steps":["trace[709101908] 'process raft request' (duration: 148.269199ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:38:12.537669Z","caller":"traceutil/trace.go:171","msg":"trace[979740757] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"142.532012ms","start":"2026-04-02T16:38:12.395128Z","end":"2026-04-02T16:38:12.53766Z","steps":["trace[979740757] 'process raft request' (duration: 141.490214ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:38:12.537874Z","caller":"traceutil/trace.go:171","msg":"trace[803807241] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"134.036926ms","start":"2026-04-02T16:38:12.403826Z","end":"2026-04-02T16:38:12.537863Z","steps":["trace[803807241] 'process raft request' (duration: 132.947727ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:38:12.538046Z","caller":"traceutil/trace.go:171","msg":"trace[275762888] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"103.907272ms","start":"2026-04-02T16:38:12.434129Z","end":"2026-04-02T16:38:12.538036Z","steps":["trace[275762888] 'process raft request' (duration: 102.715509ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:12.538219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.147908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-02T16:38:12.538255Z","caller":"traceutil/trace.go:171","msg":"trace[1980468206] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:533; }","duration":"137.216711ms","start":"2026-04-02T16:38:12.401029Z","end":"2026-04-02T16:38:12.538246Z","steps":["trace[1980468206] 'agreement among raft nodes before linearized reading' (duration: 137.149059ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:12.538461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.014874ms","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-04-02T16:38:12.538536Z","caller":"traceutil/trace.go:171","msg":"trace[107430179] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:533; }","duration":"182.147079ms","start":"2026-04-02T16:38:12.35635Z","end":"2026-04-02T16:38:12.538497Z","steps":["trace[107430179] 'agreement among raft nodes before linearized reading' (duration: 182.021655ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:38:12.536962Z","caller":"traceutil/trace.go:171","msg":"trace[679928881] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"152.010434ms","start":"2026-04-02T16:38:12.384928Z","end":"2026-04-02T16:38:12.536939Z","steps":["trace[679928881] 'process raft request' (duration: 151.365791ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:18.952404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.794331ms","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-04-02T16:38:18.952502Z","caller":"traceutil/trace.go:171","msg":"trace[1309427098] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:618; }","duration":"324.908175ms","start":"2026-04-02T16:38:18.627572Z","end":"2026-04-02T16:38:18.95248Z","steps":["trace[1309427098] 'range keys from in-memory index tree' (duration: 324.555363ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:18.952547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:38:18.627397Z","time spent":"325.141113ms","remote":"127.0.0.1:47414","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-04-02T16:38:18.952684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.36581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-02T16:38:18.952431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.949106ms","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-04-02T16:38:18.952775Z","caller":"traceutil/trace.go:171","msg":"trace[775666206] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:618; }","duration":"325.496895ms","start":"2026-04-02T16:38:18.627257Z","end":"2026-04-02T16:38:18.952754Z","steps":["trace[775666206] 'range keys from in-memory index tree' (duration: 324.937216ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:18.952821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:38:18.627244Z","time spent":"325.567268ms","remote":"127.0.0.1:47414","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":"info","ts":"2026-04-02T16:38:18.952832Z","caller":"traceutil/trace.go:171","msg":"trace[1658580346] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:618; }","duration":"325.358811ms","start":"2026-04-02T16:38:18.627413Z","end":"2026-04-02T16:38:18.952772Z","steps":["trace[1658580346] 'range keys from in-memory index tree' (duration: 324.74512ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:18.95287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.472954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-02T16:38:18.95291Z","caller":"traceutil/trace.go:171","msg":"trace[1029843068] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:618; }","duration":"325.550787ms","start":"2026-04-02T16:38:18.627345Z","end":"2026-04-02T16:38:18.952896Z","steps":["trace[1029843068] 'range keys from in-memory index tree' (duration: 324.810682ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:18.952925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:38:18.627393Z","time spent":"325.501715ms","remote":"127.0.0.1:47414","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-04-02T16:38:18.952938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:38:18.627298Z","time spent":"325.63417ms","remote":"127.0.0.1:47414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-02T16:38:19.031214Z","caller":"traceutil/trace.go:171","msg":"trace[251551352] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:638; }","duration":"189.304737ms","start":"2026-04-02T16:38:18.841893Z","end":"2026-04-02T16:38:19.031197Z","steps":["trace[251551352] 'read index received' (duration: 188.578073ms)","trace[251551352] 'applied index is now lower than readState.Index' (duration: 725.634µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:38:19.031336Z","caller":"traceutil/trace.go:171","msg":"trace[837295469] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"215.054389ms","start":"2026-04-02T16:38:18.816251Z","end":"2026-04-02T16:38:19.031305Z","steps":["trace[837295469] 'process raft request' (duration: 214.417788ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:19.031606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.68562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-mcfk2\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-02T16:38:19.031693Z","caller":"traceutil/trace.go:171","msg":"trace[1017162387] range","detail":"{range_begin:/registry/pods/kube-system/cilium-mcfk2; range_end:; response_count:1; response_revision:619; }","duration":"189.812264ms","start":"2026-04-02T16:38:18.841851Z","end":"2026-04-02T16:38:19.031664Z","steps":["trace[1017162387] 'agreement among raft nodes before linearized reading' (duration: 189.427641ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:38:19.186518Z","caller":"traceutil/trace.go:171","msg":"trace[78042169] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"230.007602ms","start":"2026-04-02T16:38:18.956485Z","end":"2026-04-02T16:38:19.186493Z","steps":["trace[78042169] 'process raft request' (duration: 223.98336ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:38:19.186569Z","caller":"traceutil/trace.go:171","msg":"trace[1062470991] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:639; }","duration":"155.291042ms","start":"2026-04-02T16:38:19.031257Z","end":"2026-04-02T16:38:19.186548Z","steps":["trace[1062470991] 'read index received' (duration: 149.145357ms)","trace[1062470991] 'applied index is now lower than readState.Index' (duration: 6.144725ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:38:19.186597Z","caller":"traceutil/trace.go:171","msg":"trace[1372729762] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"229.601778ms","start":"2026-04-02T16:38:18.956965Z","end":"2026-04-02T16:38:19.186567Z","steps":["trace[1372729762] 'process raft request' (duration: 229.505505ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:38:19.186649Z","caller":"traceutil/trace.go:171","msg":"trace[52607748] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"229.747183ms","start":"2026-04-02T16:38:18.956895Z","end":"2026-04-02T16:38:19.186642Z","steps":["trace[52607748] 'process raft request' (duration: 229.491094ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:38:19.186786Z","caller":"traceutil/trace.go:171","msg":"trace[387548716] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"229.699031ms","start":"2026-04-02T16:38:18.957009Z","end":"2026-04-02T16:38:19.186708Z","steps":["trace[387548716] 'process raft request' (duration: 229.496094ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:19.186679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.059822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T16:38:19.186973Z","caller":"traceutil/trace.go:171","msg":"trace[1647118993] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:623; }","duration":"300.347251ms","start":"2026-04-02T16:38:18.88656Z","end":"2026-04-02T16:38:19.186907Z","steps":["trace[1647118993] 'agreement among raft nodes before linearized reading' (duration: 300.073692ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:19.187559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:38:18.886545Z","time spent":"300.525498ms","remote":"127.0.0.1:47146","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-04-02T16:38:19.607536Z","caller":"traceutil/trace.go:171","msg":"trace[975312918] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"524.905354ms","start":"2026-04-02T16:38:19.082606Z","end":"2026-04-02T16:38:19.607511Z","steps":["trace[975312918] 'process raft request' (duration: 524.856953ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:38:19.607563Z","caller":"traceutil/trace.go:171","msg":"trace[208301863] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"561.616033ms","start":"2026-04-02T16:38:19.045924Z","end":"2026-04-02T16:38:19.60754Z","steps":["trace[208301863] 'process raft request' (duration: 561.370575ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:19.607805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:38:19.08258Z","time spent":"525.042929ms","remote":"127.0.0.1:47382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T16:38:19.607926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:38:19.045902Z","time spent":"561.927424ms","remote":"127.0.0.1:47342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T16:38:19.638883Z","caller":"traceutil/trace.go:171","msg":"trace[415254221] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"140.675372ms","start":"2026-04-02T16:38:19.498177Z","end":"2026-04-02T16:38:19.638853Z","steps":["trace[415254221] 'process raft request' (duration: 140.473615ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:38:19.784692Z","caller":"traceutil/trace.go:171","msg":"trace[911830462] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"129.001881ms","start":"2026-04-02T16:38:19.655643Z","end":"2026-04-02T16:38:19.784645Z","steps":["trace[911830462] 'process raft request' (duration: 117.423603ms)","trace[911830462] 'compare' (duration: 11.455244ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:38:20.316852Z","caller":"traceutil/trace.go:171","msg":"trace[224304262] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"620.804571ms","start":"2026-04-02T16:38:19.696017Z","end":"2026-04-02T16:38:20.316821Z","steps":["trace[224304262] 'process raft request' (duration: 620.605654ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:20.317081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:38:19.695985Z","time spent":"620.966956ms","remote":"127.0.0.1:47332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4539,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T16:38:20.672028Z","caller":"traceutil/trace.go:171","msg":"trace[1649875816] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:647; }","duration":"786.930596ms","start":"2026-04-02T16:38:19.88508Z","end":"2026-04-02T16:38:20.67201Z","steps":["trace[1649875816] 'read index received' (duration: 431.667555ms)","trace[1649875816] 'applied index is now lower than readState.Index' (duration: 355.261701ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T16:38:20.672196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"787.108883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T16:38:20.672239Z","caller":"traceutil/trace.go:171","msg":"trace[314098390] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:632; }","duration":"787.195146ms","start":"2026-04-02T16:38:19.885035Z","end":"2026-04-02T16:38:20.67223Z","steps":["trace[314098390] 'agreement among raft nodes before linearized reading' (duration: 787.103332ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:20.672278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:38:19.885018Z","time spent":"787.253637ms","remote":"127.0.0.1:47156","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-04-02T16:38:20.672435Z","caller":"traceutil/trace.go:171","msg":"trace[1839696045] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"881.746353ms","start":"2026-04-02T16:38:19.79068Z","end":"2026-04-02T16:38:20.672427Z","steps":["trace[1839696045] 'process raft request' (duration: 881.279798ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:38:20.672448Z","caller":"traceutil/trace.go:171","msg":"trace[642345219] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"883.544413ms","start":"2026-04-02T16:38:19.788879Z","end":"2026-04-02T16:38:20.672423Z","steps":["trace[642345219] 'process raft request' (duration: 875.718743ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:20.67257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:38:19.790669Z","time spent":"881.827475ms","remote":"127.0.0.1:47382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T16:38:20.672591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:38:19.788855Z","time spent":"883.671157ms","remote":"127.0.0.1:47212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T16:38:20.672562Z","caller":"traceutil/trace.go:171","msg":"trace[642115582] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"883.066217ms","start":"2026-04-02T16:38:19.789471Z","end":"2026-04-02T16:38:20.672537Z","steps":["trace[642115582] 'process raft request' (duration: 882.439176ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:20.672763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:38:19.789463Z","time spent":"883.275344ms","remote":"127.0.0.1:47342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T16:38:20.672789Z","caller":"traceutil/trace.go:171","msg":"trace[1605167142] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"883.792922ms","start":"2026-04-02T16:38:19.788986Z","end":"2026-04-02T16:38:20.672779Z","steps":["trace[1605167142] 'process raft request' (duration: 882.855001ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:20.672844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:38:19.788976Z","time spent":"883.845183ms","remote":"127.0.0.1:47212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T16:38:22.184522Z","caller":"traceutil/trace.go:171","msg":"trace[1181470036] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"149.752687ms","start":"2026-04-02T16:38:22.034744Z","end":"2026-04-02T16:38:22.184496Z","steps":["trace[1181470036] 'process raft request' (duration: 146.338976ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:38:35.525596Z","caller":"traceutil/trace.go:171","msg":"trace[227289202] linearizableReadLoop","detail":"{readStateIndex:806; appliedIndex:805; }","duration":"275.062136ms","start":"2026-04-02T16:38:35.250507Z","end":"2026-04-02T16:38:35.525569Z","steps":["trace[227289202] 'read index received' (duration: 274.908001ms)","trace[227289202] 'applied index is now lower than readState.Index' (duration: 152.905µs)"],"step_count":2} {"level":"warn","ts":"2026-04-02T16:38:35.526157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.618261ms","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-04-02T16:38:35.526263Z","caller":"traceutil/trace.go:171","msg":"trace[1146094210] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:782; }","duration":"275.799617ms","start":"2026-04-02T16:38:35.250443Z","end":"2026-04-02T16:38:35.526243Z","steps":["trace[1146094210] 'agreement among raft nodes before linearized reading' (duration: 275.488688ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:38:35.526445Z","caller":"traceutil/trace.go:171","msg":"trace[1988415653] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"577.539423ms","start":"2026-04-02T16:38:34.948613Z","end":"2026-04-02T16:38:35.526152Z","steps":["trace[1988415653] 'process raft request' (duration: 576.797722ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:35.526917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:38:34.948601Z","time spent":"578.102429ms","remote":"127.0.0.1:47342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T16:38:35.531522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.105715ms","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-04-02T16:38:35.531594Z","caller":"traceutil/trace.go:171","msg":"trace[1237051293] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:783; }","duration":"277.181797ms","start":"2026-04-02T16:38:35.254394Z","end":"2026-04-02T16:38:35.531575Z","steps":["trace[1237051293] 'agreement among raft nodes before linearized reading' (duration: 276.966101ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:38:35.531809Z","caller":"traceutil/trace.go:171","msg":"trace[1647738399] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"273.564943ms","start":"2026-04-02T16:38:35.258179Z","end":"2026-04-02T16:38:35.531744Z","steps":["trace[1647738399] 'process raft request' (duration: 272.993017ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:35.531885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.66294ms","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-04-02T16:38:35.531931Z","caller":"traceutil/trace.go:171","msg":"trace[513200469] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:783; }","duration":"270.757762ms","start":"2026-04-02T16:38:35.26116Z","end":"2026-04-02T16:38:35.531917Z","steps":["trace[513200469] 'agreement among raft nodes before linearized reading' (duration: 270.639649ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:35.531956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.862645ms","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-04-02T16:38:35.532048Z","caller":"traceutil/trace.go:171","msg":"trace[1840301032] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:783; }","duration":"270.983289ms","start":"2026-04-02T16:38:35.261031Z","end":"2026-04-02T16:38:35.532015Z","steps":["trace[1840301032] 'agreement among raft nodes before linearized reading' (duration: 270.705431ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:38:49.710006Z","caller":"traceutil/trace.go:171","msg":"trace[1627763413] linearizableReadLoop","detail":"{readStateIndex:971; appliedIndex:970; }","duration":"107.051649ms","start":"2026-04-02T16:38:49.602933Z","end":"2026-04-02T16:38:49.709985Z","steps":["trace[1627763413] 'read index received' (duration: 106.882095ms)","trace[1627763413] 'applied index is now lower than readState.Index' (duration: 168.594µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:38:49.710094Z","caller":"traceutil/trace.go:171","msg":"trace[1239114395] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"311.622154ms","start":"2026-04-02T16:38:49.398432Z","end":"2026-04-02T16:38:49.710054Z","steps":["trace[1239114395] 'process raft request' (duration: 311.376068ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:49.710216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.269775ms","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-04-02T16:38:49.710239Z","caller":"traceutil/trace.go:171","msg":"trace[1669620031] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:943; }","duration":"107.348847ms","start":"2026-04-02T16:38:49.602883Z","end":"2026-04-02T16:38:49.710232Z","steps":["trace[1669620031] 'agreement among raft nodes before linearized reading' (duration: 107.241394ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:49.710272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:38:49.398414Z","time spent":"311.759878ms","remote":"127.0.0.1:47342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5472,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T16:38:49.710297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.097194ms","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-04-02T16:38:49.710357Z","caller":"traceutil/trace.go:171","msg":"trace[616176489] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:943; }","duration":"102.186965ms","start":"2026-04-02T16:38:49.608153Z","end":"2026-04-02T16:38:49.71034Z","steps":["trace[616176489] 'agreement among raft nodes before linearized reading' (duration: 102.007921ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:49.710468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.518208ms","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-04-02T16:38:49.710516Z","caller":"traceutil/trace.go:171","msg":"trace[1358891985] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:943; }","duration":"101.600511ms","start":"2026-04-02T16:38:49.608902Z","end":"2026-04-02T16:38:49.710503Z","steps":["trace[1358891985] 'agreement among raft nodes before linearized reading' (duration: 101.498808ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:38:49.844852Z","caller":"traceutil/trace.go:171","msg":"trace[1792203649] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"129.55481ms","start":"2026-04-02T16:38:49.715276Z","end":"2026-04-02T16:38:49.844831Z","steps":["trace[1792203649] 'process raft request' (duration: 36.609399ms)","trace[1792203649] 'compare' (duration: 92.835398ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:38:49.845085Z","caller":"traceutil/trace.go:171","msg":"trace[554633119] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"128.071942ms","start":"2026-04-02T16:38:49.717004Z","end":"2026-04-02T16:38:49.845076Z","steps":["trace[554633119] 'process raft request' (duration: 127.806695ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:38:49.845195Z","caller":"traceutil/trace.go:171","msg":"trace[2019309496] transaction","detail":"{read_only:false; response_revision:947; number_of_response:1; }","duration":"128.020141ms","start":"2026-04-02T16:38:49.717168Z","end":"2026-04-02T16:38:49.845188Z","steps":["trace[2019309496] 'process raft request' (duration: 127.891227ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:38:49.845169Z","caller":"traceutil/trace.go:171","msg":"trace[289474745] transaction","detail":"{read_only:false; response_revision:946; number_of_response:1; }","duration":"128.056702ms","start":"2026-04-02T16:38:49.717089Z","end":"2026-04-02T16:38:49.845145Z","steps":["trace[289474745] 'process raft request' (duration: 127.893268ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:38:49.84579Z","caller":"traceutil/trace.go:171","msg":"trace[858289301] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"128.072893ms","start":"2026-04-02T16:38:49.717701Z","end":"2026-04-02T16:38:49.845774Z","steps":["trace[858289301] 'process raft request' (duration: 127.394905ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:38:49.846156Z","caller":"traceutil/trace.go:171","msg":"trace[909908947] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"128.276898ms","start":"2026-04-02T16:38:49.717867Z","end":"2026-04-02T16:38:49.846144Z","steps":["trace[909908947] 'process raft request' (duration: 127.423616ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:38:49.846854Z","caller":"traceutil/trace.go:171","msg":"trace[2062934292] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"127.709113ms","start":"2026-04-02T16:38:49.719122Z","end":"2026-04-02T16:38:49.846832Z","steps":["trace[2062934292] 'process raft request' (duration: 126.286517ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:50.111591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.984676ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T16:38:50.111752Z","caller":"traceutil/trace.go:171","msg":"trace[607030111] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"254.961802ms","start":"2026-04-02T16:38:49.856746Z","end":"2026-04-02T16:38:50.111707Z","steps":["trace[607030111] 'process raft request' (duration: 91.767681ms)","trace[607030111] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/deployments/envoy-gateway-system/envoy-gateway; req_size:5623; } (duration: 162.711329ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:38:50.112067Z","caller":"traceutil/trace.go:171","msg":"trace[1100313874] linearizableReadLoop","detail":"{readStateIndex:979; appliedIndex:978; }","duration":"228.587882ms","start":"2026-04-02T16:38:49.883461Z","end":"2026-04-02T16:38:50.112049Z","steps":["trace[1100313874] 'read index received' (duration: 64.97317ms)","trace[1100313874] 'applied index is now lower than readState.Index' (duration: 163.613442ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T16:38:50.112195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.735686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T16:38:50.112231Z","caller":"traceutil/trace.go:171","msg":"trace[1551182153] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:952; }","duration":"228.804878ms","start":"2026-04-02T16:38:49.883412Z","end":"2026-04-02T16:38:50.112216Z","steps":["trace[1551182153] 'agreement among raft nodes before linearized reading' (duration: 228.750867ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:38:50.112286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.662486ms","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-04-02T16:38:50.112335Z","caller":"traceutil/trace.go:171","msg":"trace[39129957] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:952; }","duration":"106.755049ms","start":"2026-04-02T16:38:50.005566Z","end":"2026-04-02T16:38:50.112321Z","steps":["trace[39129957] 'agreement among raft nodes before linearized reading' (duration: 106.590095ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:40:26.565375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.74393ms","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-04-02T16:40:26.565475Z","caller":"traceutil/trace.go:171","msg":"trace[664004372] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1319; }","duration":"147.906473ms","start":"2026-04-02T16:40:26.417549Z","end":"2026-04-02T16:40:26.565455Z","steps":["trace[664004372] 'range keys from in-memory index tree' (duration: 147.517397ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:40:26.965753Z","caller":"traceutil/trace.go:171","msg":"trace[1278852724] linearizableReadLoop","detail":"{readStateIndex:1373; appliedIndex:1371; }","duration":"381.303318ms","start":"2026-04-02T16:40:26.584422Z","end":"2026-04-02T16:40:26.965725Z","steps":["trace[1278852724] 'read index received' (duration: 66.853976ms)","trace[1278852724] 'applied index is now lower than readState.Index' (duration: 314.448252ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:40:26.965861Z","caller":"traceutil/trace.go:171","msg":"trace[860542454] transaction","detail":"{read_only:false; response_revision:1321; number_of_response:1; }","duration":"395.290426ms","start":"2026-04-02T16:40:26.57056Z","end":"2026-04-02T16:40:26.965851Z","steps":["trace[860542454] 'process raft request' (duration: 392.531075ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:40:26.965962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:40:26.570531Z","time spent":"395.355087ms","remote":"127.0.0.1:47414","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-04-02T16:40:26.965999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.565472ms","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-04-02T16:40:26.966058Z","caller":"traceutil/trace.go:171","msg":"trace[1132385426] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1321; }","duration":"381.655383ms","start":"2026-04-02T16:40:26.584387Z","end":"2026-04-02T16:40:26.966042Z","steps":["trace[1132385426] 'agreement among raft nodes before linearized reading' (duration: 381.47426ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:40:26.966164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:40:26.584368Z","time spent":"381.785744ms","remote":"127.0.0.1:47414","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-04-02T16:40:27.034429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.825626ms","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-04-02T16:40:27.034482Z","caller":"traceutil/trace.go:171","msg":"trace[385837094] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1322; }","duration":"449.921597ms","start":"2026-04-02T16:40:26.584548Z","end":"2026-04-02T16:40:27.03447Z","steps":["trace[385837094] 'agreement among raft nodes before linearized reading' (duration: 449.762845ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:40:27.034504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:40:26.584534Z","time spent":"449.965458ms","remote":"127.0.0.1:47414","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-04-02T16:40:27.034549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.113847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T16:40:27.034588Z","caller":"traceutil/trace.go:171","msg":"trace[928784141] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1322; }","duration":"247.162018ms","start":"2026-04-02T16:40:26.787419Z","end":"2026-04-02T16:40:27.034581Z","steps":["trace[928784141] 'agreement among raft nodes before linearized reading' (duration: 247.061907ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:40:27.034561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.626761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T16:40:27.034672Z","caller":"traceutil/trace.go:171","msg":"trace[576157933] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1322; }","duration":"148.805194ms","start":"2026-04-02T16:40:26.885841Z","end":"2026-04-02T16:40:27.034647Z","steps":["trace[576157933] 'agreement among raft nodes before linearized reading' (duration: 148.567121ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:40:27.034694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.144006ms","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-04-02T16:40:27.034801Z","caller":"traceutil/trace.go:171","msg":"trace[930491541] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1322; }","duration":"308.302739ms","start":"2026-04-02T16:40:26.726475Z","end":"2026-04-02T16:40:27.034778Z","steps":["trace[930491541] 'agreement among raft nodes before linearized reading' (duration: 308.032865ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:40:27.034853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:40:26.726453Z","time spent":"308.39102ms","remote":"127.0.0.1:47414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-02T16:40:27.035254Z","caller":"traceutil/trace.go:171","msg":"trace[1699275322] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"381.437348ms","start":"2026-04-02T16:40:26.653778Z","end":"2026-04-02T16:40:27.035215Z","steps":["trace[1699275322] 'process raft request' (duration: 380.436903ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:40:27.035362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:40:26.653762Z","time spent":"381.536199ms","remote":"127.0.0.1:47414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T16:40:27.183347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.042994ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T16:40:27.183574Z","caller":"traceutil/trace.go:171","msg":"trace[736025543] linearizableReadLoop","detail":"{readStateIndex:1377; appliedIndex:1375; }","duration":"123.817088ms","start":"2026-04-02T16:40:27.059736Z","end":"2026-04-02T16:40:27.183553Z","steps":["trace[736025543] 'read index received' (duration: 19.449979ms)","trace[736025543] 'applied index is now lower than readState.Index' (duration: 104.366019ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:40:27.183673Z","caller":"traceutil/trace.go:171","msg":"trace[724542716] transaction","detail":"{read_only:false; response_revision:1325; number_of_response:1; }","duration":"144.417085ms","start":"2026-04-02T16:40:27.039236Z","end":"2026-04-02T16:40:27.183653Z","steps":["trace[724542716] 'process raft request' (duration: 144.248062ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:40:27.183664Z","caller":"traceutil/trace.go:171","msg":"trace[963550008] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"144.420654ms","start":"2026-04-02T16:40:27.039208Z","end":"2026-04-02T16:40:27.183629Z","steps":["trace[963550008] 'process raft request' (duration: 39.981334ms)","trace[963550008] 'compare' (duration: 103.879382ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T16:40:27.183787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.862616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-02T16:40:27.183707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.96995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T16:40:27.183831Z","caller":"traceutil/trace.go:171","msg":"trace[1592757922] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:1325; }","duration":"104.930088ms","start":"2026-04-02T16:40:27.078886Z","end":"2026-04-02T16:40:27.183816Z","steps":["trace[1592757922] 'agreement among raft nodes before linearized reading' (duration: 104.849487ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:40:27.183881Z","caller":"traceutil/trace.go:171","msg":"trace[957946006] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1325; }","duration":"124.173404ms","start":"2026-04-02T16:40:27.059678Z","end":"2026-04-02T16:40:27.183852Z","steps":["trace[957946006] 'agreement among raft nodes before linearized reading' (duration: 123.995071ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:40:28.123732Z","caller":"traceutil/trace.go:171","msg":"trace[1444866632] linearizableReadLoop","detail":"{readStateIndex:1378; appliedIndex:1377; }","duration":"415.763698ms","start":"2026-04-02T16:40:27.707939Z","end":"2026-04-02T16:40:28.123703Z","steps":["trace[1444866632] 'read index received' (duration: 415.488594ms)","trace[1444866632] 'applied index is now lower than readState.Index' (duration: 273.874µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:40:28.123888Z","caller":"traceutil/trace.go:171","msg":"trace[1664463374] transaction","detail":"{read_only:false; response_revision:1326; number_of_response:1; }","duration":"523.380216ms","start":"2026-04-02T16:40:27.600378Z","end":"2026-04-02T16:40:28.123759Z","steps":["trace[1664463374] 'process raft request' (duration: 523.143202ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:40:28.124065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:40:27.600351Z","time spent":"523.63315ms","remote":"127.0.0.1:47414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T16:40:28.123942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.959631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T16:40:28.12431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.685308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T16:40:28.124397Z","caller":"traceutil/trace.go:171","msg":"trace[821948292] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1326; }","duration":"237.180466ms","start":"2026-04-02T16:40:27.887197Z","end":"2026-04-02T16:40:28.124377Z","steps":["trace[821948292] 'agreement among raft nodes before linearized reading' (duration: 236.693069ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:40:28.124405Z","caller":"traceutil/trace.go:171","msg":"trace[208967845] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1326; }","duration":"416.470299ms","start":"2026-04-02T16:40:27.707886Z","end":"2026-04-02T16:40:28.124356Z","steps":["trace[208967845] 'agreement among raft nodes before linearized reading' (duration: 415.972781ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:40:28.124511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:40:27.707866Z","time spent":"416.626711ms","remote":"127.0.0.1:36404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-02T16:40:43.157151Z","caller":"traceutil/trace.go:171","msg":"trace[974117203] transaction","detail":"{read_only:false; response_revision:1378; number_of_response:1; }","duration":"109.660708ms","start":"2026-04-02T16:40:43.047465Z","end":"2026-04-02T16:40:43.157126Z","steps":["trace[974117203] 'process raft request' (duration: 105.969806ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:40:43.355766Z","caller":"traceutil/trace.go:171","msg":"trace[1583502583] transaction","detail":"{read_only:false; response_revision:1381; number_of_response:1; }","duration":"101.701895ms","start":"2026-04-02T16:40:43.254041Z","end":"2026-04-02T16:40:43.355743Z","steps":["trace[1583502583] 'process raft request' (duration: 33.511246ms)","trace[1583502583] 'compare' (duration: 67.936485ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:40:43.355774Z","caller":"traceutil/trace.go:171","msg":"trace[693813122] transaction","detail":"{read_only:false; response_revision:1382; number_of_response:1; }","duration":"100.150493ms","start":"2026-04-02T16:40:43.255599Z","end":"2026-04-02T16:40:43.355749Z","steps":["trace[693813122] 'process raft request' (duration: 100.073432ms)"],"step_count":1}