{"level":"warn","ts":"2026-05-26T13:47:42.153416Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-26T13:47:42.1535Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.194: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.19.213.194:2380","--initial-cluster=instance=https://199.19.213.194:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.194:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.194: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-05-26T13:47:42.153585Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-26T13:47:42.153601Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.194:2380"]} {"level":"info","ts":"2026-05-26T13:47:42.153617Z","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-05-26T13:47:42.154154Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.194:2379"]} {"level":"info","ts":"2026-05-26T13:47:42.154223Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.194:2380"],"listen-peer-urls":["https://199.19.213.194:2380"],"advertise-client-urls":["https://199.19.213.194:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.194:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.194: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-05-26T13:47:42.158341Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.889343ms"} {"level":"info","ts":"2026-05-26T13:47:42.166837Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1444e0f5dfca45ef","cluster-id":"46f0df2abd5471c9"} {"level":"info","ts":"2026-05-26T13:47:42.166936Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1444e0f5dfca45ef switched to configuration voters=()"} {"level":"info","ts":"2026-05-26T13:47:42.166962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1444e0f5dfca45ef became follower at term 0"} {"level":"info","ts":"2026-05-26T13:47:42.166982Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1444e0f5dfca45ef [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-26T13:47:42.166995Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1444e0f5dfca45ef became follower at term 1"} {"level":"info","ts":"2026-05-26T13:47:42.167033Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1444e0f5dfca45ef switched to configuration voters=(1460539525801068015)"} {"level":"warn","ts":"2026-05-26T13:47:42.176615Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-26T13:47:42.177928Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-26T13:47:42.183803Z","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-05-26T13:47:42.19256Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1444e0f5dfca45ef","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-26T13:47:42.193005Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1444e0f5dfca45ef","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-26T13:47:42.193204Z","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-05-26T13:47:42.193266Z","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-05-26T13:47:42.193276Z","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-05-26T13:47:42.196331Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1444e0f5dfca45ef switched to configuration voters=(1460539525801068015)"} {"level":"info","ts":"2026-05-26T13:47:42.196546Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"46f0df2abd5471c9","local-member-id":"1444e0f5dfca45ef","added-peer-id":"1444e0f5dfca45ef","added-peer-peer-urls":["https://199.19.213.194:2380"]} {"level":"info","ts":"2026-05-26T13:47:42.197227Z","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-05-26T13:47:42.197366Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.194:2380"} {"level":"info","ts":"2026-05-26T13:47:42.197386Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.194:2380"} {"level":"info","ts":"2026-05-26T13:47:42.197541Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1444e0f5dfca45ef","initial-advertise-peer-urls":["https://199.19.213.194:2380"],"listen-peer-urls":["https://199.19.213.194:2380"],"advertise-client-urls":["https://199.19.213.194:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.194:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-26T13:47:42.197612Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-26T13:47:43.067791Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1444e0f5dfca45ef is starting a new election at term 1"} {"level":"info","ts":"2026-05-26T13:47:43.067831Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1444e0f5dfca45ef became pre-candidate at term 1"} {"level":"info","ts":"2026-05-26T13:47:43.067844Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1444e0f5dfca45ef received MsgPreVoteResp from 1444e0f5dfca45ef at term 1"} {"level":"info","ts":"2026-05-26T13:47:43.067855Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1444e0f5dfca45ef became candidate at term 2"} {"level":"info","ts":"2026-05-26T13:47:43.06786Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1444e0f5dfca45ef received MsgVoteResp from 1444e0f5dfca45ef at term 2"} {"level":"info","ts":"2026-05-26T13:47:43.067868Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1444e0f5dfca45ef became leader at term 2"} {"level":"info","ts":"2026-05-26T13:47:43.067897Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1444e0f5dfca45ef elected leader 1444e0f5dfca45ef at term 2"} {"level":"info","ts":"2026-05-26T13:47:43.423829Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T13:47:43.424919Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1444e0f5dfca45ef","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.194:2379]}","request-path":"/0/members/1444e0f5dfca45ef/attributes","cluster-id":"46f0df2abd5471c9","publish-timeout":"7s"} {"level":"info","ts":"2026-05-26T13:47:43.425035Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-26T13:47:43.425119Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-26T13:47:43.425614Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-26T13:47:43.425673Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-26T13:47:43.425736Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"46f0df2abd5471c9","local-member-id":"1444e0f5dfca45ef","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T13:47:43.42588Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T13:47:43.42592Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T13:47:43.427121Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-26T13:47:43.428733Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.194:2379"} {"level":"info","ts":"2026-05-26T13:48:20.986178Z","caller":"traceutil/trace.go:171","msg":"trace[2099998730] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"133.775316ms","start":"2026-05-26T13:48:20.852377Z","end":"2026-05-26T13:48:20.986152Z","steps":["trace[2099998730] 'process raft request' (duration: 133.637633ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:48:21.426191Z","caller":"traceutil/trace.go:171","msg":"trace[1557223058] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"568.421669ms","start":"2026-05-26T13:48:20.85774Z","end":"2026-05-26T13:48:21.426162Z","steps":["trace[1557223058] 'process raft request' (duration: 568.224613ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:48:21.42624Z","caller":"traceutil/trace.go:171","msg":"trace[958600877] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"553.889583ms","start":"2026-05-26T13:48:20.872295Z","end":"2026-05-26T13:48:21.426185Z","steps":["trace[958600877] 'process raft request' (duration: 553.735369ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:48:21.426258Z","caller":"traceutil/trace.go:171","msg":"trace[772773803] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"568.717587ms","start":"2026-05-26T13:48:20.857503Z","end":"2026-05-26T13:48:21.426221Z","steps":["trace[772773803] 'process raft request' (duration: 568.305475ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:48:21.426348Z","caller":"traceutil/trace.go:171","msg":"trace[1184032483] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"553.987916ms","start":"2026-05-26T13:48:20.87235Z","end":"2026-05-26T13:48:21.426338Z","steps":["trace[1184032483] 'process raft request' (duration: 553.733308ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:48:21.42653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:48:20.857734Z","time spent":"568.515481ms","remote":"127.0.0.1:49572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T13:48:21.426578Z","caller":"traceutil/trace.go:171","msg":"trace[1526927658] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"554.120771ms","start":"2026-05-26T13:48:20.872407Z","end":"2026-05-26T13:48:21.426528Z","steps":["trace[1526927658] 'process raft request' (duration: 553.74168ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:48:21.426699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:48:20.872279Z","time spent":"554.032108ms","remote":"127.0.0.1:49572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T13:48:21.426709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:48:20.872403Z","time spent":"554.239294ms","remote":"127.0.0.1:49572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T13:48:21.4268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:48:20.857486Z","time spent":"568.834771ms","remote":"127.0.0.1:49572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T13:48:21.426813Z","caller":"traceutil/trace.go:171","msg":"trace[1628985451] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"548.545721ms","start":"2026-05-26T13:48:20.87826Z","end":"2026-05-26T13:48:21.426806Z","steps":["trace[1628985451] 'process raft request' (duration: 548.106219ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:48:21.426849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:48:20.878249Z","time spent":"548.586762ms","remote":"127.0.0.1:49572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T13:48:21.426875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:48:20.872347Z","time spent":"554.030917ms","remote":"127.0.0.1:49572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T13:48:21.426974Z","caller":"traceutil/trace.go:171","msg":"trace[1747973536] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"536.233946ms","start":"2026-05-26T13:48:20.890731Z","end":"2026-05-26T13:48:21.426965Z","steps":["trace[1747973536] 'process raft request' (duration: 535.819064ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:48:21.427073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:48:20.890715Z","time spent":"536.283207ms","remote":"127.0.0.1:49572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T13:48:21.427475Z","caller":"traceutil/trace.go:171","msg":"trace[1836690199] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"536.594475ms","start":"2026-05-26T13:48:20.890862Z","end":"2026-05-26T13:48:21.427457Z","steps":["trace[1836690199] 'process raft request' (duration: 536.423061ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:48:21.427568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:48:20.890858Z","time spent":"536.662687ms","remote":"127.0.0.1:49572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T13:48:21.427648Z","caller":"traceutil/trace.go:171","msg":"trace[839656516] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"516.308475ms","start":"2026-05-26T13:48:20.91133Z","end":"2026-05-26T13:48:21.427638Z","steps":["trace[839656516] 'process raft request' (duration: 516.060279ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:48:21.427725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:48:20.911313Z","time spent":"516.392629ms","remote":"127.0.0.1:49572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T13:48:21.427957Z","caller":"traceutil/trace.go:171","msg":"trace[1233265449] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"499.408808ms","start":"2026-05-26T13:48:20.92852Z","end":"2026-05-26T13:48:21.427929Z","steps":["trace[1233265449] 'process raft request' (duration: 498.946844ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:48:21.428157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:48:20.928489Z","time spent":"499.612873ms","remote":"127.0.0.1:49572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T13:48:21.480955Z","caller":"traceutil/trace.go:171","msg":"trace[617971635] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"488.90069ms","start":"2026-05-26T13:48:20.992029Z","end":"2026-05-26T13:48:21.48093Z","steps":["trace[617971635] 'process raft request' (duration: 488.676834ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:48:21.481127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:48:20.992014Z","time spent":"489.032373ms","remote":"127.0.0.1:50012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T13:48:21.481817Z","caller":"traceutil/trace.go:171","msg":"trace[1661898116] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"488.717395ms","start":"2026-05-26T13:48:20.993085Z","end":"2026-05-26T13:48:21.481802Z","steps":["trace[1661898116] 'process raft request' (duration: 488.54986ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:48:21.482148Z","caller":"traceutil/trace.go:171","msg":"trace[350492628] transaction","detail":"{read_only:false; number_of_response:1; response_revision:501; }","duration":"487.941735ms","start":"2026-05-26T13:48:20.994192Z","end":"2026-05-26T13:48:21.482134Z","steps":["trace[350492628] 'process raft request' (duration: 487.536114ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:48:21.482241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:48:20.994182Z","time spent":"488.027988ms","remote":"127.0.0.1:49572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7365,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T13:48:21.482141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:48:20.993075Z","time spent":"488.792356ms","remote":"127.0.0.1:49572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7317,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T13:48:21.482463Z","caller":"traceutil/trace.go:171","msg":"trace[1212999610] linearizableReadLoop","detail":"{readStateIndex:523; appliedIndex:509; }","duration":"264.718933ms","start":"2026-05-26T13:48:21.217735Z","end":"2026-05-26T13:48:21.482454Z","steps":["trace[1212999610] 'read index received' (duration: 208.204155ms)","trace[1212999610] 'applied index is now lower than readState.Index' (duration: 56.514158ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T13:48:21.482575Z","caller":"traceutil/trace.go:171","msg":"trace[841468686] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"452.622817ms","start":"2026-05-26T13:48:21.029944Z","end":"2026-05-26T13:48:21.482567Z","steps":["trace[841468686] 'process raft request' (duration: 452.113263ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:48:21.48265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:48:21.029917Z","time spent":"452.711769ms","remote":"127.0.0.1:49572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T13:48:21.482821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.058002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-26T13:48:21.482949Z","caller":"traceutil/trace.go:171","msg":"trace[126149323] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:502; }","duration":"265.230128ms","start":"2026-05-26T13:48:21.217696Z","end":"2026-05-26T13:48:21.482926Z","steps":["trace[126149323] 'agreement among raft nodes before linearized reading' (duration: 264.907619ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:48:21.71195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.003825ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-26T13:48:21.712245Z","caller":"traceutil/trace.go:171","msg":"trace[810187408] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"279.060874ms","start":"2026-05-26T13:48:21.433133Z","end":"2026-05-26T13:48:21.712194Z","steps":["trace[810187408] 'process raft request' (duration: 155.533204ms)","trace[810187408] 'compare' (duration: 122.882182ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T13:48:21.712333Z","caller":"traceutil/trace.go:171","msg":"trace[422068302] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"279.039814ms","start":"2026-05-26T13:48:21.433255Z","end":"2026-05-26T13:48:21.712295Z","steps":["trace[422068302] 'process raft request' (duration: 278.822407ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:48:21.712459Z","caller":"traceutil/trace.go:171","msg":"trace[1158987660] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"269.163618ms","start":"2026-05-26T13:48:21.443255Z","end":"2026-05-26T13:48:21.712419Z","steps":["trace[1158987660] 'process raft request' (duration: 268.966542ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:48:21.712532Z","caller":"traceutil/trace.go:171","msg":"trace[953716869] linearizableReadLoop","detail":"{readStateIndex:531; appliedIndex:523; }","duration":"230.035055ms","start":"2026-05-26T13:48:21.482486Z","end":"2026-05-26T13:48:21.712521Z","steps":["trace[953716869] 'read index received' (duration: 106.204286ms)","trace[953716869] 'applied index is now lower than readState.Index' (duration: 123.829809ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T13:48:21.712618Z","caller":"traceutil/trace.go:171","msg":"trace[1261275687] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"269.350983ms","start":"2026-05-26T13:48:21.443255Z","end":"2026-05-26T13:48:21.712606Z","steps":["trace[1261275687] 'process raft request' (duration: 269.006084ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:48:21.712616Z","caller":"traceutil/trace.go:171","msg":"trace[1266166850] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"260.099624ms","start":"2026-05-26T13:48:21.452509Z","end":"2026-05-26T13:48:21.712609Z","steps":["trace[1266166850] 'process raft request' (duration: 259.862288ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:48:21.712659Z","caller":"traceutil/trace.go:171","msg":"trace[743968099] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"274.305151ms","start":"2026-05-26T13:48:21.438341Z","end":"2026-05-26T13:48:21.712646Z","steps":["trace[743968099] 'process raft request' (duration: 273.839478ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:48:21.712737Z","caller":"traceutil/trace.go:171","msg":"trace[1093593895] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"264.95445ms","start":"2026-05-26T13:48:21.447554Z","end":"2026-05-26T13:48:21.712508Z","steps":["trace[1093593895] 'process raft request' (duration: 264.740614ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:48:21.712744Z","caller":"traceutil/trace.go:171","msg":"trace[1916831824] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"260.033552ms","start":"2026-05-26T13:48:21.452701Z","end":"2026-05-26T13:48:21.712735Z","steps":["trace[1916831824] 'process raft request' (duration: 259.754595ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:48:21.712841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.728984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T13:48:21.712902Z","caller":"traceutil/trace.go:171","msg":"trace[1567506804] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:510; }","duration":"452.832338ms","start":"2026-05-26T13:48:21.260052Z","end":"2026-05-26T13:48:21.712885Z","steps":["trace[1567506804] 'agreement among raft nodes before linearized reading' (duration: 452.714133ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:48:21.712952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:48:21.260035Z","time spent":"452.905239ms","remote":"127.0.0.1:49528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-26T13:48:21.718221Z","caller":"traceutil/trace.go:171","msg":"trace[1235990702] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"229.393837ms","start":"2026-05-26T13:48:21.488807Z","end":"2026-05-26T13:48:21.7182Z","steps":["trace[1235990702] 'process raft request' (duration: 229.030207ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:48:21.71848Z","caller":"traceutil/trace.go:171","msg":"trace[1924254942] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"227.018401ms","start":"2026-05-26T13:48:21.491452Z","end":"2026-05-26T13:48:21.71847Z","steps":["trace[1924254942] 'process raft request' (duration: 226.431355ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:48:21.718625Z","caller":"traceutil/trace.go:171","msg":"trace[1965663622] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"200.279084ms","start":"2026-05-26T13:48:21.518336Z","end":"2026-05-26T13:48:21.718615Z","steps":["trace[1965663622] 'process raft request' (duration: 199.617026ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:48:21.718766Z","caller":"traceutil/trace.go:171","msg":"trace[429059391] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"166.142491ms","start":"2026-05-26T13:48:21.552603Z","end":"2026-05-26T13:48:21.718745Z","steps":["trace[429059391] 'process raft request' (duration: 165.522213ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:48:21.718812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.308005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-26T13:48:21.718979Z","caller":"traceutil/trace.go:171","msg":"trace[234201517] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:515; }","duration":"195.49143ms","start":"2026-05-26T13:48:21.523458Z","end":"2026-05-26T13:48:21.718949Z","steps":["trace[234201517] 'agreement among raft nodes before linearized reading' (duration: 195.196321ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:48:21.718597Z","caller":"traceutil/trace.go:171","msg":"trace[715108231] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"230.607621ms","start":"2026-05-26T13:48:21.487908Z","end":"2026-05-26T13:48:21.718515Z","steps":["trace[715108231] 'process raft request' (duration: 229.822109ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:48:21.718824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.355706ms","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-05-26T13:48:21.719169Z","caller":"traceutil/trace.go:171","msg":"trace[1358039570] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:515; }","duration":"166.737817ms","start":"2026-05-26T13:48:21.552409Z","end":"2026-05-26T13:48:21.719147Z","steps":["trace[1358039570] 'agreement among raft nodes before linearized reading' (duration: 166.290035ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:48:27.113295Z","caller":"traceutil/trace.go:171","msg":"trace[726460880] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"111.254018ms","start":"2026-05-26T13:48:27.002021Z","end":"2026-05-26T13:48:27.113275Z","steps":["trace[726460880] 'process raft request' (duration: 109.996452ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:48:27.635798Z","caller":"traceutil/trace.go:171","msg":"trace[2078261765] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"112.359078ms","start":"2026-05-26T13:48:27.523407Z","end":"2026-05-26T13:48:27.635766Z","steps":["trace[2078261765] 'process raft request' (duration: 111.789513ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:48:28.480548Z","caller":"traceutil/trace.go:171","msg":"trace[268571455] linearizableReadLoop","detail":"{readStateIndex:626; appliedIndex:625; }","duration":"219.44544ms","start":"2026-05-26T13:48:28.26105Z","end":"2026-05-26T13:48:28.480496Z","steps":["trace[268571455] 'read index received' (duration: 218.338769ms)","trace[268571455] 'applied index is now lower than readState.Index' (duration: 1.105241ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T13:48:28.480718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.648695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T13:48:28.480755Z","caller":"traceutil/trace.go:171","msg":"trace[1102671880] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:601; }","duration":"219.731767ms","start":"2026-05-26T13:48:28.261012Z","end":"2026-05-26T13:48:28.480744Z","steps":["trace[1102671880] 'agreement among raft nodes before linearized reading' (duration: 219.606234ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:48:28.481101Z","caller":"traceutil/trace.go:171","msg":"trace[1949175193] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"255.382012ms","start":"2026-05-26T13:48:28.225647Z","end":"2026-05-26T13:48:28.481029Z","steps":["trace[1949175193] 'process raft request' (duration: 253.999174ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:48:29.039523Z","caller":"traceutil/trace.go:171","msg":"trace[1305001344] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"482.340392ms","start":"2026-05-26T13:48:28.557156Z","end":"2026-05-26T13:48:29.039496Z","steps":["trace[1305001344] 'process raft request' (duration: 481.732734ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:48:29.039675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:48:28.557136Z","time spent":"482.474636ms","remote":"127.0.0.1:49750","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T13:48:29.959406Z","caller":"traceutil/trace.go:171","msg":"trace[2010598307] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"902.575049ms","start":"2026-05-26T13:48:29.056807Z","end":"2026-05-26T13:48:29.959382Z","steps":["trace[2010598307] 'process raft request' (duration: 902.443086ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:48:29.959545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:48:29.056794Z","time spent":"902.690982ms","remote":"127.0.0.1:49708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T13:48:29.977091Z","caller":"traceutil/trace.go:171","msg":"trace[1284998688] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:628; }","duration":"195.1308ms","start":"2026-05-26T13:48:29.781943Z","end":"2026-05-26T13:48:29.977074Z","steps":["trace[1284998688] 'read index received' (duration: 177.338222ms)","trace[1284998688] 'applied index is now lower than readState.Index' (duration: 17.791738ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T13:48:29.977146Z","caller":"traceutil/trace.go:171","msg":"trace[1958397200] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"352.558337ms","start":"2026-05-26T13:48:29.624567Z","end":"2026-05-26T13:48:29.977125Z","steps":["trace[1958397200] 'process raft request' (duration: 352.410073ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:48:29.977249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:48:29.624543Z","time spent":"352.653469ms","remote":"127.0.0.1:49766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T13:48:29.977266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.314974ms","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-05-26T13:48:29.977473Z","caller":"traceutil/trace.go:171","msg":"trace[1404865346] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:605; }","duration":"195.462279ms","start":"2026-05-26T13:48:29.781893Z","end":"2026-05-26T13:48:29.977355Z","steps":["trace[1404865346] 'agreement among raft nodes before linearized reading' (duration: 195.255123ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:48:30.007262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.09153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-26T13:48:30.007325Z","caller":"traceutil/trace.go:171","msg":"trace[302937570] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:609; }","duration":"219.192952ms","start":"2026-05-26T13:48:29.788117Z","end":"2026-05-26T13:48:30.00731Z","steps":["trace[302937570] 'agreement among raft nodes before linearized reading' (duration: 219.034558ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:48:30.007522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.334559ms","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-05-26T13:48:30.007787Z","caller":"traceutil/trace.go:171","msg":"trace[867481468] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:609; }","duration":"198.627529ms","start":"2026-05-26T13:48:29.809152Z","end":"2026-05-26T13:48:30.00778Z","steps":["trace[867481468] 'agreement among raft nodes before linearized reading' (duration: 198.295219ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:48:30.008609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.033412ms","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-05-26T13:48:30.008708Z","caller":"traceutil/trace.go:171","msg":"trace[148884632] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:609; }","duration":"189.233906ms","start":"2026-05-26T13:48:29.819457Z","end":"2026-05-26T13:48:30.008691Z","steps":["trace[148884632] 'agreement among raft nodes before linearized reading' (duration: 187.864917ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:48:46.226899Z","caller":"traceutil/trace.go:171","msg":"trace[1975307648] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"122.803219ms","start":"2026-05-26T13:48:46.104067Z","end":"2026-05-26T13:48:46.22687Z","steps":["trace[1975307648] 'process raft request' (duration: 122.623824ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:48:46.22687Z","caller":"traceutil/trace.go:171","msg":"trace[289648551] linearizableReadLoop","detail":"{readStateIndex:790; appliedIndex:789; }","duration":"122.693418ms","start":"2026-05-26T13:48:46.10415Z","end":"2026-05-26T13:48:46.226843Z","steps":["trace[289648551] 'read index received' (duration: 122.560613ms)","trace[289648551] 'applied index is now lower than readState.Index' (duration: 131.735µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T13:48:46.22715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.970865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-05-26T13:48:46.227306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.320883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-82hgm\" ","response":"range_response_count:1 size:3965"} {"level":"warn","ts":"2026-05-26T13:48:46.227332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.194165ms","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-05-26T13:48:46.227361Z","caller":"traceutil/trace.go:171","msg":"trace[1373928059] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-82hgm; range_end:; response_count:1; response_revision:761; }","duration":"119.386374ms","start":"2026-05-26T13:48:46.107955Z","end":"2026-05-26T13:48:46.227342Z","steps":["trace[1373928059] 'agreement among raft nodes before linearized reading' (duration: 119.249601ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:48:46.227324Z","caller":"traceutil/trace.go:171","msg":"trace[51015768] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:761; }","duration":"123.19209ms","start":"2026-05-26T13:48:46.104108Z","end":"2026-05-26T13:48:46.2273Z","steps":["trace[51015768] 'agreement among raft nodes before linearized reading' (duration: 122.847941ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:48:46.227474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.46494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-26T13:48:46.227507Z","caller":"traceutil/trace.go:171","msg":"trace[1839671074] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:761; }","duration":"117.511162ms","start":"2026-05-26T13:48:46.109988Z","end":"2026-05-26T13:48:46.227499Z","steps":["trace[1839671074] 'agreement among raft nodes before linearized reading' (duration: 117.414909ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:48:46.227374Z","caller":"traceutil/trace.go:171","msg":"trace[1520686538] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:761; }","duration":"102.264386ms","start":"2026-05-26T13:48:46.125098Z","end":"2026-05-26T13:48:46.227362Z","steps":["trace[1520686538] 'agreement among raft nodes before linearized reading' (duration: 102.192614ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:48:46.227778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.578602ms","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-05-26T13:48:46.227829Z","caller":"traceutil/trace.go:171","msg":"trace[1796231483] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:761; }","duration":"118.684255ms","start":"2026-05-26T13:48:46.109132Z","end":"2026-05-26T13:48:46.227816Z","steps":["trace[1796231483] 'agreement among raft nodes before linearized reading' (duration: 118.412437ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:48:46.577233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.869385ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T13:48:46.577412Z","caller":"traceutil/trace.go:171","msg":"trace[1877521257] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"345.817209ms","start":"2026-05-26T13:48:46.231531Z","end":"2026-05-26T13:48:46.577348Z","steps":["trace[1877521257] 'process raft request' (duration: 40.759989ms)","trace[1877521257] 'compare' (duration: 304.749941ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T13:48:46.57756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:48:46.23151Z","time spent":"346.016584ms","remote":"127.0.0.1:49766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T13:48:46.591266Z","caller":"traceutil/trace.go:171","msg":"trace[972718425] linearizableReadLoop","detail":"{readStateIndex:794; appliedIndex:790; }","duration":"332.499946ms","start":"2026-05-26T13:48:46.258749Z","end":"2026-05-26T13:48:46.591249Z","steps":["trace[972718425] 'read index received' (duration: 13.539758ms)","trace[972718425] 'applied index is now lower than readState.Index' (duration: 318.959318ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T13:48:46.591346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.587539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T13:48:46.59134Z","caller":"traceutil/trace.go:171","msg":"trace[788875622] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"358.986076ms","start":"2026-05-26T13:48:46.232336Z","end":"2026-05-26T13:48:46.591322Z","steps":["trace[788875622] 'process raft request' (duration: 358.852743ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:48:46.591369Z","caller":"traceutil/trace.go:171","msg":"trace[1143996375] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:765; }","duration":"332.64738ms","start":"2026-05-26T13:48:46.258713Z","end":"2026-05-26T13:48:46.59136Z","steps":["trace[1143996375] 'agreement among raft nodes before linearized reading' (duration: 332.601309ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:48:46.591459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:48:46.23227Z","time spent":"359.116111ms","remote":"127.0.0.1:49766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T13:48:46.591523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:48:46.258699Z","time spent":"332.687882ms","remote":"127.0.0.1:49528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-26T13:48:46.591611Z","caller":"traceutil/trace.go:171","msg":"trace[2349822] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"359.264774ms","start":"2026-05-26T13:48:46.232321Z","end":"2026-05-26T13:48:46.591586Z","steps":["trace[2349822] 'process raft request' (duration: 358.77304ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:48:46.591793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:48:46.232303Z","time spent":"359.378517ms","remote":"127.0.0.1:49766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T13:48:46.591837Z","caller":"traceutil/trace.go:171","msg":"trace[1180109821] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"357.447214ms","start":"2026-05-26T13:48:46.23436Z","end":"2026-05-26T13:48:46.591807Z","steps":["trace[1180109821] 'process raft request' (duration: 356.856457ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:48:46.591983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:48:46.23435Z","time spent":"357.555066ms","remote":"127.0.0.1:49708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4025,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T13:48:46.59358Z","caller":"traceutil/trace.go:171","msg":"trace[683166075] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"162.107617ms","start":"2026-05-26T13:48:46.431459Z","end":"2026-05-26T13:48:46.593566Z","steps":["trace[683166075] 'process raft request' (duration: 161.744197ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:49:21.167043Z","caller":"traceutil/trace.go:171","msg":"trace[1908958284] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"391.954487ms","start":"2026-05-26T13:49:20.77506Z","end":"2026-05-26T13:49:21.167014Z","steps":["trace[1908958284] 'process raft request' (duration: 317.633472ms)","trace[1908958284] 'compare' (duration: 74.139931ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T13:49:21.167269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:49:20.775041Z","time spent":"392.152122ms","remote":"127.0.0.1:49766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T13:49:21.411403Z","caller":"traceutil/trace.go:171","msg":"trace[804194169] linearizableReadLoop","detail":"{readStateIndex:1019; appliedIndex:1016; }","duration":"150.361899ms","start":"2026-05-26T13:49:21.261019Z","end":"2026-05-26T13:49:21.41138Z","steps":["trace[804194169] 'read index received' (duration: 150.116372ms)","trace[804194169] 'applied index is now lower than readState.Index' (duration: 244.557µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T13:49:21.411532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.500004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T13:49:21.411563Z","caller":"traceutil/trace.go:171","msg":"trace[141729924] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:982; }","duration":"150.584625ms","start":"2026-05-26T13:49:21.260968Z","end":"2026-05-26T13:49:21.411552Z","steps":["trace[141729924] 'agreement among raft nodes before linearized reading' (duration: 150.501263ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:49:21.41159Z","caller":"traceutil/trace.go:171","msg":"trace[167920797] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"636.453296ms","start":"2026-05-26T13:49:20.77512Z","end":"2026-05-26T13:49:21.411574Z","steps":["trace[167920797] 'process raft request' (duration: 636.066325ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:49:21.411612Z","caller":"traceutil/trace.go:171","msg":"trace[562145502] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"636.381864ms","start":"2026-05-26T13:49:20.775211Z","end":"2026-05-26T13:49:21.411593Z","steps":["trace[562145502] 'process raft request' (duration: 636.086937ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:49:21.411682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:49:20.775197Z","time spent":"636.440606ms","remote":"127.0.0.1:49766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T13:49:21.411769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:49:20.775097Z","time spent":"636.536469ms","remote":"127.0.0.1:49766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T13:49:21.411854Z","caller":"traceutil/trace.go:171","msg":"trace[1574470152] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"439.626219ms","start":"2026-05-26T13:49:20.972212Z","end":"2026-05-26T13:49:21.411838Z","steps":["trace[1574470152] 'process raft request' (duration: 439.133414ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:49:21.411953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:49:20.972186Z","time spent":"439.704271ms","remote":"127.0.0.1:49766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T13:49:43.45631Z","caller":"traceutil/trace.go:171","msg":"trace[1360664699] transaction","detail":"{read_only:false; response_revision:1051; number_of_response:1; }","duration":"185.635755ms","start":"2026-05-26T13:49:43.270646Z","end":"2026-05-26T13:49:43.456282Z","steps":["trace[1360664699] 'process raft request' (duration: 185.536543ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:49:45.825409Z","caller":"traceutil/trace.go:171","msg":"trace[1167240963] transaction","detail":"{read_only:false; response_revision:1057; number_of_response:1; }","duration":"359.748546ms","start":"2026-05-26T13:49:45.465637Z","end":"2026-05-26T13:49:45.825385Z","steps":["trace[1167240963] 'process raft request' (duration: 359.617352ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:49:45.825554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:49:45.465617Z","time spent":"359.861629ms","remote":"127.0.0.1:49766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T13:49:46.499711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.527345ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T13:49:46.499846Z","caller":"traceutil/trace.go:171","msg":"trace[2052243067] linearizableReadLoop","detail":"{readStateIndex:1100; appliedIndex:1098; }","duration":"870.227357ms","start":"2026-05-26T13:49:45.629604Z","end":"2026-05-26T13:49:46.499831Z","steps":["trace[2052243067] 'read index received' (duration: 195.708638ms)","trace[2052243067] 'applied index is now lower than readState.Index' (duration: 674.517559ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T13:49:46.500095Z","caller":"traceutil/trace.go:171","msg":"trace[69819136] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"990.561956ms","start":"2026-05-26T13:49:45.509518Z","end":"2026-05-26T13:49:46.50008Z","steps":["trace[69819136] 'process raft request' (duration: 884.581399ms)","trace[69819136] 'compare' (duration: 105.434372ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T13:49:46.500198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:49:45.509485Z","time spent":"990.675871ms","remote":"127.0.0.1:49766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T13:49:46.500235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"844.788853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-26T13:49:46.500365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.323253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T13:49:46.500358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.703859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T13:49:46.500404Z","caller":"traceutil/trace.go:171","msg":"trace[589062872] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1058; }","duration":"239.395905ms","start":"2026-05-26T13:49:46.260997Z","end":"2026-05-26T13:49:46.500393Z","steps":["trace[589062872] 'agreement among raft nodes before linearized reading' (duration: 239.244931ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:49:46.500415Z","caller":"traceutil/trace.go:171","msg":"trace[1883197673] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:1058; }","duration":"357.804671ms","start":"2026-05-26T13:49:46.142593Z","end":"2026-05-26T13:49:46.500398Z","steps":["trace[1883197673] 'agreement among raft nodes before linearized reading' (duration: 357.695888ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:49:46.500457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:49:46.142571Z","time spent":"357.876103ms","remote":"127.0.0.1:47578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-05-26T13:49:46.500449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"870.818463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-26T13:49:46.500474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"755.180655ms","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-05-26T13:49:46.500361Z","caller":"traceutil/trace.go:171","msg":"trace[2068356406] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1058; }","duration":"844.925086ms","start":"2026-05-26T13:49:45.655414Z","end":"2026-05-26T13:49:46.500339Z","steps":["trace[2068356406] 'agreement among raft nodes before linearized reading' (duration: 844.655918ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:49:46.50052Z","caller":"traceutil/trace.go:171","msg":"trace[254999133] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1058; }","duration":"755.259697ms","start":"2026-05-26T13:49:45.745252Z","end":"2026-05-26T13:49:46.500511Z","steps":["trace[254999133] 'agreement among raft nodes before linearized reading' (duration: 755.140934ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:49:46.500525Z","caller":"traceutil/trace.go:171","msg":"trace[1323865252] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1058; }","duration":"870.953747ms","start":"2026-05-26T13:49:45.62955Z","end":"2026-05-26T13:49:46.500503Z","steps":["trace[1323865252] 'agreement among raft nodes before linearized reading' (duration: 870.721191ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:49:46.500555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:49:45.745237Z","time spent":"755.310169ms","remote":"127.0.0.1:49766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-26T13:49:46.500554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:49:45.655358Z","time spent":"845.184693ms","remote":"127.0.0.1:49766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-26T13:49:46.500569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:49:45.629525Z","time spent":"871.035909ms","remote":"127.0.0.1:49766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-26T13:50:01.9411Z","caller":"traceutil/trace.go:171","msg":"trace[1854922907] transaction","detail":"{read_only:false; response_revision:1161; number_of_response:1; }","duration":"314.562277ms","start":"2026-05-26T13:50:01.626512Z","end":"2026-05-26T13:50:01.941074Z","steps":["trace[1854922907] 'process raft request' (duration: 314.411963ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:50:01.941276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:50:01.626488Z","time spent":"314.689411ms","remote":"127.0.0.1:49766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T13:50:02.214596Z","caller":"traceutil/trace.go:171","msg":"trace[1640264895] linearizableReadLoop","detail":"{readStateIndex:1209; appliedIndex:1207; }","duration":"326.150952ms","start":"2026-05-26T13:50:01.888425Z","end":"2026-05-26T13:50:02.214576Z","steps":["trace[1640264895] 'read index received' (duration: 52.566347ms)","trace[1640264895] 'applied index is now lower than readState.Index' (duration: 273.583235ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T13:50:02.214739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.308187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-26T13:50:02.214765Z","caller":"traceutil/trace.go:171","msg":"trace[1486940114] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1161; }","duration":"326.379519ms","start":"2026-05-26T13:50:01.888378Z","end":"2026-05-26T13:50:02.214758Z","steps":["trace[1486940114] 'agreement among raft nodes before linearized reading' (duration: 326.267176ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:50:02.214793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:50:01.888356Z","time spent":"326.43047ms","remote":"127.0.0.1:49766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-26T13:50:14.411079Z","caller":"traceutil/trace.go:171","msg":"trace[1319323498] transaction","detail":"{read_only:false; response_revision:1201; number_of_response:1; }","duration":"146.227337ms","start":"2026-05-26T13:50:14.264824Z","end":"2026-05-26T13:50:14.411051Z","steps":["trace[1319323498] 'process raft request' (duration: 146.079623ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:50:18.915643Z","caller":"traceutil/trace.go:171","msg":"trace[928528644] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"172.812955ms","start":"2026-05-26T13:50:18.742808Z","end":"2026-05-26T13:50:18.915621Z","steps":["trace[928528644] 'process raft request' (duration: 172.568368ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:50:18.915686Z","caller":"traceutil/trace.go:171","msg":"trace[1560295511] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"172.811655ms","start":"2026-05-26T13:50:18.742859Z","end":"2026-05-26T13:50:18.915671Z","steps":["trace[1560295511] 'process raft request' (duration: 172.566688ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:50:18.915948Z","caller":"traceutil/trace.go:171","msg":"trace[1528815621] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"173.153795ms","start":"2026-05-26T13:50:18.742753Z","end":"2026-05-26T13:50:18.915907Z","steps":["trace[1528815621] 'process raft request' (duration: 129.20301ms)","trace[1528815621] 'compare' (duration: 43.318697ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T13:50:20.682058Z","caller":"traceutil/trace.go:171","msg":"trace[891556119] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"247.691749ms","start":"2026-05-26T13:50:20.434347Z","end":"2026-05-26T13:50:20.682039Z","steps":["trace[891556119] 'process raft request' (duration: 247.552244ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:50:21.011437Z","caller":"traceutil/trace.go:171","msg":"trace[938427707] linearizableReadLoop","detail":"{readStateIndex:1307; appliedIndex:1306; }","duration":"290.001027ms","start":"2026-05-26T13:50:20.721408Z","end":"2026-05-26T13:50:21.011409Z","steps":["trace[938427707] 'read index received' (duration: 289.74849ms)","trace[938427707] 'applied index is now lower than readState.Index' (duration: 251.087µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T13:50:21.011571Z","caller":"traceutil/trace.go:171","msg":"trace[649199193] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"322.328415ms","start":"2026-05-26T13:50:20.689231Z","end":"2026-05-26T13:50:21.011559Z","steps":["trace[649199193] 'process raft request' (duration: 322.012446ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:50:21.011714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:50:20.689206Z","time spent":"322.412437ms","remote":"127.0.0.1:49766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T13:50:21.011933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.529842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T13:50:21.011757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.07203ms","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-05-26T13:50:21.011978Z","caller":"traceutil/trace.go:171","msg":"trace[669771282] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:1256; }","duration":"290.610753ms","start":"2026-05-26T13:50:20.721352Z","end":"2026-05-26T13:50:21.011962Z","steps":["trace[669771282] 'agreement among raft nodes before linearized reading' (duration: 290.552702ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:50:21.011984Z","caller":"traceutil/trace.go:171","msg":"trace[1099651913] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1256; }","duration":"216.353069ms","start":"2026-05-26T13:50:20.795618Z","end":"2026-05-26T13:50:21.011971Z","steps":["trace[1099651913] 'agreement among raft nodes before linearized reading' (duration: 215.962478ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:50:21.952786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.337146ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-26T13:50:21.952869Z","caller":"traceutil/trace.go:171","msg":"trace[900129624] linearizableReadLoop","detail":"{readStateIndex:1316; appliedIndex:1315; }","duration":"354.622063ms","start":"2026-05-26T13:50:21.598235Z","end":"2026-05-26T13:50:21.952857Z","steps":["trace[900129624] 'read index received' (duration: 22.104421ms)","trace[900129624] 'applied index is now lower than readState.Index' (duration: 332.516332ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T13:50:21.95294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.698144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T13:50:21.952958Z","caller":"traceutil/trace.go:171","msg":"trace[836771699] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1265; }","duration":"354.755636ms","start":"2026-05-26T13:50:21.598195Z","end":"2026-05-26T13:50:21.95295Z","steps":["trace[836771699] 'agreement among raft nodes before linearized reading' (duration: 354.693014ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:50:21.952981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:50:21.598175Z","time spent":"354.799738ms","remote":"127.0.0.1:60584","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":4,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"info","ts":"2026-05-26T13:50:21.953166Z","caller":"traceutil/trace.go:171","msg":"trace[1061911056] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"450.063523ms","start":"2026-05-26T13:50:21.503093Z","end":"2026-05-26T13:50:21.953157Z","steps":["trace[1061911056] 'process raft request' (duration: 117.299095ms)","trace[1061911056] 'compare' (duration: 332.034388ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T13:50:21.953199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:50:21.503077Z","time spent":"450.105875ms","remote":"127.0.0.1:49766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T13:50:22.36647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.991554ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-26T13:50:22.366725Z","caller":"traceutil/trace.go:171","msg":"trace[304255797] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"405.957355ms","start":"2026-05-26T13:50:21.960748Z","end":"2026-05-26T13:50:22.366705Z","steps":["trace[304255797] 'process raft request' (duration: 405.83762ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:50:22.366834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:50:21.960734Z","time spent":"406.040936ms","remote":"127.0.0.1:49582","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":929,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T13:50:22.366892Z","caller":"traceutil/trace.go:171","msg":"trace[407846240] linearizableReadLoop","detail":"{readStateIndex:1317; appliedIndex:1316; }","duration":"408.527926ms","start":"2026-05-26T13:50:21.958349Z","end":"2026-05-26T13:50:22.366877Z","steps":["trace[407846240] 'read index received' (duration: 227.169991ms)","trace[407846240] 'applied index is now lower than readState.Index' (duration: 181.355355ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T13:50:22.367122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.763312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-05-26T13:50:22.367162Z","caller":"traceutil/trace.go:171","msg":"trace[533069166] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1266; }","duration":"408.831665ms","start":"2026-05-26T13:50:21.95832Z","end":"2026-05-26T13:50:22.367151Z","steps":["trace[533069166] 'agreement among raft nodes before linearized reading' (duration: 408.646119ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:50:22.367193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:50:21.958306Z","time spent":"408.879897ms","remote":"127.0.0.1:49766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":557,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-05-26T13:50:22.367306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.585078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T13:50:22.367365Z","caller":"traceutil/trace.go:171","msg":"trace[616169156] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1266; }","duration":"104.683671ms","start":"2026-05-26T13:50:22.262666Z","end":"2026-05-26T13:50:22.367349Z","steps":["trace[616169156] 'agreement among raft nodes before linearized reading' (duration: 104.604528ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:50:22.652191Z","caller":"traceutil/trace.go:171","msg":"trace[451945413] linearizableReadLoop","detail":"{readStateIndex:1321; appliedIndex:1320; }","duration":"184.276197ms","start":"2026-05-26T13:50:22.467891Z","end":"2026-05-26T13:50:22.652167Z","steps":["trace[451945413] 'read index received' (duration: 9.964591ms)","trace[451945413] 'applied index is now lower than readState.Index' (duration: 174.310576ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T13:50:22.65227Z","caller":"traceutil/trace.go:171","msg":"trace[797496267] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"251.252299ms","start":"2026-05-26T13:50:22.400997Z","end":"2026-05-26T13:50:22.65225Z","steps":["trace[797496267] 'process raft request' (duration: 224.616371ms)","trace[797496267] 'compare' (duration: 26.273578ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T13:50:22.652371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.623867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-05-26T13:50:22.65241Z","caller":"traceutil/trace.go:171","msg":"trace[310567197] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1269; }","duration":"184.699179ms","start":"2026-05-26T13:50:22.467701Z","end":"2026-05-26T13:50:22.6524Z","steps":["trace[310567197] 'agreement among raft nodes before linearized reading' (duration: 184.553425ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:50:23.23867Z","caller":"traceutil/trace.go:171","msg":"trace[2025914044] linearizableReadLoop","detail":"{readStateIndex:1324; appliedIndex:1323; }","duration":"200.970836ms","start":"2026-05-26T13:50:23.03767Z","end":"2026-05-26T13:50:23.238641Z","steps":["trace[2025914044] 'read index received' (duration: 200.711069ms)","trace[2025914044] 'applied index is now lower than readState.Index' (duration: 258.587µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T13:50:23.238722Z","caller":"traceutil/trace.go:171","msg":"trace[467512948] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"221.459861ms","start":"2026-05-26T13:50:23.01723Z","end":"2026-05-26T13:50:23.23869Z","steps":["trace[467512948] 'process raft request' (duration: 221.221564ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:50:23.238966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.267184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-26T13:50:23.239026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.226697ms","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-05-26T13:50:23.239029Z","caller":"traceutil/trace.go:171","msg":"trace[1839524753] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1272; }","duration":"201.394328ms","start":"2026-05-26T13:50:23.037615Z","end":"2026-05-26T13:50:23.239009Z","steps":["trace[1839524753] 'agreement among raft nodes before linearized reading' (duration: 201.188132ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:50:23.239062Z","caller":"traceutil/trace.go:171","msg":"trace[1425430402] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1272; }","duration":"178.31163ms","start":"2026-05-26T13:50:23.06074Z","end":"2026-05-26T13:50:23.239051Z","steps":["trace[1425430402] 'agreement among raft nodes before linearized reading' (duration: 178.148094ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:50:23.239222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.35016ms","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-05-26T13:50:23.239293Z","caller":"traceutil/trace.go:171","msg":"trace[36281563] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1272; }","duration":"178.448923ms","start":"2026-05-26T13:50:23.060827Z","end":"2026-05-26T13:50:23.239276Z","steps":["trace[36281563] 'agreement among raft nodes before linearized reading' (duration: 178.223917ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:50:23.239341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.490373ms","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-05-26T13:50:23.239443Z","caller":"traceutil/trace.go:171","msg":"trace[692236327] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1272; }","duration":"178.631068ms","start":"2026-05-26T13:50:23.060793Z","end":"2026-05-26T13:50:23.239424Z","steps":["trace[692236327] 'agreement among raft nodes before linearized reading' (duration: 178.286758ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:50:23.38043Z","caller":"traceutil/trace.go:171","msg":"trace[1803403836] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"137.837792ms","start":"2026-05-26T13:50:23.242562Z","end":"2026-05-26T13:50:23.3804Z","steps":["trace[1803403836] 'process raft request' (duration: 68.782962ms)","trace[1803403836] 'compare' (duration: 68.937517ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T13:50:23.462238Z","caller":"traceutil/trace.go:171","msg":"trace[535216665] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"218.967371ms","start":"2026-05-26T13:50:23.24325Z","end":"2026-05-26T13:50:23.462217Z","steps":["trace[535216665] 'process raft request' (duration: 218.804456ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:50:23.462458Z","caller":"traceutil/trace.go:171","msg":"trace[1268033395] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"218.57214ms","start":"2026-05-26T13:50:23.243876Z","end":"2026-05-26T13:50:23.462448Z","steps":["trace[1268033395] 'process raft request' (duration: 218.306233ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:50:23.462598Z","caller":"traceutil/trace.go:171","msg":"trace[86227994] linearizableReadLoop","detail":"{readStateIndex:1328; appliedIndex:1324; }","duration":"200.685748ms","start":"2026-05-26T13:50:23.261902Z","end":"2026-05-26T13:50:23.462588Z","steps":["trace[86227994] 'read index received' (duration: 49.45932ms)","trace[86227994] 'applied index is now lower than readState.Index' (duration: 151.225458ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T13:50:23.462676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.76094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T13:50:23.46271Z","caller":"traceutil/trace.go:171","msg":"trace[1620801815] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1276; }","duration":"200.851903ms","start":"2026-05-26T13:50:23.26185Z","end":"2026-05-26T13:50:23.462702Z","steps":["trace[1620801815] 'agreement among raft nodes before linearized reading' (duration: 200.778841ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:50:23.462894Z","caller":"traceutil/trace.go:171","msg":"trace[1698210399] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"218.428716ms","start":"2026-05-26T13:50:23.244435Z","end":"2026-05-26T13:50:23.462864Z","steps":["trace[1698210399] 'process raft request' (duration: 217.979263ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:50:30.850269Z","caller":"traceutil/trace.go:171","msg":"trace[1510808232] transaction","detail":"{read_only:false; response_revision:1323; number_of_response:1; }","duration":"106.253743ms","start":"2026-05-26T13:50:30.743991Z","end":"2026-05-26T13:50:30.850244Z","steps":["trace[1510808232] 'process raft request' (duration: 106.104879ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:51:23.251649Z","caller":"traceutil/trace.go:171","msg":"trace[584468149] transaction","detail":"{read_only:false; response_revision:1563; number_of_response:1; }","duration":"134.854519ms","start":"2026-05-26T13:51:23.116672Z","end":"2026-05-26T13:51:23.251526Z","steps":["trace[584468149] 'process raft request' (duration: 134.575401ms)"],"step_count":1}