{"level":"warn","ts":"2026-02-08T16:37:58.363339Z","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-08T16:37:58.363484Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.19: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.19:2380","--initial-cluster=instance=https://199.204.45.19:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.19:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.19: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-08T16:37:58.363567Z","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-08T16:37:58.363699Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-02-08T16:37:58.363739Z","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-08T16:37:58.36438Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"]} {"level":"info","ts":"2026-02-08T16:37:58.364488Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.19: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-08T16:37:58.3756Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.360217ms"} {"level":"info","ts":"2026-02-08T16:37:58.403197Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a847c2e9c7010db6","cluster-id":"2b11a68e27507b05"} {"level":"info","ts":"2026-02-08T16:37:58.403289Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=()"} {"level":"info","ts":"2026-02-08T16:37:58.403324Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 0"} {"level":"info","ts":"2026-02-08T16:37:58.403362Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a847c2e9c7010db6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-08T16:37:58.403396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 1"} {"level":"info","ts":"2026-02-08T16:37:58.403436Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"warn","ts":"2026-02-08T16:37:58.415004Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-08T16:37:58.419465Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-08T16:37:58.421235Z","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-08T16:37:58.423975Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a847c2e9c7010db6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-08T16:37:58.424291Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a847c2e9c7010db6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-08T16:37:58.425369Z","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-08T16:37:58.425449Z","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-08T16:37:58.42547Z","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-08T16:37:58.425887Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"info","ts":"2026-02-08T16:37:58.426016Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","added-peer-id":"a847c2e9c7010db6","added-peer-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-02-08T16:37:58.436442Z","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-08T16:37:58.437Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a847c2e9c7010db6","initial-advertise-peer-urls":["https://199.204.45.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-08T16:37:58.437145Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-08T16:37:58.44052Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-02-08T16:37:58.443133Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-02-08T16:37:58.503651Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 is starting a new election at term 1"} {"level":"info","ts":"2026-02-08T16:37:58.503714Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-08T16:37:58.503741Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgPreVoteResp from a847c2e9c7010db6 at term 1"} {"level":"info","ts":"2026-02-08T16:37:58.50376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became candidate at term 2"} {"level":"info","ts":"2026-02-08T16:37:58.503787Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgVoteResp from a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-02-08T16:37:58.50381Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became leader at term 2"} {"level":"info","ts":"2026-02-08T16:37:58.503827Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a847c2e9c7010db6 elected leader a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-02-08T16:37:58.506331Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-08T16:37:58.506517Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a847c2e9c7010db6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.19:2379]}","request-path":"/0/members/a847c2e9c7010db6/attributes","cluster-id":"2b11a68e27507b05","publish-timeout":"7s"} {"level":"info","ts":"2026-02-08T16:37:58.506626Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-08T16:37:58.508198Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-08T16:37:58.50846Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-08T16:37:58.512155Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.19:2379"} {"level":"info","ts":"2026-02-08T16:37:58.537815Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-08T16:37:58.537897Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-08T16:37:58.569079Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","cluster-version":"3.5"} {"level":"info","ts":"2026-02-08T16:37:58.576476Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-08T16:37:58.576518Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-02-08T16:38:22.380369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.903741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T16:38:22.380438Z","caller":"traceutil/trace.go:171","msg":"trace[1882976174] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:464; }","duration":"124.033274ms","start":"2026-02-08T16:38:22.256394Z","end":"2026-02-08T16:38:22.380427Z","steps":["trace[1882976174] 'range keys from in-memory index tree' (duration: 123.871551ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:38:27.926018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.708649ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-08T16:38:27.926112Z","caller":"traceutil/trace.go:171","msg":"trace[1464588030] linearizableReadLoop","detail":"{readStateIndex:525; appliedIndex:524; }","duration":"123.008991ms","start":"2026-02-08T16:38:27.803086Z","end":"2026-02-08T16:38:27.926095Z","steps":["trace[1464588030] 'read index received' (duration: 32.771µs)","trace[1464588030] 'applied index is now lower than readState.Index' (duration: 122.9749ms)"],"step_count":2} {"level":"warn","ts":"2026-02-08T16:38:27.926209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.097203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4018"} {"level":"info","ts":"2026-02-08T16:38:27.926234Z","caller":"traceutil/trace.go:171","msg":"trace[1988174730] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:510; }","duration":"123.167065ms","start":"2026-02-08T16:38:27.803059Z","end":"2026-02-08T16:38:27.926226Z","steps":["trace[1988174730] 'agreement among raft nodes before linearized reading' (duration: 123.081023ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:38:31.215979Z","caller":"traceutil/trace.go:171","msg":"trace[641009064] linearizableReadLoop","detail":"{readStateIndex:531; appliedIndex:530; }","duration":"248.277552ms","start":"2026-02-08T16:38:30.967589Z","end":"2026-02-08T16:38:31.215866Z","steps":["trace[641009064] 'read index received' (duration: 248.094098ms)","trace[641009064] 'applied index is now lower than readState.Index' (duration: 182.594µs)"],"step_count":2} {"level":"warn","ts":"2026-02-08T16:38:31.21668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.05594ms","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-08T16:38:31.216731Z","caller":"traceutil/trace.go:171","msg":"trace[1705042010] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:516; }","duration":"249.153072ms","start":"2026-02-08T16:38:30.967565Z","end":"2026-02-08T16:38:31.216718Z","steps":["trace[1705042010] 'agreement among raft nodes before linearized reading' (duration: 248.932797ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:38:31.216996Z","caller":"traceutil/trace.go:171","msg":"trace[240834419] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"251.100246ms","start":"2026-02-08T16:38:30.965876Z","end":"2026-02-08T16:38:31.216976Z","steps":["trace[240834419] 'process raft request' (duration: 249.866868ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:38:33.752506Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988148958859364196,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-08T16:38:33.780713Z","caller":"traceutil/trace.go:171","msg":"trace[2130658247] linearizableReadLoop","detail":"{readStateIndex:538; appliedIndex:537; }","duration":"528.755206ms","start":"2026-02-08T16:38:33.251944Z","end":"2026-02-08T16:38:33.780699Z","steps":["trace[2130658247] 'read index received' (duration: 528.628343ms)","trace[2130658247] 'applied index is now lower than readState.Index' (duration: 126.303µs)"],"step_count":2} {"level":"info","ts":"2026-02-08T16:38:33.780776Z","caller":"traceutil/trace.go:171","msg":"trace[1736512221] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"557.661092ms","start":"2026-02-08T16:38:33.22311Z","end":"2026-02-08T16:38:33.780771Z","steps":["trace[1736512221] 'process raft request' (duration: 557.480238ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:38:33.780936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.801442ms","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-08T16:38:33.780962Z","caller":"traceutil/trace.go:171","msg":"trace[423159717] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:522; }","duration":"526.839493ms","start":"2026-02-08T16:38:33.254113Z","end":"2026-02-08T16:38:33.780952Z","steps":["trace[423159717] 'agreement among raft nodes before linearized reading' (duration: 526.796722ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:38:33.780977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:38:33.254107Z","time spent":"526.866714ms","remote":"127.0.0.1:49232","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-08T16:38:33.78105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:38:33.223096Z","time spent":"557.693753ms","remote":"127.0.0.1:49232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-08T16:38:33.781105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.159834ms","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-08T16:38:33.781117Z","caller":"traceutil/trace.go:171","msg":"trace[841402852] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:522; }","duration":"529.189996ms","start":"2026-02-08T16:38:33.251923Z","end":"2026-02-08T16:38:33.781113Z","steps":["trace[841402852] 'agreement among raft nodes before linearized reading' (duration: 529.139935ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:38:33.781129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:38:33.251913Z","time spent":"529.213626ms","remote":"127.0.0.1:49232","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-08T16:38:33.781164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.409823ms","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-08T16:38:33.781195Z","caller":"traceutil/trace.go:171","msg":"trace[1656926798] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:522; }","duration":"526.440613ms","start":"2026-02-08T16:38:33.254752Z","end":"2026-02-08T16:38:33.781192Z","steps":["trace[1656926798] 'agreement among raft nodes before linearized reading' (duration: 526.401963ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:38:33.781207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:38:33.254733Z","time spent":"526.471095ms","remote":"127.0.0.1:49232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-08T16:38:35.292213Z","caller":"traceutil/trace.go:171","msg":"trace[1887121308] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"162.584836ms","start":"2026-02-08T16:38:35.122902Z","end":"2026-02-08T16:38:35.285487Z","steps":["trace[1887121308] 'process raft request' (duration: 162.046454ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:38:50.029085Z","caller":"traceutil/trace.go:171","msg":"trace[643828705] linearizableReadLoop","detail":"{readStateIndex:719; appliedIndex:718; }","duration":"116.991537ms","start":"2026-02-08T16:38:49.91208Z","end":"2026-02-08T16:38:50.029071Z","steps":["trace[643828705] 'read index received' (duration: 116.874634ms)","trace[643828705] 'applied index is now lower than readState.Index' (duration: 116.343µs)"],"step_count":2} {"level":"info","ts":"2026-02-08T16:38:50.029277Z","caller":"traceutil/trace.go:171","msg":"trace[1753786269] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"157.043822ms","start":"2026-02-08T16:38:49.872227Z","end":"2026-02-08T16:38:50.029271Z","steps":["trace[1753786269] 'process raft request' (duration: 156.767646ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:38:50.029434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.334514ms","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-08T16:38:50.029451Z","caller":"traceutil/trace.go:171","msg":"trace[1991845774] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:699; }","duration":"117.401306ms","start":"2026-02-08T16:38:49.912044Z","end":"2026-02-08T16:38:50.029446Z","steps":["trace[1991845774] 'agreement among raft nodes before linearized reading' (duration: 117.318844ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:38:50.230557Z","caller":"traceutil/trace.go:171","msg":"trace[605986838] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"198.04944ms","start":"2026-02-08T16:38:50.032492Z","end":"2026-02-08T16:38:50.230542Z","steps":["trace[605986838] 'process raft request' (duration: 197.968688ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:38:50.231758Z","caller":"traceutil/trace.go:171","msg":"trace[160327129] transaction","detail":"{read_only:false; response_revision:702; number_of_response:1; }","duration":"198.067479ms","start":"2026-02-08T16:38:50.033683Z","end":"2026-02-08T16:38:50.231751Z","steps":["trace[160327129] 'process raft request' (duration: 198.044248ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:38:50.231918Z","caller":"traceutil/trace.go:171","msg":"trace[1185943327] transaction","detail":"{read_only:false; response_revision:701; number_of_response:1; }","duration":"198.286464ms","start":"2026-02-08T16:38:50.033626Z","end":"2026-02-08T16:38:50.231912Z","steps":["trace[1185943327] 'process raft request' (duration: 198.057119ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:38:56.558638Z","caller":"traceutil/trace.go:171","msg":"trace[668599898] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"171.2622ms","start":"2026-02-08T16:38:56.387357Z","end":"2026-02-08T16:38:56.558619Z","steps":["trace[668599898] 'process raft request' (duration: 170.882712ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:38:56.707315Z","caller":"traceutil/trace.go:171","msg":"trace[2040773899] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"136.394741ms","start":"2026-02-08T16:38:56.570906Z","end":"2026-02-08T16:38:56.707301Z","steps":["trace[2040773899] 'process raft request' (duration: 136.36201ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:38:56.707514Z","caller":"traceutil/trace.go:171","msg":"trace[352345254] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"138.17415ms","start":"2026-02-08T16:38:56.569334Z","end":"2026-02-08T16:38:56.707508Z","steps":["trace[352345254] 'process raft request' (duration: 120.889523ms)","trace[352345254] 'compare' (duration: 16.96285ms)"],"step_count":2} {"level":"info","ts":"2026-02-08T16:38:56.837389Z","caller":"traceutil/trace.go:171","msg":"trace[1269591890] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"123.159574ms","start":"2026-02-08T16:38:56.714181Z","end":"2026-02-08T16:38:56.837341Z","steps":["trace[1269591890] 'process raft request' (duration: 116.2418ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:39:04.387318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.18041ms","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-08T16:39:04.387386Z","caller":"traceutil/trace.go:171","msg":"trace[2143893381] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:751; }","duration":"104.324233ms","start":"2026-02-08T16:39:04.283046Z","end":"2026-02-08T16:39:04.38737Z","steps":["trace[2143893381] 'range keys from in-memory index tree' (duration: 104.007146ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:39:04.387614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.376703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T16:39:04.387637Z","caller":"traceutil/trace.go:171","msg":"trace[747942673] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:751; }","duration":"133.422454ms","start":"2026-02-08T16:39:04.254205Z","end":"2026-02-08T16:39:04.387628Z","steps":["trace[747942673] 'range keys from in-memory index tree' (duration: 133.330931ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:39:20.619335Z","caller":"traceutil/trace.go:171","msg":"trace[660902033] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"100.069249ms","start":"2026-02-08T16:39:20.519245Z","end":"2026-02-08T16:39:20.619314Z","steps":["trace[660902033] 'process raft request' (duration: 99.804633ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:39:33.538733Z","caller":"traceutil/trace.go:171","msg":"trace[1296850274] linearizableReadLoop","detail":"{readStateIndex:918; appliedIndex:917; }","duration":"105.382573ms","start":"2026-02-08T16:39:33.433335Z","end":"2026-02-08T16:39:33.538717Z","steps":["trace[1296850274] 'read index received' (duration: 105.258571ms)","trace[1296850274] 'applied index is now lower than readState.Index' (duration: 123.492µs)"],"step_count":2} {"level":"warn","ts":"2026-02-08T16:39:33.538845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.469555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-08T16:39:33.538868Z","caller":"traceutil/trace.go:171","msg":"trace[2051292878] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:886; }","duration":"105.549489ms","start":"2026-02-08T16:39:33.433313Z","end":"2026-02-08T16:39:33.538862Z","steps":["trace[2051292878] 'agreement among raft nodes before linearized reading' (duration: 105.463416ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:39:33.539075Z","caller":"traceutil/trace.go:171","msg":"trace[2065601989] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"186.532848ms","start":"2026-02-08T16:39:33.352537Z","end":"2026-02-08T16:39:33.53907Z","steps":["trace[2065601989] 'process raft request' (duration: 186.096938ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:39:44.485122Z","caller":"traceutil/trace.go:171","msg":"trace[1532467285] transaction","detail":"{read_only:false; response_revision:915; number_of_response:1; }","duration":"106.441918ms","start":"2026-02-08T16:39:44.378665Z","end":"2026-02-08T16:39:44.485107Z","steps":["trace[1532467285] 'process raft request' (duration: 106.347146ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:39:45.414285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:39:44.880271Z","time spent":"534.008681ms","remote":"127.0.0.1:38386","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-08T16:39:45.414758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.443095ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-08T16:39:45.414793Z","caller":"traceutil/trace.go:171","msg":"trace[304356181] linearizableReadLoop","detail":"{readStateIndex:952; appliedIndex:951; }","duration":"161.377966ms","start":"2026-02-08T16:39:45.253407Z","end":"2026-02-08T16:39:45.414785Z","steps":["trace[304356181] 'read index received' (duration: 22.361µs)","trace[304356181] 'applied index is now lower than readState.Index' (duration: 161.354955ms)"],"step_count":2} {"level":"warn","ts":"2026-02-08T16:39:45.414838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.430777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T16:39:45.41485Z","caller":"traceutil/trace.go:171","msg":"trace[458350127] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:918; }","duration":"161.476798ms","start":"2026-02-08T16:39:45.253369Z","end":"2026-02-08T16:39:45.414846Z","steps":["trace[458350127] 'agreement among raft nodes before linearized reading' (duration: 161.438687ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:39:45.414996Z","caller":"traceutil/trace.go:171","msg":"trace[609934639] transaction","detail":"{read_only:false; response_revision:918; number_of_response:1; }","duration":"648.525569ms","start":"2026-02-08T16:39:44.766462Z","end":"2026-02-08T16:39:45.414987Z","steps":["trace[609934639] 'process raft request' (duration: 282.802638ms)","trace[609934639] 'compare' (duration: 365.22534ms)"],"step_count":2} {"level":"warn","ts":"2026-02-08T16:39:45.415026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:39:44.766453Z","time spent":"648.55653ms","remote":"127.0.0.1:49232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-08T16:39:45.709951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.398993ms","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-08T16:39:45.709998Z","caller":"traceutil/trace.go:171","msg":"trace[755527383] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:918; }","duration":"126.475846ms","start":"2026-02-08T16:39:45.583511Z","end":"2026-02-08T16:39:45.709986Z","steps":["trace[755527383] 'range keys from in-memory index tree' (duration: 126.275881ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:39:51.022311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.165916ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-08T16:39:51.022383Z","caller":"traceutil/trace.go:171","msg":"trace[1979304678] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"527.829333ms","start":"2026-02-08T16:39:50.494543Z","end":"2026-02-08T16:39:51.022373Z","steps":["trace[1979304678] 'process raft request' (duration: 189.553496ms)","trace[1979304678] 'compare' (duration: 338.060022ms)"],"step_count":2} {"level":"warn","ts":"2026-02-08T16:39:51.022415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:39:50.494518Z","time spent":"527.882174ms","remote":"127.0.0.1:49108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":914,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-08T16:39:51.03457Z","caller":"traceutil/trace.go:171","msg":"trace[654814226] linearizableReadLoop","detail":"{readStateIndex:985; appliedIndex:982; }","duration":"529.596662ms","start":"2026-02-08T16:39:50.504964Z","end":"2026-02-08T16:39:51.03456Z","steps":["trace[654814226] 'read index received' (duration: 179.138222ms)","trace[654814226] 'applied index is now lower than readState.Index' (duration: 350.456549ms)"],"step_count":2} {"level":"info","ts":"2026-02-08T16:39:51.034622Z","caller":"traceutil/trace.go:171","msg":"trace[142028897] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"537.642092ms","start":"2026-02-08T16:39:50.496974Z","end":"2026-02-08T16:39:51.034616Z","steps":["trace[142028897] 'process raft request' (duration: 537.505649ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:39:51.034661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:39:50.496955Z","time spent":"537.678273ms","remote":"127.0.0.1:49246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1507,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-08T16:39:51.034803Z","caller":"traceutil/trace.go:171","msg":"trace[1351004176] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"533.798817ms","start":"2026-02-08T16:39:50.500999Z","end":"2026-02-08T16:39:51.034798Z","steps":["trace[1351004176] 'process raft request' (duration: 533.536441ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:39:51.034831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:39:50.500979Z","time spent":"533.834647ms","remote":"127.0.0.1:49456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-08T16:39:51.034938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.974921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-08T16:39:51.034952Z","caller":"traceutil/trace.go:171","msg":"trace[625568389] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:950; }","duration":"530.004201ms","start":"2026-02-08T16:39:50.504944Z","end":"2026-02-08T16:39:51.034948Z","steps":["trace[625568389] 'agreement among raft nodes before linearized reading' (duration: 529.94409ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:39:51.034965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:39:50.504937Z","time spent":"530.025031ms","remote":"127.0.0.1:49232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-08T16:39:51.035068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.918088ms","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-02-08T16:39:51.035139Z","caller":"traceutil/trace.go:171","msg":"trace[709228292] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:950; }","duration":"457.050161ms","start":"2026-02-08T16:39:50.578073Z","end":"2026-02-08T16:39:51.035124Z","steps":["trace[709228292] 'agreement among raft nodes before linearized reading' (duration: 456.928618ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:39:51.035171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.713688ms","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-08T16:39:51.035189Z","caller":"traceutil/trace.go:171","msg":"trace[605446986] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:950; }","duration":"300.733208ms","start":"2026-02-08T16:39:50.734451Z","end":"2026-02-08T16:39:51.035184Z","steps":["trace[605446986] 'agreement among raft nodes before linearized reading' (duration: 300.684647ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:39:51.035185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:39:50.578057Z","time spent":"457.105543ms","remote":"127.0.0.1:49250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":28,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-02-08T16:39:51.035202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:39:50.734386Z","time spent":"300.812271ms","remote":"127.0.0.1:49232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-08T16:39:51.035273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.091749ms","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-08T16:39:51.035284Z","caller":"traceutil/trace.go:171","msg":"trace[974223967] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:950; }","duration":"251.104299ms","start":"2026-02-08T16:39:50.784176Z","end":"2026-02-08T16:39:51.035281Z","steps":["trace[974223967] 'agreement among raft nodes before linearized reading' (duration: 251.071519ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:39:51.035354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.227058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T16:39:51.035396Z","caller":"traceutil/trace.go:171","msg":"trace[854874852] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:950; }","duration":"407.250498ms","start":"2026-02-08T16:39:50.62812Z","end":"2026-02-08T16:39:51.03537Z","steps":["trace[854874852] 'agreement among raft nodes before linearized reading' (duration: 407.198417ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:39:51.035431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:39:50.62809Z","time spent":"407.335601ms","remote":"127.0.0.1:49352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "} {"level":"warn","ts":"2026-02-08T16:39:51.035437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.785772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T16:39:51.035455Z","caller":"traceutil/trace.go:171","msg":"trace[1966376902] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:950; }","duration":"416.836763ms","start":"2026-02-08T16:39:50.618612Z","end":"2026-02-08T16:39:51.035449Z","steps":["trace[1966376902] 'agreement among raft nodes before linearized reading' (duration: 416.807872ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:39:51.035479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:39:50.618599Z","time spent":"416.875994ms","remote":"127.0.0.1:39456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"info","ts":"2026-02-08T16:39:51.728103Z","caller":"traceutil/trace.go:171","msg":"trace[1963395102] transaction","detail":"{read_only:false; response_revision:954; number_of_response:1; }","duration":"285.60749ms","start":"2026-02-08T16:39:51.44248Z","end":"2026-02-08T16:39:51.728087Z","steps":["trace[1963395102] 'process raft request' (duration: 285.510508ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:39:54.729875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.738176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-02-08T16:39:54.73052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.890064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T16:39:54.730571Z","caller":"traceutil/trace.go:171","msg":"trace[44170008] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:971; }","duration":"181.956785ms","start":"2026-02-08T16:39:54.5486Z","end":"2026-02-08T16:39:54.730557Z","steps":["trace[44170008] 'range keys from in-memory index tree' (duration: 181.818393ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:39:54.778992Z","caller":"traceutil/trace.go:171","msg":"trace[891684752] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:971; }","duration":"243.886759ms","start":"2026-02-08T16:39:54.486067Z","end":"2026-02-08T16:39:54.729954Z","steps":["trace[891684752] 'count revisions from in-memory index tree' (duration: 243.662494ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:40:03.93695Z","caller":"traceutil/trace.go:171","msg":"trace[1852853246] transaction","detail":"{read_only:false; response_revision:1033; number_of_response:1; }","duration":"119.312156ms","start":"2026-02-08T16:40:03.817614Z","end":"2026-02-08T16:40:03.936926Z","steps":["trace[1852853246] 'process raft request' (duration: 118.869495ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:40:16.165932Z","caller":"traceutil/trace.go:171","msg":"trace[649154085] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"116.79574ms","start":"2026-02-08T16:40:16.049119Z","end":"2026-02-08T16:40:16.165915Z","steps":["trace[649154085] 'process raft request' (duration: 18.403812ms)","trace[649154085] 'compare' (duration: 98.068101ms)"],"step_count":2} {"level":"warn","ts":"2026-02-08T16:41:52.911017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.463985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-02-08T16:41:52.91107Z","caller":"traceutil/trace.go:171","msg":"trace[941770173] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1479; }","duration":"177.571707ms","start":"2026-02-08T16:41:52.733486Z","end":"2026-02-08T16:41:52.911058Z","steps":["trace[941770173] 'range keys from in-memory index tree' (duration: 177.351542ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:42:13.889716Z","caller":"traceutil/trace.go:171","msg":"trace[1502945539] transaction","detail":"{read_only:false; response_revision:1564; number_of_response:1; }","duration":"236.188954ms","start":"2026-02-08T16:42:13.653506Z","end":"2026-02-08T16:42:13.889695Z","steps":["trace[1502945539] 'process raft request' (duration: 235.620201ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:42:13.890048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.224047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T16:42:13.890406Z","caller":"traceutil/trace.go:171","msg":"trace[649431362] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1564; }","duration":"100.632146ms","start":"2026-02-08T16:42:13.789759Z","end":"2026-02-08T16:42:13.890391Z","steps":["trace[649431362] 'agreement among raft nodes before linearized reading' (duration: 100.238058ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:43:05.16908Z","caller":"traceutil/trace.go:171","msg":"trace[74559375] transaction","detail":"{read_only:false; response_revision:1799; number_of_response:1; }","duration":"176.347845ms","start":"2026-02-08T16:43:04.992712Z","end":"2026-02-08T16:43:05.16906Z","steps":["trace[74559375] 'process raft request' (duration: 176.236512ms)"],"step_count":1}