{"level":"warn","ts":"2026-01-19T22:05:51.535416Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-01-19T22:05:51.53556Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.250:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.250:2380","--initial-cluster=instance=https://162.253.55.250:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.250:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.250: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-01-19T22:05:51.535924Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-01-19T22:05:51.535953Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.250:2380"]}
{"level":"info","ts":"2026-01-19T22:05:51.536034Z","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-01-19T22:05:51.536795Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.250:2379"]}
{"level":"info","ts":"2026-01-19T22:05:51.536924Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.250:2380"],"listen-peer-urls":["https://162.253.55.250:2380"],"advertise-client-urls":["https://162.253.55.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.250: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-01-19T22:05:51.542754Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.588896ms"}
{"level":"info","ts":"2026-01-19T22:05:51.554543Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1e4a0bccff66c64d","cluster-id":"8ba64f6e83da771"}
{"level":"info","ts":"2026-01-19T22:05:51.554666Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d switched to configuration voters=()"}
{"level":"info","ts":"2026-01-19T22:05:51.554716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d became follower at term 0"}
{"level":"info","ts":"2026-01-19T22:05:51.554794Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1e4a0bccff66c64d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-01-19T22:05:51.554859Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d became follower at term 1"}
{"level":"info","ts":"2026-01-19T22:05:51.554935Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d switched to configuration voters=(2182569944500586061)"}
{"level":"warn","ts":"2026-01-19T22:05:51.566273Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-01-19T22:05:51.567639Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-01-19T22:05:51.572708Z","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-01-19T22:05:51.580045Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1e4a0bccff66c64d","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-01-19T22:05:51.587369Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1e4a0bccff66c64d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-01-19T22:05:51.587542Z","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-01-19T22:05:51.588235Z","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-01-19T22:05:51.588294Z","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-01-19T22:05:51.58801Z","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-01-19T22:05:51.589334Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1e4a0bccff66c64d","initial-advertise-peer-urls":["https://162.253.55.250:2380"],"listen-peer-urls":["https://162.253.55.250:2380"],"advertise-client-urls":["https://162.253.55.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-01-19T22:05:51.589391Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-01-19T22:05:51.588077Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.250:2380"}
{"level":"info","ts":"2026-01-19T22:05:51.589895Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.250:2380"}
{"level":"info","ts":"2026-01-19T22:05:51.591401Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d switched to configuration voters=(2182569944500586061)"}
{"level":"info","ts":"2026-01-19T22:05:51.591516Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8ba64f6e83da771","local-member-id":"1e4a0bccff66c64d","added-peer-id":"1e4a0bccff66c64d","added-peer-peer-urls":["https://162.253.55.250:2380"]}
{"level":"info","ts":"2026-01-19T22:05:52.258416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d is starting a new election at term 1"}
{"level":"info","ts":"2026-01-19T22:05:52.258456Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d became pre-candidate at term 1"}
{"level":"info","ts":"2026-01-19T22:05:52.258477Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d received MsgPreVoteResp from 1e4a0bccff66c64d at term 1"}
{"level":"info","ts":"2026-01-19T22:05:52.258489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d became candidate at term 2"}
{"level":"info","ts":"2026-01-19T22:05:52.258494Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d received MsgVoteResp from 1e4a0bccff66c64d at term 2"}
{"level":"info","ts":"2026-01-19T22:05:52.258508Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d became leader at term 2"}
{"level":"info","ts":"2026-01-19T22:05:52.258515Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1e4a0bccff66c64d elected leader 1e4a0bccff66c64d at term 2"}
{"level":"info","ts":"2026-01-19T22:05:52.260661Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1e4a0bccff66c64d","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.250:2379]}","request-path":"/0/members/1e4a0bccff66c64d/attributes","cluster-id":"8ba64f6e83da771","publish-timeout":"7s"}
{"level":"info","ts":"2026-01-19T22:05:52.260826Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-01-19T22:05:52.263591Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-01-19T22:05:52.260681Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-19T22:05:52.265904Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-01-19T22:05:52.265934Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-01-19T22:05:52.265996Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8ba64f6e83da771","local-member-id":"1e4a0bccff66c64d","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-19T22:05:52.266105Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-19T22:05:52.26615Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-19T22:05:52.267762Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-01-19T22:05:52.2738Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.250:2379"}
{"level":"warn","ts":"2026-01-19T22:06:15.757686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T22:06:15.355972Z","time spent":"401.711032ms","remote":"127.0.0.1:43814","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-01-19T22:06:23.703167Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14289248545989740317,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-19T22:06:24.175579Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.101831529s","expected-duration":"1s"}
{"level":"info","ts":"2026-01-19T22:06:24.175791Z","caller":"traceutil/trace.go:171","msg":"trace[1852146559] linearizableReadLoop","detail":"{readStateIndex:493; appliedIndex:492; }","duration":"972.841042ms","start":"2026-01-19T22:06:23.202936Z","end":"2026-01-19T22:06:24.175777Z","steps":["trace[1852146559] 'read index received'  (duration: 972.740371ms)","trace[1852146559] 'applied index is now lower than readState.Index'  (duration: 99.821µs)"],"step_count":2}
{"level":"info","ts":"2026-01-19T22:06:24.175944Z","caller":"traceutil/trace.go:171","msg":"trace[301934820] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"1.102261612s","start":"2026-01-19T22:06:23.073677Z","end":"2026-01-19T22:06:24.175939Z","steps":["trace[301934820] 'process raft request'  (duration: 1.10203131s)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T22:06:24.17617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.990212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-01-19T22:06:24.176217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T22:06:23.073669Z","time spent":"1.102294932s","remote":"127.0.0.1:45886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<>"}
{"level":"info","ts":"2026-01-19T22:06:24.176248Z","caller":"traceutil/trace.go:171","msg":"trace[1847250512] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:477; }","duration":"249.107163ms","start":"2026-01-19T22:06:23.927125Z","end":"2026-01-19T22:06:24.176232Z","steps":["trace[1847250512] 'agreement among raft nodes before linearized reading'  (duration: 248.873342ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T22:06:24.176406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"973.463475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-d8qh8\" ","response":"range_response_count:1 size:4639"}
{"level":"info","ts":"2026-01-19T22:06:24.176425Z","caller":"traceutil/trace.go:171","msg":"trace[490345026] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-d8qh8; range_end:; response_count:1; response_revision:477; }","duration":"973.510605ms","start":"2026-01-19T22:06:23.202908Z","end":"2026-01-19T22:06:24.176419Z","steps":["trace[490345026] 'agreement among raft nodes before linearized reading'  (duration: 973.436365ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T22:06:24.17644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T22:06:23.202894Z","time spent":"973.542586ms","remote":"127.0.0.1:45814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":4661,"request content":"key:\"/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-d8qh8\" "}
{"level":"warn","ts":"2026-01-19T22:06:24.17645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.361211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-19T22:06:24.176475Z","caller":"traceutil/trace.go:171","msg":"trace[1780493812] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:477; }","duration":"179.404341ms","start":"2026-01-19T22:06:23.997061Z","end":"2026-01-19T22:06:24.176465Z","steps":["trace[1780493812] 'agreement among raft nodes before linearized reading'  (duration: 179.370661ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T22:06:25.629637Z","caller":"traceutil/trace.go:171","msg":"trace[897549245] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"437.898347ms","start":"2026-01-19T22:06:25.191722Z","end":"2026-01-19T22:06:25.629621Z","steps":["trace[897549245] 'process raft request'  (duration: 437.484415ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T22:06:25.629789Z","caller":"traceutil/trace.go:171","msg":"trace[25643772] linearizableReadLoop","detail":"{readStateIndex:543; appliedIndex:542; }","duration":"396.337937ms","start":"2026-01-19T22:06:25.233071Z","end":"2026-01-19T22:06:25.629409Z","steps":["trace[25643772] 'read index received'  (duration: 396.217656ms)","trace[25643772] 'applied index is now lower than readState.Index'  (duration: 119.391µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-19T22:06:25.629877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T22:06:25.191707Z","time spent":"438.017468ms","remote":"127.0.0.1:43832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" value_size:3262 >> failure:<>"}
{"level":"warn","ts":"2026-01-19T22:06:25.630508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.422703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:1 size:12727"}
{"level":"info","ts":"2026-01-19T22:06:25.630602Z","caller":"traceutil/trace.go:171","msg":"trace[85037051] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:527; }","duration":"397.542864ms","start":"2026-01-19T22:06:25.233045Z","end":"2026-01-19T22:06:25.630588Z","steps":["trace[85037051] 'agreement among raft nodes before linearized reading'  (duration: 396.787759ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T22:06:25.630661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T22:06:25.233033Z","time spent":"397.618024ms","remote":"127.0.0.1:43880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":12749,"request content":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" "}
{"level":"warn","ts":"2026-01-19T22:06:26.130204Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14289248545989740395,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-01-19T22:06:26.451402Z","caller":"traceutil/trace.go:171","msg":"trace[624373176] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"866.038699ms","start":"2026-01-19T22:06:25.585298Z","end":"2026-01-19T22:06:26.451337Z","steps":["trace[624373176] 'process raft request'  (duration: 866.015388ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T22:06:26.451509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T22:06:25.58528Z","time spent":"866.172969ms","remote":"127.0.0.1:43832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12244,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" value_size:12154 >> failure:<>"}
{"level":"info","ts":"2026-01-19T22:06:26.451602Z","caller":"traceutil/trace.go:171","msg":"trace[1097195764] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"1.061593585s","start":"2026-01-19T22:06:25.390004Z","end":"2026-01-19T22:06:26.451597Z","steps":["trace[1097195764] 'process raft request'  (duration: 1.061193893s)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T22:06:26.451626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T22:06:25.389982Z","time spent":"1.061631865s","remote":"127.0.0.1:43832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" value_size:23189 >> failure:<>"}
{"level":"info","ts":"2026-01-19T22:06:26.580859Z","caller":"traceutil/trace.go:171","msg":"trace[533242998] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"942.071213ms","start":"2026-01-19T22:06:25.638775Z","end":"2026-01-19T22:06:26.580846Z","steps":["trace[533242998] 'process raft request'  (duration: 940.627773ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T22:06:26.581077Z","caller":"traceutil/trace.go:171","msg":"trace[920451832] linearizableReadLoop","detail":"{readStateIndex:547; appliedIndex:543; }","duration":"951.015058ms","start":"2026-01-19T22:06:25.629813Z","end":"2026-01-19T22:06:26.580828Z","steps":["trace[920451832] 'read index received'  (duration: 821.351659ms)","trace[920451832] 'applied index is now lower than readState.Index'  (duration: 129.662909ms)"],"step_count":2}
{"level":"info","ts":"2026-01-19T22:06:26.581131Z","caller":"traceutil/trace.go:171","msg":"trace[1673892931] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"797.504415ms","start":"2026-01-19T22:06:25.78362Z","end":"2026-01-19T22:06:26.581125Z","steps":["trace[1673892931] 'process raft request'  (duration: 797.188323ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T22:06:26.58127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T22:06:25.783602Z","time spent":"797.639626ms","remote":"127.0.0.1:43832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3104,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" value_size:3013 >> failure:<>"}
{"level":"warn","ts":"2026-01-19T22:06:26.581215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T22:06:25.638755Z","time spent":"942.145363ms","remote":"127.0.0.1:43832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4309,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" mod_revision:527 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" value_size:4218 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" > >"}
{"level":"warn","ts":"2026-01-19T22:06:26.5819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.811275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-19T22:06:26.581925Z","caller":"traceutil/trace.go:171","msg":"trace[473229747] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:531; }","duration":"599.861205ms","start":"2026-01-19T22:06:25.982058Z","end":"2026-01-19T22:06:26.581919Z","steps":["trace[473229747] 'agreement among raft nodes before linearized reading'  (duration: 599.449173ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T22:06:26.582363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T22:06:25.982034Z","time spent":"600.267687ms","remote":"127.0.0.1:43832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" "}
{"level":"warn","ts":"2026-01-19T22:06:26.582834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.650132ms","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-01-19T22:06:26.582877Z","caller":"traceutil/trace.go:171","msg":"trace[1621873332] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:531; }","duration":"224.723613ms","start":"2026-01-19T22:06:26.358143Z","end":"2026-01-19T22:06:26.582867Z","steps":["trace[1621873332] 'agreement among raft nodes before linearized reading'  (duration: 224.585462ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T22:06:26.583113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.207035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"}
{"level":"info","ts":"2026-01-19T22:06:26.583131Z","caller":"traceutil/trace.go:171","msg":"trace[1383036144] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:531; }","duration":"201.248815ms","start":"2026-01-19T22:06:26.381875Z","end":"2026-01-19T22:06:26.583124Z","steps":["trace[1383036144] 'agreement among raft nodes before linearized reading'  (duration: 201.199205ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T22:06:26.583206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.188047ms","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-01-19T22:06:26.583218Z","caller":"traceutil/trace.go:171","msg":"trace[1467826572] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:531; }","duration":"222.236037ms","start":"2026-01-19T22:06:26.360978Z","end":"2026-01-19T22:06:26.583214Z","steps":["trace[1467826572] 'agreement among raft nodes before linearized reading'  (duration: 222.203596ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T22:06:26.583462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.825743ms","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-01-19T22:06:26.583478Z","caller":"traceutil/trace.go:171","msg":"trace[1815101180] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:531; }","duration":"341.862883ms","start":"2026-01-19T22:06:26.24161Z","end":"2026-01-19T22:06:26.583473Z","steps":["trace[1815101180] 'agreement among raft nodes before linearized reading'  (duration: 341.822113ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T22:06:26.583491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T22:06:26.241597Z","time spent":"341.890345ms","remote":"127.0.0.1:45886","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-01-19T22:06:26.583565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.041839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"}
{"level":"info","ts":"2026-01-19T22:06:26.583579Z","caller":"traceutil/trace.go:171","msg":"trace[133673542] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:531; }","duration":"304.078019ms","start":"2026-01-19T22:06:26.279498Z","end":"2026-01-19T22:06:26.583576Z","steps":["trace[133673542] 'agreement among raft nodes before linearized reading'  (duration: 304.042439ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T22:06:26.583591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T22:06:26.279485Z","time spent":"304.103759ms","remote":"127.0.0.1:45886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-01-19T22:06:26.583745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.536267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-19T22:06:26.58376Z","caller":"traceutil/trace.go:171","msg":"trace[127650368] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:531; }","duration":"401.574057ms","start":"2026-01-19T22:06:26.182182Z","end":"2026-01-19T22:06:26.583756Z","steps":["trace[127650368] 'agreement among raft nodes before linearized reading'  (duration: 401.551197ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T22:06:26.583773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T22:06:26.18217Z","time spent":"401.600037ms","remote":"127.0.0.1:43832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" "}
{"level":"warn","ts":"2026-01-19T22:06:26.583862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.000517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-19T22:06:26.583875Z","caller":"traceutil/trace.go:171","msg":"trace[95399545] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:531; }","duration":"589.040278ms","start":"2026-01-19T22:06:25.994831Z","end":"2026-01-19T22:06:26.583871Z","steps":["trace[95399545] 'agreement among raft nodes before linearized reading'  (duration: 589.020887ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T22:06:26.583886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T22:06:25.994815Z","time spent":"589.068198ms","remote":"127.0.0.1:43764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-01-19T22:06:26.585929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.229318272s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.250\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-01-19T22:06:26.586029Z","caller":"traceutil/trace.go:171","msg":"trace[1257648854] range","detail":"{range_begin:/registry/masterleases/162.253.55.250; range_end:; response_count:1; response_revision:531; }","duration":"1.229423723s","start":"2026-01-19T22:06:25.35657Z","end":"2026-01-19T22:06:26.585993Z","steps":["trace[1257648854] 'agreement among raft nodes before linearized reading'  (duration: 1.225909201s)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T22:06:26.586165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T22:06:25.356555Z","time spent":"1.229553734s","remote":"127.0.0.1:43814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/162.253.55.250\" "}
{"level":"info","ts":"2026-01-19T22:06:33.697024Z","caller":"traceutil/trace.go:171","msg":"trace[1551451393] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"438.19554ms","start":"2026-01-19T22:06:33.258813Z","end":"2026-01-19T22:06:33.697008Z","steps":["trace[1551451393] 'process raft request'  (duration: 438.094979ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T22:06:33.697126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T22:06:33.258795Z","time spent":"438.2814ms","remote":"127.0.0.1:45814","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-l5q6j\" mod_revision:457 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-l5q6j\" value_size:16754 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-l5q6j\" > >"}
{"level":"warn","ts":"2026-01-19T22:06:36.091351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.349107435s","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-01-19T22:06:36.091409Z","caller":"traceutil/trace.go:171","msg":"trace[859087773] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:573; }","duration":"1.349202405s","start":"2026-01-19T22:06:34.742194Z","end":"2026-01-19T22:06:36.091396Z","steps":["trace[859087773] 'range keys from in-memory index tree'  (duration: 1.348952953s)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T22:06:36.091435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T22:06:34.742176Z","time spent":"1.349252435s","remote":"127.0.0.1:45886","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":"warn","ts":"2026-01-19T22:06:36.091581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.345603223s","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-01-19T22:06:36.091598Z","caller":"traceutil/trace.go:171","msg":"trace[726639404] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:573; }","duration":"1.345651773s","start":"2026-01-19T22:06:34.745941Z","end":"2026-01-19T22:06:36.091593Z","steps":["trace[726639404] 'range keys from in-memory index tree'  (duration: 1.345528483s)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T22:06:36.091617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T22:06:34.745925Z","time spent":"1.345688664s","remote":"127.0.0.1:45886","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-01-19T22:06:36.091715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.344878998s","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-01-19T22:06:36.091731Z","caller":"traceutil/trace.go:171","msg":"trace[304970339] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:573; }","duration":"1.344904148s","start":"2026-01-19T22:06:34.746822Z","end":"2026-01-19T22:06:36.091726Z","steps":["trace[304970339] 'range keys from in-memory index tree'  (duration: 1.344821528s)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T22:06:36.09175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T22:06:34.746817Z","time spent":"1.344929078s","remote":"127.0.0.1:45886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-01-19T22:06:36.091838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.343780583s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-01-19T22:06:36.091857Z","caller":"traceutil/trace.go:171","msg":"trace[337178759] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:573; }","duration":"1.343806293s","start":"2026-01-19T22:06:34.748044Z","end":"2026-01-19T22:06:36.091851Z","steps":["trace[337178759] 'range keys from in-memory index tree'  (duration: 1.343736842s)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T22:06:36.091873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T22:06:34.74804Z","time spent":"1.343829893s","remote":"127.0.0.1:45886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-01-19T22:06:36.091967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.340197621s","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-01-19T22:06:36.091983Z","caller":"traceutil/trace.go:171","msg":"trace[1769633868] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:573; }","duration":"1.340213271s","start":"2026-01-19T22:06:34.751765Z","end":"2026-01-19T22:06:36.091978Z","steps":["trace[1769633868] 'range keys from in-memory index tree'  (duration: 1.340145481s)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T22:06:36.092002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T22:06:34.751751Z","time spent":"1.340243862s","remote":"127.0.0.1:45886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-01-19T22:06:36.092192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.096291912s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-19T22:06:36.09221Z","caller":"traceutil/trace.go:171","msg":"trace[344578316] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:573; }","duration":"1.096326502s","start":"2026-01-19T22:06:34.995878Z","end":"2026-01-19T22:06:36.092204Z","steps":["trace[344578316] 'range keys from in-memory index tree'  (duration: 1.096225952s)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T22:06:36.092225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T22:06:34.995865Z","time spent":"1.096356052s","remote":"127.0.0.1:43762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-01-19T22:06:36.092388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"734.980385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.250\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-01-19T22:06:36.092408Z","caller":"traceutil/trace.go:171","msg":"trace[496256493] range","detail":"{range_begin:/registry/masterleases/162.253.55.250; range_end:; response_count:1; response_revision:573; }","duration":"735.026625ms","start":"2026-01-19T22:06:35.357374Z","end":"2026-01-19T22:06:36.092401Z","steps":["trace[496256493] 'range keys from in-memory index tree'  (duration: 734.909715ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T22:06:36.092423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T22:06:35.357359Z","time spent":"735.060905ms","remote":"127.0.0.1:43814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/162.253.55.250\" "}
{"level":"info","ts":"2026-01-19T22:06:36.226701Z","caller":"traceutil/trace.go:171","msg":"trace[1733858127] linearizableReadLoop","detail":"{readStateIndex:595; appliedIndex:592; }","duration":"119.229943ms","start":"2026-01-19T22:06:36.107449Z","end":"2026-01-19T22:06:36.226679Z","steps":["trace[1733858127] 'read index received'  (duration: 59.561567ms)","trace[1733858127] 'applied index is now lower than readState.Index'  (duration: 59.667236ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-19T22:06:36.226861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.388374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-19T22:06:36.226893Z","caller":"traceutil/trace.go:171","msg":"trace[884956886] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:579; }","duration":"119.439014ms","start":"2026-01-19T22:06:36.107444Z","end":"2026-01-19T22:06:36.226883Z","steps":["trace[884956886] 'agreement among raft nodes before linearized reading'  (duration: 119.319164ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T22:06:36.226889Z","caller":"traceutil/trace.go:171","msg":"trace[1871076212] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"120.078917ms","start":"2026-01-19T22:06:36.106797Z","end":"2026-01-19T22:06:36.226876Z","steps":["trace[1871076212] 'process raft request'  (duration: 119.702035ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T22:06:36.22698Z","caller":"traceutil/trace.go:171","msg":"trace[1973157063] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"124.818036ms","start":"2026-01-19T22:06:36.102156Z","end":"2026-01-19T22:06:36.226974Z","steps":["trace[1973157063] 'process raft request'  (duration: 89.697356ms)","trace[1973157063] 'compare'  (duration: 34.425196ms)"],"step_count":2}
{"level":"info","ts":"2026-01-19T22:06:36.227031Z","caller":"traceutil/trace.go:171","msg":"trace[1182189618] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"124.637094ms","start":"2026-01-19T22:06:36.102388Z","end":"2026-01-19T22:06:36.227025Z","steps":["trace[1182189618] 'process raft request'  (duration: 124.034081ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T22:06:36.227132Z","caller":"traceutil/trace.go:171","msg":"trace[1048072498] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"118.346687ms","start":"2026-01-19T22:06:36.108774Z","end":"2026-01-19T22:06:36.227121Z","steps":["trace[1048072498] 'process raft request'  (duration: 117.766493ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T22:06:36.227158Z","caller":"traceutil/trace.go:171","msg":"trace[356215656] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"117.515132ms","start":"2026-01-19T22:06:36.109636Z","end":"2026-01-19T22:06:36.227152Z","steps":["trace[356215656] 'process raft request'  (duration: 116.943569ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T22:07:58.931201Z","caller":"traceutil/trace.go:171","msg":"trace[270298402] linearizableReadLoop","detail":"{readStateIndex:988; appliedIndex:987; }","duration":"162.181647ms","start":"2026-01-19T22:07:58.768995Z","end":"2026-01-19T22:07:58.931176Z","steps":["trace[270298402] 'read index received'  (duration: 161.994443ms)","trace[270298402] 'applied index is now lower than readState.Index'  (duration: 186.244µs)"],"step_count":2}
{"level":"info","ts":"2026-01-19T22:07:58.9316Z","caller":"traceutil/trace.go:171","msg":"trace[1070749285] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"216.741384ms","start":"2026-01-19T22:07:58.714845Z","end":"2026-01-19T22:07:58.931586Z","steps":["trace[1070749285] 'process raft request'  (duration: 216.207872ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T22:07:58.931823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.750089ms","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-01-19T22:07:58.932606Z","caller":"traceutil/trace.go:171","msg":"trace[570713391] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:950; }","duration":"163.556505ms","start":"2026-01-19T22:07:58.769033Z","end":"2026-01-19T22:07:58.93259Z","steps":["trace[570713391] 'agreement among raft nodes before linearized reading'  (duration: 162.623116ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T22:07:58.931922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.923853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-01-19T22:07:58.933249Z","caller":"traceutil/trace.go:171","msg":"trace[1791010400] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:950; }","duration":"164.277409ms","start":"2026-01-19T22:07:58.768956Z","end":"2026-01-19T22:07:58.933234Z","steps":["trace[1791010400] 'agreement among raft nodes before linearized reading'  (duration: 162.905962ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T22:07:59.064591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.809043ms","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-01-19T22:07:59.064664Z","caller":"traceutil/trace.go:171","msg":"trace[780871898] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:950; }","duration":"294.901495ms","start":"2026-01-19T22:07:58.769744Z","end":"2026-01-19T22:07:59.064645Z","steps":["trace[780871898] 'agreement among raft nodes before linearized reading'  (duration: 162.573745ms)","trace[780871898] 'range keys from in-memory index tree'  (duration: 132.118066ms)"],"step_count":2}
{"level":"info","ts":"2026-01-19T22:07:59.06792Z","caller":"traceutil/trace.go:171","msg":"trace[1212163056] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"130.234617ms","start":"2026-01-19T22:07:58.937667Z","end":"2026-01-19T22:07:59.067902Z","steps":["trace[1212163056] 'process raft request'  (duration: 78.977808ms)","trace[1212163056] 'compare'  (duration: 51.138456ms)"],"step_count":2}
{"level":"info","ts":"2026-01-19T22:07:59.250939Z","caller":"traceutil/trace.go:171","msg":"trace[1187728433] linearizableReadLoop","detail":"{readStateIndex:990; appliedIndex:988; }","duration":"255.952212ms","start":"2026-01-19T22:07:58.994961Z","end":"2026-01-19T22:07:59.250914Z","steps":["trace[1187728433] 'read index received'  (duration: 21.692406ms)","trace[1187728433] 'applied index is now lower than readState.Index'  (duration: 234.258956ms)"],"step_count":2}
{"level":"info","ts":"2026-01-19T22:07:59.251097Z","caller":"traceutil/trace.go:171","msg":"trace[1076754725] transaction","detail":"{read_only:false; response_revision:952; number_of_response:1; }","duration":"312.241783ms","start":"2026-01-19T22:07:58.938796Z","end":"2026-01-19T22:07:59.251038Z","steps":["trace[1076754725] 'process raft request'  (duration: 285.21411ms)","trace[1076754725] 'compare'  (duration: 26.754068ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-19T22:07:59.251338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T22:07:58.938788Z","time spent":"312.405527ms","remote":"127.0.0.1:45886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:946 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-01-19T22:07:59.251618Z","caller":"traceutil/trace.go:171","msg":"trace[1604215953] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"180.857453ms","start":"2026-01-19T22:07:59.070749Z","end":"2026-01-19T22:07:59.251606Z","steps":["trace[1604215953] 'process raft request'  (duration: 180.132648ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T22:07:59.251984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.018153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-19T22:07:59.252029Z","caller":"traceutil/trace.go:171","msg":"trace[1646433655] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:953; }","duration":"257.088884ms","start":"2026-01-19T22:07:58.99493Z","end":"2026-01-19T22:07:59.252018Z","steps":["trace[1646433655] 'agreement among raft nodes before linearized reading'  (duration: 256.086734ms)"],"step_count":1}