{"level":"warn","ts":"2026-05-19T18:50:02.169532Z","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-19T18:50:02.169617Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.152: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.152:2380","--initial-cluster=instance=https://199.19.213.152:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.152:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.152: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-19T18:50:02.169687Z","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-19T18:50:02.169723Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.152:2380"]} {"level":"info","ts":"2026-05-19T18:50:02.16976Z","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-19T18:50:02.170514Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.152:2379"]} {"level":"info","ts":"2026-05-19T18:50:02.170597Z","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.152:2380"],"listen-peer-urls":["https://199.19.213.152:2380"],"advertise-client-urls":["https://199.19.213.152:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.152:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.152: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-19T18:50:02.176105Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.184517ms"} {"level":"info","ts":"2026-05-19T18:50:02.184567Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"68d6d88687e6b830","cluster-id":"8a5d84e8c26d99a1"} {"level":"info","ts":"2026-05-19T18:50:02.184649Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68d6d88687e6b830 switched to configuration voters=()"} {"level":"info","ts":"2026-05-19T18:50:02.184674Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68d6d88687e6b830 became follower at term 0"} {"level":"info","ts":"2026-05-19T18:50:02.184691Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 68d6d88687e6b830 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-19T18:50:02.184704Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68d6d88687e6b830 became follower at term 1"} {"level":"info","ts":"2026-05-19T18:50:02.184741Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68d6d88687e6b830 switched to configuration voters=(7554463497277847600)"} {"level":"warn","ts":"2026-05-19T18:50:02.192143Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-19T18:50:02.193699Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-19T18:50:02.194723Z","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-19T18:50:02.197479Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"68d6d88687e6b830","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-19T18:50:02.197739Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"68d6d88687e6b830","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-19T18:50:02.197879Z","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-19T18:50:02.197951Z","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-19T18:50:02.19797Z","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-19T18:50:02.198527Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68d6d88687e6b830 switched to configuration voters=(7554463497277847600)"} {"level":"info","ts":"2026-05-19T18:50:02.198738Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8a5d84e8c26d99a1","local-member-id":"68d6d88687e6b830","added-peer-id":"68d6d88687e6b830","added-peer-peer-urls":["https://199.19.213.152:2380"]} {"level":"info","ts":"2026-05-19T18:50:02.205386Z","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-19T18:50:02.205569Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"68d6d88687e6b830","initial-advertise-peer-urls":["https://199.19.213.152:2380"],"listen-peer-urls":["https://199.19.213.152:2380"],"advertise-client-urls":["https://199.19.213.152:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.152:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-19T18:50:02.205598Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-19T18:50:02.20569Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.152:2380"} {"level":"info","ts":"2026-05-19T18:50:02.205705Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.152:2380"} {"level":"info","ts":"2026-05-19T18:50:02.985647Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68d6d88687e6b830 is starting a new election at term 1"} {"level":"info","ts":"2026-05-19T18:50:02.98571Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68d6d88687e6b830 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-19T18:50:02.985757Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68d6d88687e6b830 received MsgPreVoteResp from 68d6d88687e6b830 at term 1"} {"level":"info","ts":"2026-05-19T18:50:02.985778Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68d6d88687e6b830 became candidate at term 2"} {"level":"info","ts":"2026-05-19T18:50:02.985802Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68d6d88687e6b830 received MsgVoteResp from 68d6d88687e6b830 at term 2"} {"level":"info","ts":"2026-05-19T18:50:02.985818Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68d6d88687e6b830 became leader at term 2"} {"level":"info","ts":"2026-05-19T18:50:02.985838Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 68d6d88687e6b830 elected leader 68d6d88687e6b830 at term 2"} {"level":"info","ts":"2026-05-19T18:50:02.987016Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"68d6d88687e6b830","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.152:2379]}","request-path":"/0/members/68d6d88687e6b830/attributes","cluster-id":"8a5d84e8c26d99a1","publish-timeout":"7s"} {"level":"info","ts":"2026-05-19T18:50:02.987187Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T18:50:02.987344Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T18:50:02.987633Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T18:50:02.987815Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-19T18:50:02.987855Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-19T18:50:02.988582Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8a5d84e8c26d99a1","local-member-id":"68d6d88687e6b830","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T18:50:02.988648Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T18:50:02.988674Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T18:50:02.990472Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-19T18:50:02.99086Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.152:2379"} {"level":"info","ts":"2026-05-19T18:50:27.036892Z","caller":"traceutil/trace.go:171","msg":"trace[376017693] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"126.86652ms","start":"2026-05-19T18:50:26.910002Z","end":"2026-05-19T18:50:27.036869Z","steps":["trace[376017693] 'process raft request' (duration: 126.625564ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:50:30.397219Z","caller":"traceutil/trace.go:171","msg":"trace[942054044] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"147.679444ms","start":"2026-05-19T18:50:30.249501Z","end":"2026-05-19T18:50:30.397181Z","steps":["trace[942054044] 'process raft request' (duration: 103.422448ms)","trace[942054044] 'compare' (duration: 43.998919ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:50:30.397463Z","caller":"traceutil/trace.go:171","msg":"trace[1141784312] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"145.50177ms","start":"2026-05-19T18:50:30.25194Z","end":"2026-05-19T18:50:30.397442Z","steps":["trace[1141784312] 'process raft request' (duration: 145.306905ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:50:30.397696Z","caller":"traceutil/trace.go:171","msg":"trace[1543245566] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"143.48534ms","start":"2026-05-19T18:50:30.254197Z","end":"2026-05-19T18:50:30.397682Z","steps":["trace[1543245566] 'process raft request' (duration: 143.203623ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:50:30.400926Z","caller":"traceutil/trace.go:171","msg":"trace[209213483] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"145.139721ms","start":"2026-05-19T18:50:30.255757Z","end":"2026-05-19T18:50:30.400897Z","steps":["trace[209213483] 'process raft request' (duration: 141.749357ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:50:32.250999Z","caller":"traceutil/trace.go:171","msg":"trace[399390031] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"358.041679ms","start":"2026-05-19T18:50:31.89293Z","end":"2026-05-19T18:50:32.250972Z","steps":["trace[399390031] 'process raft request' (duration: 357.874375ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:50:32.251573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:50:31.892913Z","time spent":"358.162771ms","remote":"127.0.0.1:49528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T18:50:32.477185Z","caller":"traceutil/trace.go:171","msg":"trace[29960254] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"583.306862ms","start":"2026-05-19T18:50:31.893837Z","end":"2026-05-19T18:50:32.477144Z","steps":["trace[29960254] 'process raft request' (duration: 583.031805ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:50:32.477392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:50:31.893827Z","time spent":"583.478067ms","remote":"127.0.0.1:49528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T18:50:32.477576Z","caller":"traceutil/trace.go:171","msg":"trace[1570774162] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"538.454112ms","start":"2026-05-19T18:50:31.939108Z","end":"2026-05-19T18:50:32.477563Z","steps":["trace[1570774162] 'process raft request' (duration: 538.129444ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:50:32.477631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:50:31.9391Z","time spent":"538.505203ms","remote":"127.0.0.1:49528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T18:50:32.477604Z","caller":"traceutil/trace.go:171","msg":"trace[2116547374] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"381.077169ms","start":"2026-05-19T18:50:32.096504Z","end":"2026-05-19T18:50:32.477581Z","steps":["trace[2116547374] 'process raft request' (duration: 381.016347ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:50:32.477718Z","caller":"traceutil/trace.go:171","msg":"trace[947791115] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"581.410796ms","start":"2026-05-19T18:50:31.896293Z","end":"2026-05-19T18:50:32.477704Z","steps":["trace[947791115] 'process raft request' (duration: 580.732019ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:50:32.477744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:50:32.096471Z","time spent":"381.205032ms","remote":"127.0.0.1:49528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T18:50:32.477789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:50:31.896271Z","time spent":"581.474227ms","remote":"127.0.0.1:49528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T18:50:32.477854Z","caller":"traceutil/trace.go:171","msg":"trace[2050758988] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"532.130886ms","start":"2026-05-19T18:50:31.945717Z","end":"2026-05-19T18:50:32.477848Z","steps":["trace[2050758988] 'process raft request' (duration: 531.582883ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:50:32.477872Z","caller":"traceutil/trace.go:171","msg":"trace[1021028808] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"560.308913ms","start":"2026-05-19T18:50:31.917553Z","end":"2026-05-19T18:50:32.477862Z","steps":["trace[1021028808] 'process raft request' (duration: 559.567845ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:50:32.477899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:50:31.945699Z","time spent":"532.187277ms","remote":"127.0.0.1:49528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T18:50:32.47791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:50:31.917538Z","time spent":"560.353574ms","remote":"127.0.0.1:49528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T18:50:32.477981Z","caller":"traceutil/trace.go:171","msg":"trace[1129170410] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"540.531834ms","start":"2026-05-19T18:50:31.937438Z","end":"2026-05-19T18:50:32.47797Z","steps":["trace[1129170410] 'process raft request' (duration: 539.719814ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:50:32.478006Z","caller":"traceutil/trace.go:171","msg":"trace[357466337] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"530.810703ms","start":"2026-05-19T18:50:31.947191Z","end":"2026-05-19T18:50:32.478001Z","steps":["trace[357466337] 'process raft request' (duration: 530.185758ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:50:32.478026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:50:31.93742Z","time spent":"540.587785ms","remote":"127.0.0.1:49528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T18:50:32.478046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:50:31.947182Z","time spent":"530.837003ms","remote":"127.0.0.1:49528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T18:50:32.477975Z","caller":"traceutil/trace.go:171","msg":"trace[2076590237] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"532.224948ms","start":"2026-05-19T18:50:31.945745Z","end":"2026-05-19T18:50:32.47797Z","steps":["trace[2076590237] 'process raft request' (duration: 531.576312ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:50:32.478114Z","caller":"traceutil/trace.go:171","msg":"trace[478906948] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"523.714477ms","start":"2026-05-19T18:50:31.954379Z","end":"2026-05-19T18:50:32.478094Z","steps":["trace[478906948] 'process raft request' (duration: 523.02576ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:50:32.478151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:50:31.954359Z","time spent":"523.779889ms","remote":"127.0.0.1:49528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T18:50:32.478124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:50:31.945734Z","time spent":"532.368621ms","remote":"127.0.0.1:49528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T18:50:32.478349Z","caller":"traceutil/trace.go:171","msg":"trace[1706404209] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"486.25877ms","start":"2026-05-19T18:50:31.99208Z","end":"2026-05-19T18:50:32.478338Z","steps":["trace[1706404209] 'process raft request' (duration: 485.392549ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:50:32.478417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:50:31.99206Z","time spent":"486.334162ms","remote":"127.0.0.1:49528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T18:50:32.481349Z","caller":"traceutil/trace.go:171","msg":"trace[1990621383] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"222.097085ms","start":"2026-05-19T18:50:32.259227Z","end":"2026-05-19T18:50:32.481324Z","steps":["trace[1990621383] 'process raft request' (duration: 221.983622ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:50:32.481519Z","caller":"traceutil/trace.go:171","msg":"trace[1990563328] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"224.945886ms","start":"2026-05-19T18:50:32.256536Z","end":"2026-05-19T18:50:32.481482Z","steps":["trace[1990563328] 'process raft request' (duration: 224.567617ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:50:34.956195Z","caller":"traceutil/trace.go:171","msg":"trace[809782454] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:606; }","duration":"353.075306ms","start":"2026-05-19T18:50:34.603099Z","end":"2026-05-19T18:50:34.956174Z","steps":["trace[809782454] 'read index received' (duration: 352.898132ms)","trace[809782454] 'applied index is now lower than readState.Index' (duration: 176.074µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:50:34.956306Z","caller":"traceutil/trace.go:171","msg":"trace[497858553] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"397.792133ms","start":"2026-05-19T18:50:34.558492Z","end":"2026-05-19T18:50:34.956284Z","steps":["trace[497858553] 'process raft request' (duration: 397.561087ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:50:34.956424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.303541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-19T18:50:34.956509Z","caller":"traceutil/trace.go:171","msg":"trace[1149022917] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:589; }","duration":"353.440975ms","start":"2026-05-19T18:50:34.603056Z","end":"2026-05-19T18:50:34.956497Z","steps":["trace[1149022917] 'agreement among raft nodes before linearized reading' (duration: 353.24105ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:50:34.956543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:50:34.603043Z","time spent":"353.490486ms","remote":"127.0.0.1:49744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-19T18:50:34.956601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:50:34.558467Z","time spent":"397.886124ms","remote":"127.0.0.1:49744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:50:39.273481Z","caller":"traceutil/trace.go:171","msg":"trace[248372841] linearizableReadLoop","detail":"{readStateIndex:629; appliedIndex:628; }","duration":"318.764207ms","start":"2026-05-19T18:50:38.954667Z","end":"2026-05-19T18:50:39.273431Z","steps":["trace[248372841] 'read index received' (duration: 315.928217ms)","trace[248372841] 'applied index is now lower than readState.Index' (duration: 2.83476ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:50:39.273686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.997202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:50:39.273725Z","caller":"traceutil/trace.go:171","msg":"trace[1656598501] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:610; }","duration":"319.093905ms","start":"2026-05-19T18:50:38.954618Z","end":"2026-05-19T18:50:39.273712Z","steps":["trace[1656598501] 'agreement among raft nodes before linearized reading' (duration: 318.995283ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:50:39.273767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:50:38.954604Z","time spent":"319.153857ms","remote":"127.0.0.1:49472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-19T18:50:39.273781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.586072ms","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-19T18:50:39.273878Z","caller":"traceutil/trace.go:171","msg":"trace[593817869] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:610; }","duration":"301.709496ms","start":"2026-05-19T18:50:38.972153Z","end":"2026-05-19T18:50:39.273862Z","steps":["trace[593817869] 'agreement among raft nodes before linearized reading' (duration: 301.49869ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:50:39.273918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:50:38.972148Z","time spent":"301.759897ms","remote":"127.0.0.1:49744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-19T18:50:39.273503Z","caller":"traceutil/trace.go:171","msg":"trace[1578141864] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"411.750468ms","start":"2026-05-19T18:50:38.861707Z","end":"2026-05-19T18:50:39.273457Z","steps":["trace[1578141864] 'process raft request' (duration: 409.81736ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:50:39.274341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.315393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-19T18:50:39.274392Z","caller":"traceutil/trace.go:171","msg":"trace[627310904] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:610; }","duration":"178.386644ms","start":"2026-05-19T18:50:39.095993Z","end":"2026-05-19T18:50:39.27438Z","steps":["trace[627310904] 'agreement among raft nodes before linearized reading' (duration: 178.22147ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:50:39.27424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:50:38.861676Z","time spent":"412.496366ms","remote":"127.0.0.1:49576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036161,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:50:39.274477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.061147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-19T18:50:39.274555Z","caller":"traceutil/trace.go:171","msg":"trace[204602936] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:610; }","duration":"254.267071ms","start":"2026-05-19T18:50:39.020277Z","end":"2026-05-19T18:50:39.274544Z","steps":["trace[204602936] 'agreement among raft nodes before linearized reading' (duration: 253.999325ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:50:40.2817Z","caller":"traceutil/trace.go:171","msg":"trace[2092306850] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:634; }","duration":"326.93326ms","start":"2026-05-19T18:50:39.954737Z","end":"2026-05-19T18:50:40.281671Z","steps":["trace[2092306850] 'read index received' (duration: 326.466138ms)","trace[2092306850] 'applied index is now lower than readState.Index' (duration: 465.912µs)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:50:40.281827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.081643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:50:40.281864Z","caller":"traceutil/trace.go:171","msg":"trace[1076021935] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:616; }","duration":"327.186176ms","start":"2026-05-19T18:50:39.954661Z","end":"2026-05-19T18:50:40.281848Z","steps":["trace[1076021935] 'agreement among raft nodes before linearized reading' (duration: 327.110164ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:50:40.281899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:50:39.954629Z","time spent":"327.261547ms","remote":"127.0.0.1:49466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-19T18:50:40.281863Z","caller":"traceutil/trace.go:171","msg":"trace[116706488] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"524.312562ms","start":"2026-05-19T18:50:39.757461Z","end":"2026-05-19T18:50:40.281774Z","steps":["trace[116706488] 'process raft request' (duration: 523.694726ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:50:40.282862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:50:39.757444Z","time spent":"524.992949ms","remote":"127.0.0.1:49576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036197,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:50:55.409923Z","caller":"traceutil/trace.go:171","msg":"trace[1254832949] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"467.469577ms","start":"2026-05-19T18:50:54.942429Z","end":"2026-05-19T18:50:55.409899Z","steps":["trace[1254832949] 'process raft request' (duration: 467.245521ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:50:55.410607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:50:54.942421Z","time spent":"468.090732ms","remote":"127.0.0.1:49658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:51:29.84044Z","caller":"traceutil/trace.go:171","msg":"trace[621731718] linearizableReadLoop","detail":"{readStateIndex:1030; appliedIndex:1029; }","duration":"267.086549ms","start":"2026-05-19T18:51:29.573327Z","end":"2026-05-19T18:51:29.840413Z","steps":["trace[621731718] 'read index received' (duration: 266.862233ms)","trace[621731718] 'applied index is now lower than readState.Index' (duration: 223.396µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:51:29.84074Z","caller":"traceutil/trace.go:171","msg":"trace[1539646560] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"517.13242ms","start":"2026-05-19T18:51:29.323562Z","end":"2026-05-19T18:51:29.840694Z","steps":["trace[1539646560] 'process raft request' (duration: 516.700588ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:51:29.840916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.564882ms","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-19T18:51:29.840931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:51:29.323531Z","time spent":"517.299484ms","remote":"127.0.0.1:49744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:51:29.840993Z","caller":"traceutil/trace.go:171","msg":"trace[1893379821] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:995; }","duration":"267.711775ms","start":"2026-05-19T18:51:29.573267Z","end":"2026-05-19T18:51:29.840979Z","steps":["trace[1893379821] 'agreement among raft nodes before linearized reading' (duration: 267.48799ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:51:29.841068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.894144ms","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-19T18:51:29.84115Z","caller":"traceutil/trace.go:171","msg":"trace[2021855401] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:995; }","duration":"257.000926ms","start":"2026-05-19T18:51:29.584131Z","end":"2026-05-19T18:51:29.841132Z","steps":["trace[2021855401] 'agreement among raft nodes before linearized reading' (duration: 256.75599ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:51:29.841046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.723605ms","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-19T18:51:29.841279Z","caller":"traceutil/trace.go:171","msg":"trace[1123057447] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:995; }","duration":"261.985872ms","start":"2026-05-19T18:51:29.579263Z","end":"2026-05-19T18:51:29.841249Z","steps":["trace[1123057447] 'agreement among raft nodes before linearized reading' (duration: 261.554111ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:51:29.841429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.852112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-19T18:51:29.841675Z","caller":"traceutil/trace.go:171","msg":"trace[353814501] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:995; }","duration":"257.14103ms","start":"2026-05-19T18:51:29.584523Z","end":"2026-05-19T18:51:29.841665Z","steps":["trace[353814501] 'agreement among raft nodes before linearized reading' (duration: 256.308799ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:51:30.433885Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13272282106334302310,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-19T18:51:30.666343Z","caller":"traceutil/trace.go:171","msg":"trace[699408756] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"822.114058ms","start":"2026-05-19T18:51:29.84421Z","end":"2026-05-19T18:51:30.666324Z","steps":["trace[699408756] 'process raft request' (duration: 821.992995ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:51:30.666461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:51:29.844188Z","time spent":"822.206701ms","remote":"127.0.0.1:49744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:51:30.667043Z","caller":"traceutil/trace.go:171","msg":"trace[1922952402] linearizableReadLoop","detail":"{readStateIndex:1035; appliedIndex:1030; }","duration":"733.336823ms","start":"2026-05-19T18:51:29.933689Z","end":"2026-05-19T18:51:30.667026Z","steps":["trace[1922952402] 'read index received' (duration: 732.582513ms)","trace[1922952402] 'applied index is now lower than readState.Index' (duration: 753.71µs)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:51:30.667205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"733.510017ms","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-19T18:51:30.667239Z","caller":"traceutil/trace.go:171","msg":"trace[1968042518] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1000; }","duration":"733.598999ms","start":"2026-05-19T18:51:29.933631Z","end":"2026-05-19T18:51:30.66723Z","steps":["trace[1968042518] 'agreement among raft nodes before linearized reading' (duration: 733.464776ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:51:30.667267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:51:29.933606Z","time spent":"733.655101ms","remote":"127.0.0.1:49744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-19T18:51:30.667386Z","caller":"traceutil/trace.go:171","msg":"trace[38544582] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"775.757036ms","start":"2026-05-19T18:51:29.891615Z","end":"2026-05-19T18:51:30.667372Z","steps":["trace[38544582] 'process raft request' (duration: 775.375797ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:51:30.667438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:51:29.891607Z","time spent":"775.803247ms","remote":"127.0.0.1:49744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:51:30.667431Z","caller":"traceutil/trace.go:171","msg":"trace[1978100823] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"821.793172ms","start":"2026-05-19T18:51:29.845606Z","end":"2026-05-19T18:51:30.667399Z","steps":["trace[1978100823] 'process raft request' (duration: 821.338431ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:51:30.66747Z","caller":"traceutil/trace.go:171","msg":"trace[2055249984] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"821.066663ms","start":"2026-05-19T18:51:29.846396Z","end":"2026-05-19T18:51:30.667463Z","steps":["trace[2055249984] 'process raft request' (duration: 820.57302ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:51:30.667536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:51:29.846377Z","time spent":"821.114444ms","remote":"127.0.0.1:49744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:51:30.667616Z","caller":"traceutil/trace.go:171","msg":"trace[2111017734] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"823.166445ms","start":"2026-05-19T18:51:29.844443Z","end":"2026-05-19T18:51:30.66761Z","steps":["trace[2111017734] 'process raft request' (duration: 822.429797ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:51:30.667652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:51:29.844427Z","time spent":"823.204047ms","remote":"127.0.0.1:49744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:51:30.667689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:51:29.845588Z","time spent":"821.891144ms","remote":"127.0.0.1:49744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:51:52.00703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.569801ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-19T18:51:52.007139Z","caller":"traceutil/trace.go:171","msg":"trace[1711508779] linearizableReadLoop","detail":"{readStateIndex:1107; appliedIndex:1106; }","duration":"532.362752ms","start":"2026-05-19T18:51:51.474756Z","end":"2026-05-19T18:51:52.007119Z","steps":["trace[1711508779] 'read index received' (duration: 191.221467ms)","trace[1711508779] 'applied index is now lower than readState.Index' (duration: 341.139695ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:51:52.007282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.520035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:51:52.00731Z","caller":"traceutil/trace.go:171","msg":"trace[977093987] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1067; }","duration":"532.562257ms","start":"2026-05-19T18:51:51.474738Z","end":"2026-05-19T18:51:52.007301Z","steps":["trace[977093987] 'agreement among raft nodes before linearized reading' (duration: 532.488185ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:51:52.007342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:51:51.474671Z","time spent":"532.661559ms","remote":"127.0.0.1:49626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"info","ts":"2026-05-19T18:51:52.888623Z","caller":"traceutil/trace.go:171","msg":"trace[479302100] linearizableReadLoop","detail":"{readStateIndex:1108; appliedIndex:1107; }","duration":"110.354378ms","start":"2026-05-19T18:51:52.778243Z","end":"2026-05-19T18:51:52.888598Z","steps":["trace[479302100] 'read index received' (duration: 110.128532ms)","trace[479302100] 'applied index is now lower than readState.Index' (duration: 224.206µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:51:52.888657Z","caller":"traceutil/trace.go:171","msg":"trace[1568720117] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"141.204341ms","start":"2026-05-19T18:51:52.747427Z","end":"2026-05-19T18:51:52.888631Z","steps":["trace[1568720117] 'process raft request' (duration: 140.996886ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:51:52.888946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.685306ms","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-19T18:51:52.888959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.451065ms","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-19T18:51:52.889001Z","caller":"traceutil/trace.go:171","msg":"trace[1782397425] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1068; }","duration":"110.84853ms","start":"2026-05-19T18:51:52.778137Z","end":"2026-05-19T18:51:52.888985Z","steps":["trace[1782397425] 'agreement among raft nodes before linearized reading' (duration: 110.609324ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:51:52.88903Z","caller":"traceutil/trace.go:171","msg":"trace[1408056334] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1068; }","duration":"103.560348ms","start":"2026-05-19T18:51:52.785452Z","end":"2026-05-19T18:51:52.889013Z","steps":["trace[1408056334] 'agreement among raft nodes before linearized reading' (duration: 103.386013ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:51:52.889108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.902632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-19T18:51:52.88917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.023764ms","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-19T18:51:52.88923Z","caller":"traceutil/trace.go:171","msg":"trace[1632820312] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1068; }","duration":"103.117327ms","start":"2026-05-19T18:51:52.786098Z","end":"2026-05-19T18:51:52.889215Z","steps":["trace[1632820312] 'agreement among raft nodes before linearized reading' (duration: 102.926572ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:51:52.889225Z","caller":"traceutil/trace.go:171","msg":"trace[810454724] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1068; }","duration":"109.045735ms","start":"2026-05-19T18:51:52.780151Z","end":"2026-05-19T18:51:52.889197Z","steps":["trace[810454724] 'agreement among raft nodes before linearized reading' (duration: 108.683216ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:51:52.889267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.219109ms","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-19T18:51:52.889328Z","caller":"traceutil/trace.go:171","msg":"trace[1963585528] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1068; }","duration":"105.327331ms","start":"2026-05-19T18:51:52.783987Z","end":"2026-05-19T18:51:52.889315Z","steps":["trace[1963585528] 'agreement among raft nodes before linearized reading' (duration: 105.174587ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:51:53.159838Z","caller":"traceutil/trace.go:171","msg":"trace[289939201] transaction","detail":"{read_only:false; response_revision:1071; number_of_response:1; }","duration":"265.071269ms","start":"2026-05-19T18:51:52.894732Z","end":"2026-05-19T18:51:53.159804Z","steps":["trace[289939201] 'process raft request' (duration: 265.013528ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:51:53.159965Z","caller":"traceutil/trace.go:171","msg":"trace[288967820] transaction","detail":"{read_only:false; response_revision:1069; number_of_response:1; }","duration":"265.155232ms","start":"2026-05-19T18:51:52.894733Z","end":"2026-05-19T18:51:53.159888Z","steps":["trace[288967820] 'process raft request' (duration: 264.749402ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:51:53.159968Z","caller":"traceutil/trace.go:171","msg":"trace[960054962] transaction","detail":"{read_only:false; response_revision:1070; number_of_response:1; }","duration":"265.168872ms","start":"2026-05-19T18:51:52.894731Z","end":"2026-05-19T18:51:53.1599Z","steps":["trace[960054962] 'process raft request' (duration: 264.932436ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:51:53.188471Z","caller":"traceutil/trace.go:171","msg":"trace[1391404131] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"293.589085ms","start":"2026-05-19T18:51:52.894852Z","end":"2026-05-19T18:51:53.188441Z","steps":["trace[1391404131] 'process raft request' (duration: 293.543733ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:51:53.188591Z","caller":"traceutil/trace.go:171","msg":"trace[1086114941] transaction","detail":"{read_only:false; response_revision:1072; number_of_response:1; }","duration":"293.775489ms","start":"2026-05-19T18:51:52.894776Z","end":"2026-05-19T18:51:53.188552Z","steps":["trace[1086114941] 'process raft request' (duration: 293.449181ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:51:55.309125Z","caller":"traceutil/trace.go:171","msg":"trace[2085596645] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"140.655908ms","start":"2026-05-19T18:51:55.168438Z","end":"2026-05-19T18:51:55.309093Z","steps":["trace[2085596645] 'process raft request' (duration: 140.442763ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:51:55.347148Z","caller":"traceutil/trace.go:171","msg":"trace[355980925] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"178.573069ms","start":"2026-05-19T18:51:55.168539Z","end":"2026-05-19T18:51:55.347112Z","steps":["trace[355980925] 'process raft request' (duration: 178.417256ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:51:55.347253Z","caller":"traceutil/trace.go:171","msg":"trace[397819268] linearizableReadLoop","detail":"{readStateIndex:1117; appliedIndex:1114; }","duration":"153.689775ms","start":"2026-05-19T18:51:55.19354Z","end":"2026-05-19T18:51:55.34723Z","steps":["trace[397819268] 'read index received' (duration: 115.300882ms)","trace[397819268] 'applied index is now lower than readState.Index' (duration: 38.386323ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:51:55.34737Z","caller":"traceutil/trace.go:171","msg":"trace[51598691] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"178.483538ms","start":"2026-05-19T18:51:55.168853Z","end":"2026-05-19T18:51:55.347336Z","steps":["trace[51598691] 'process raft request' (duration: 178.197571ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:51:55.347441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.875741ms","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-19T18:51:55.347783Z","caller":"traceutil/trace.go:171","msg":"trace[741858747] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1077; }","duration":"154.297241ms","start":"2026-05-19T18:51:55.193472Z","end":"2026-05-19T18:51:55.347769Z","steps":["trace[741858747] 'agreement among raft nodes before linearized reading' (duration: 153.807619ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:51:55.347909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.8471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-19T18:51:55.347978Z","caller":"traceutil/trace.go:171","msg":"trace[572874203] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1077; }","duration":"153.938831ms","start":"2026-05-19T18:51:55.194027Z","end":"2026-05-19T18:51:55.347966Z","steps":["trace[572874203] 'agreement among raft nodes before linearized reading' (duration: 153.699276ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:52:10.828738Z","caller":"traceutil/trace.go:171","msg":"trace[941409656] transaction","detail":"{read_only:false; response_revision:1187; number_of_response:1; }","duration":"334.761487ms","start":"2026-05-19T18:52:10.493935Z","end":"2026-05-19T18:52:10.828697Z","steps":["trace[941409656] 'process raft request' (duration: 334.556772ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:52:10.828955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:52:10.49391Z","time spent":"334.930991ms","remote":"127.0.0.1:49744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:52:11.204057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.515778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:52:11.204147Z","caller":"traceutil/trace.go:171","msg":"trace[69080561] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1187; }","duration":"251.669862ms","start":"2026-05-19T18:52:10.952456Z","end":"2026-05-19T18:52:11.204126Z","steps":["trace[69080561] 'range keys from in-memory index tree' (duration: 251.384675ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:52:11.204448Z","caller":"traceutil/trace.go:171","msg":"trace[586369661] transaction","detail":"{read_only:false; response_revision:1188; number_of_response:1; }","duration":"195.125964ms","start":"2026-05-19T18:52:11.009275Z","end":"2026-05-19T18:52:11.204401Z","steps":["trace[586369661] 'process raft request' (duration: 191.490164ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:52:11.208457Z","caller":"traceutil/trace.go:171","msg":"trace[1820751224] transaction","detail":"{read_only:false; response_revision:1189; number_of_response:1; }","duration":"176.924728ms","start":"2026-05-19T18:52:11.031518Z","end":"2026-05-19T18:52:11.208443Z","steps":["trace[1820751224] 'process raft request' (duration: 176.599279ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:52:24.427976Z","caller":"traceutil/trace.go:171","msg":"trace[642165180] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"134.340959ms","start":"2026-05-19T18:52:24.293591Z","end":"2026-05-19T18:52:24.427932Z","steps":["trace[642165180] 'process raft request' (duration: 67.488673ms)","trace[642165180] 'compare' (duration: 66.497027ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:52:24.427971Z","caller":"traceutil/trace.go:171","msg":"trace[953236431] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"133.868897ms","start":"2026-05-19T18:52:24.294037Z","end":"2026-05-19T18:52:24.427906Z","steps":["trace[953236431] 'process raft request' (duration: 133.747054ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:52:24.428722Z","caller":"traceutil/trace.go:171","msg":"trace[1854723535] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"129.403008ms","start":"2026-05-19T18:52:24.299301Z","end":"2026-05-19T18:52:24.428704Z","steps":["trace[1854723535] 'process raft request' (duration: 128.538216ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:52:25.029501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.962808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:52:25.029617Z","caller":"traceutil/trace.go:171","msg":"trace[1593842608] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1246; }","duration":"350.135072ms","start":"2026-05-19T18:52:24.679451Z","end":"2026-05-19T18:52:25.029586Z","steps":["trace[1593842608] 'count revisions from in-memory index tree' (duration: 349.849466ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:52:25.029675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:52:24.679423Z","time spent":"350.238475ms","remote":"127.0.0.1:44702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"info","ts":"2026-05-19T18:52:25.366312Z","caller":"traceutil/trace.go:171","msg":"trace[1199854067] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"123.35239ms","start":"2026-05-19T18:52:25.242922Z","end":"2026-05-19T18:52:25.366274Z","steps":["trace[1199854067] 'process raft request' (duration: 123.179146ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:52:26.078101Z","caller":"traceutil/trace.go:171","msg":"trace[235111994] transaction","detail":"{read_only:false; response_revision:1253; number_of_response:1; }","duration":"381.85546ms","start":"2026-05-19T18:52:25.696203Z","end":"2026-05-19T18:52:26.078059Z","steps":["trace[235111994] 'process raft request' (duration: 381.687085ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:52:26.078227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.724325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.152\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-19T18:52:26.078266Z","caller":"traceutil/trace.go:171","msg":"trace[1894113926] range","detail":"{range_begin:/registry/masterleases/199.19.213.152; range_end:; response_count:1; response_revision:1253; }","duration":"131.830068ms","start":"2026-05-19T18:52:25.946428Z","end":"2026-05-19T18:52:26.078258Z","steps":["trace[1894113926] 'agreement among raft nodes before linearized reading' (duration: 131.674244ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:52:26.078285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:52:25.69618Z","time spent":"382.003263ms","remote":"127.0.0.1:49556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":783,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T18:52:26.078054Z","caller":"traceutil/trace.go:171","msg":"trace[1624794363] linearizableReadLoop","detail":"{readStateIndex:1301; appliedIndex:1300; }","duration":"131.52839ms","start":"2026-05-19T18:52:25.946496Z","end":"2026-05-19T18:52:26.078024Z","steps":["trace[1624794363] 'read index received' (duration: 131.341625ms)","trace[1624794363] 'applied index is now lower than readState.Index' (duration: 186.114µs)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:52:26.078492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.650278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:52:26.078511Z","caller":"traceutil/trace.go:171","msg":"trace[1166560940] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1253; }","duration":"123.687688ms","start":"2026-05-19T18:52:25.954817Z","end":"2026-05-19T18:52:26.078505Z","steps":["trace[1166560940] 'agreement among raft nodes before linearized reading' (duration: 123.659367ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:52:26.67631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.698441ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-05-19T18:52:26.676648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:52:26.079104Z","time spent":"597.532589ms","remote":"127.0.0.1:49510","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-05-19T18:52:26.676746Z","caller":"traceutil/trace.go:171","msg":"trace[1146525643] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"267.10869ms","start":"2026-05-19T18:52:26.409613Z","end":"2026-05-19T18:52:26.676722Z","steps":["trace[1146525643] 'process raft request' (duration: 266.819043ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:52:26.677072Z","caller":"traceutil/trace.go:171","msg":"trace[975346205] linearizableReadLoop","detail":"{readStateIndex:1302; appliedIndex:1301; }","duration":"597.341445ms","start":"2026-05-19T18:52:26.079708Z","end":"2026-05-19T18:52:26.677049Z","steps":["trace[975346205] 'read index received' (duration: 398.896706ms)","trace[975346205] 'applied index is now lower than readState.Index' (duration: 198.442579ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:52:26.677224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.496198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:52:26.677264Z","caller":"traceutil/trace.go:171","msg":"trace[1509076349] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1254; }","duration":"597.600821ms","start":"2026-05-19T18:52:26.079653Z","end":"2026-05-19T18:52:26.677254Z","steps":["trace[1509076349] 'agreement among raft nodes before linearized reading' (duration: 597.464297ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:52:26.677293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:52:26.079629Z","time spent":"597.657792ms","remote":"127.0.0.1:49472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-19T18:52:27.530634Z","caller":"traceutil/trace.go:171","msg":"trace[1084032012] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"159.522836ms","start":"2026-05-19T18:52:27.371074Z","end":"2026-05-19T18:52:27.530597Z","steps":["trace[1084032012] 'process raft request' (duration: 159.314881ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:52:27.878644Z","caller":"traceutil/trace.go:171","msg":"trace[1134987860] linearizableReadLoop","detail":"{readStateIndex:1308; appliedIndex:1307; }","duration":"293.414313ms","start":"2026-05-19T18:52:27.585195Z","end":"2026-05-19T18:52:27.878609Z","steps":["trace[1134987860] 'read index received' (duration: 257.775481ms)","trace[1134987860] 'applied index is now lower than readState.Index' (duration: 35.637292ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:52:27.878696Z","caller":"traceutil/trace.go:171","msg":"trace[1595201017] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"293.697491ms","start":"2026-05-19T18:52:27.584965Z","end":"2026-05-19T18:52:27.878663Z","steps":["trace[1595201017] 'process raft request' (duration: 258.101171ms)","trace[1595201017] 'compare' (duration: 35.18162ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:52:27.878799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.577327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:52:27.878834Z","caller":"traceutil/trace.go:171","msg":"trace[1165463417] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:1259; }","duration":"293.644249ms","start":"2026-05-19T18:52:27.58518Z","end":"2026-05-19T18:52:27.878824Z","steps":["trace[1165463417] 'agreement among raft nodes before linearized reading' (duration: 293.568117ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:52:27.878988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.376935ms","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-19T18:52:27.879035Z","caller":"traceutil/trace.go:171","msg":"trace[366129903] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1259; }","duration":"271.449036ms","start":"2026-05-19T18:52:27.607572Z","end":"2026-05-19T18:52:27.879021Z","steps":["trace[366129903] 'agreement among raft nodes before linearized reading' (duration: 271.264222ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:52:27.879071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.258739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-19T18:52:27.879086Z","caller":"traceutil/trace.go:171","msg":"trace[1412148472] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1259; }","duration":"197.331632ms","start":"2026-05-19T18:52:27.68175Z","end":"2026-05-19T18:52:27.879081Z","steps":["trace[1412148472] 'agreement among raft nodes before linearized reading' (duration: 197.2785ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:52:27.879154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.731891ms","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-19T18:52:27.879145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.243038ms","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-19T18:52:27.879365Z","caller":"traceutil/trace.go:171","msg":"trace[77169761] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1259; }","duration":"197.960067ms","start":"2026-05-19T18:52:27.6814Z","end":"2026-05-19T18:52:27.87936Z","steps":["trace[77169761] 'agreement among raft nodes before linearized reading' (duration: 197.726671ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:52:27.879431Z","caller":"traceutil/trace.go:171","msg":"trace[205593714] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1259; }","duration":"197.559758ms","start":"2026-05-19T18:52:27.68186Z","end":"2026-05-19T18:52:27.879419Z","steps":["trace[205593714] 'agreement among raft nodes before linearized reading' (duration: 197.150737ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:52:39.753589Z","caller":"traceutil/trace.go:171","msg":"trace[1954027352] linearizableReadLoop","detail":"{readStateIndex:1398; appliedIndex:1397; }","duration":"148.440174ms","start":"2026-05-19T18:52:39.605115Z","end":"2026-05-19T18:52:39.753555Z","steps":["trace[1954027352] 'read index received' (duration: 148.211889ms)","trace[1954027352] 'applied index is now lower than readState.Index' (duration: 227.055µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:52:39.753737Z","caller":"traceutil/trace.go:171","msg":"trace[2066263371] transaction","detail":"{read_only:false; response_revision:1347; number_of_response:1; }","duration":"182.960179ms","start":"2026-05-19T18:52:39.570723Z","end":"2026-05-19T18:52:39.753683Z","steps":["trace[2066263371] 'process raft request' (duration: 182.638522ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:52:39.753802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.653719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T18:52:39.753895Z","caller":"traceutil/trace.go:171","msg":"trace[1901474198] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1347; }","duration":"148.838944ms","start":"2026-05-19T18:52:39.605038Z","end":"2026-05-19T18:52:39.753877Z","steps":["trace[1901474198] 'agreement among raft nodes before linearized reading' (duration: 148.66892ms)"],"step_count":1}