{"level":"warn","ts":"2026-07-25T10:31:01.824788Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-25T10:31:01.824868Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.53:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.53:2380","--initial-cluster=instance=https://199.204.45.53:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.53:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.53: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-07-25T10:31:01.824934Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-25T10:31:01.824941Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-07-25T10:31:01.82496Z","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-07-25T10:31:01.825554Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"]} {"level":"info","ts":"2026-07-25T10:31:01.825713Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.53: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-07-25T10:31:01.831616Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.688306ms"} {"level":"info","ts":"2026-07-25T10:31:01.841506Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c47ca1a7b1fe506b","cluster-id":"95bd21e158fabf07"} {"level":"info","ts":"2026-07-25T10:31:01.841612Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=()"} {"level":"info","ts":"2026-07-25T10:31:01.841633Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 0"} {"level":"info","ts":"2026-07-25T10:31:01.841643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c47ca1a7b1fe506b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-25T10:31:01.841652Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 1"} {"level":"info","ts":"2026-07-25T10:31:01.841684Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"warn","ts":"2026-07-25T10:31:01.851536Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-25T10:31:01.852769Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-25T10:31:01.858362Z","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-07-25T10:31:01.860384Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c47ca1a7b1fe506b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-25T10:31:01.860813Z","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-07-25T10:31:01.860892Z","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-07-25T10:31:01.860914Z","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-07-25T10:31:01.860883Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c47ca1a7b1fe506b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-25T10:31:01.862756Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"info","ts":"2026-07-25T10:31:01.863897Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","added-peer-id":"c47ca1a7b1fe506b","added-peer-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-07-25T10:31:01.866185Z","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-07-25T10:31:01.866479Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c47ca1a7b1fe506b","initial-advertise-peer-urls":["https://199.204.45.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-25T10:31:01.866527Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-25T10:31:01.866609Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-07-25T10:31:01.866634Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-07-25T10:31:02.8428Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b is starting a new election at term 1"} {"level":"info","ts":"2026-07-25T10:31:02.842863Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became pre-candidate at term 1"} {"level":"info","ts":"2026-07-25T10:31:02.842899Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgPreVoteResp from c47ca1a7b1fe506b at term 1"} {"level":"info","ts":"2026-07-25T10:31:02.842921Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became candidate at term 2"} {"level":"info","ts":"2026-07-25T10:31:02.842948Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgVoteResp from c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-07-25T10:31:02.842968Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became leader at term 2"} {"level":"info","ts":"2026-07-25T10:31:02.842988Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c47ca1a7b1fe506b elected leader c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-07-25T10:31:02.844015Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T10:31:02.844882Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-25T10:31:02.844883Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c47ca1a7b1fe506b","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.53:2379]}","request-path":"/0/members/c47ca1a7b1fe506b/attributes","cluster-id":"95bd21e158fabf07","publish-timeout":"7s"} {"level":"info","ts":"2026-07-25T10:31:02.845063Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-25T10:31:02.845354Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T10:31:02.845332Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-25T10:31:02.845415Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-25T10:31:02.845504Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T10:31:02.845601Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T10:31:02.847978Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-25T10:31:02.848983Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.53:2379"} {"level":"info","ts":"2026-07-25T10:31:04.490016Z","caller":"traceutil/trace.go:171","msg":"trace[1923617230] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"361.405506ms","start":"2026-07-25T10:31:04.12858Z","end":"2026-07-25T10:31:04.489986Z","steps":["trace[1923617230] 'process raft request' (duration: 361.154514ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:04.490945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:04.128566Z","time spent":"361.587028ms","remote":"127.0.0.1:33750","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T10:31:05.021733Z","caller":"traceutil/trace.go:171","msg":"trace[125564292] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"815.772206ms","start":"2026-07-25T10:31:04.205913Z","end":"2026-07-25T10:31:05.021686Z","steps":["trace[125564292] 'process raft request' (duration: 815.631624ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:05.021911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:04.205902Z","time spent":"815.922557ms","remote":"127.0.0.1:34074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T10:31:05.021976Z","caller":"traceutil/trace.go:171","msg":"trace[1686863736] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"888.266663ms","start":"2026-07-25T10:31:04.133679Z","end":"2026-07-25T10:31:05.021946Z","steps":["trace[1686863736] 'read index received' (duration: 356.021594ms)","trace[1686863736] 'applied index is now lower than readState.Index' (duration: 532.243859ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:31:05.022064Z","caller":"traceutil/trace.go:171","msg":"trace[983493442] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"815.680105ms","start":"2026-07-25T10:31:04.206368Z","end":"2026-07-25T10:31:05.022048Z","steps":["trace[983493442] 'process raft request' (duration: 815.421483ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:05.022117Z","caller":"traceutil/trace.go:171","msg":"trace[521751347] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"815.704236ms","start":"2026-07-25T10:31:04.206399Z","end":"2026-07-25T10:31:05.022103Z","steps":["trace[521751347] 'process raft request' (duration: 815.426413ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:05.022118Z","caller":"traceutil/trace.go:171","msg":"trace[1757798348] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"815.837546ms","start":"2026-07-25T10:31:04.206244Z","end":"2026-07-25T10:31:05.022081Z","steps":["trace[1757798348] 'process raft request' (duration: 815.377472ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:05.022163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:04.206364Z","time spent":"815.737326ms","remote":"127.0.0.1:34140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T10:31:05.022227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:04.206395Z","time spent":"815.759626ms","remote":"127.0.0.1:34140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T10:31:05.022253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:04.206238Z","time spent":"815.949867ms","remote":"127.0.0.1:34140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T10:31:05.022345Z","caller":"traceutil/trace.go:171","msg":"trace[803141545] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"816.017278ms","start":"2026-07-25T10:31:04.206316Z","end":"2026-07-25T10:31:05.022334Z","steps":["trace[803141545] 'process raft request' (duration: 815.344131ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:05.022382Z","caller":"traceutil/trace.go:171","msg":"trace[2110327006] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"788.966188ms","start":"2026-07-25T10:31:04.233406Z","end":"2026-07-25T10:31:05.022372Z","steps":["trace[2110327006] 'process raft request' (duration: 788.493154ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:05.022402Z","caller":"traceutil/trace.go:171","msg":"trace[1253723865] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"816.046178ms","start":"2026-07-25T10:31:04.206343Z","end":"2026-07-25T10:31:05.022389Z","steps":["trace[1253723865] 'process raft request' (duration: 815.410912ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:05.022425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:04.233391Z","time spent":"789.013588ms","remote":"127.0.0.1:33914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T10:31:05.022392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:04.206313Z","time spent":"816.058458ms","remote":"127.0.0.1:34140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T10:31:05.022461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:04.206339Z","time spent":"816.093229ms","remote":"127.0.0.1:34140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T10:31:05.022469Z","caller":"traceutil/trace.go:171","msg":"trace[1945859888] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"806.331155ms","start":"2026-07-25T10:31:04.216068Z","end":"2026-07-25T10:31:05.022399Z","steps":["trace[1945859888] 'process raft request' (duration: 805.78872ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:05.022579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:04.216047Z","time spent":"806.484157ms","remote":"127.0.0.1:33842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T10:31:05.021991Z","caller":"traceutil/trace.go:171","msg":"trace[1416472257] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"888.209552ms","start":"2026-07-25T10:31:04.133751Z","end":"2026-07-25T10:31:05.021961Z","steps":["trace[1416472257] 'process raft request' (duration: 887.507596ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:05.022663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:04.133727Z","time spent":"888.893459ms","remote":"127.0.0.1:33740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T10:31:05.022675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"888.98368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-25T10:31:05.022749Z","caller":"traceutil/trace.go:171","msg":"trace[1767318738] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:11; }","duration":"889.080121ms","start":"2026-07-25T10:31:04.133658Z","end":"2026-07-25T10:31:05.022738Z","steps":["trace[1767318738] 'agreement among raft nodes before linearized reading' (duration: 888.922149ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:05.022776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:04.133646Z","time spent":"889.124481ms","remote":"127.0.0.1:33674","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-07-25T10:31:05.022853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"888.749708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3170"} {"level":"info","ts":"2026-07-25T10:31:05.022893Z","caller":"traceutil/trace.go:171","msg":"trace[432389682] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"888.799198ms","start":"2026-07-25T10:31:04.134082Z","end":"2026-07-25T10:31:05.022881Z","steps":["trace[432389682] 'agreement among raft nodes before linearized reading' (duration: 888.705507ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:05.022923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:04.134059Z","time spent":"888.857168ms","remote":"127.0.0.1:33842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3194,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-07-25T10:31:05.022953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"824.583431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.53\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-25T10:31:05.023009Z","caller":"traceutil/trace.go:171","msg":"trace[1114167921] range","detail":"{range_begin:/registry/masterleases/199.204.45.53; range_end:; response_count:0; response_revision:11; }","duration":"824.709052ms","start":"2026-07-25T10:31:04.198281Z","end":"2026-07-25T10:31:05.02299Z","steps":["trace[1114167921] 'agreement among raft nodes before linearized reading' (duration: 824.624371ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:05.023053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:04.198256Z","time spent":"824.786673ms","remote":"127.0.0.1:33710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":28,"request content":"key:\"/registry/masterleases/199.204.45.53\" "} {"level":"warn","ts":"2026-07-25T10:31:05.023074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"791.619364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-25T10:31:05.023093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"888.853689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-25T10:31:05.023117Z","caller":"traceutil/trace.go:171","msg":"trace[428310109] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"791.663334ms","start":"2026-07-25T10:31:04.231443Z","end":"2026-07-25T10:31:05.023106Z","steps":["trace[428310109] 'agreement among raft nodes before linearized reading' (duration: 791.587443ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:05.023123Z","caller":"traceutil/trace.go:171","msg":"trace[1233721133] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:11; }","duration":"888.889169ms","start":"2026-07-25T10:31:04.134224Z","end":"2026-07-25T10:31:05.023113Z","steps":["trace[1233721133] 'agreement among raft nodes before linearized reading' (duration: 888.854889ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:05.023147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:04.231421Z","time spent":"791.720075ms","remote":"127.0.0.1:33788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-25T10:31:05.023103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"817.29756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-25T10:31:05.023215Z","caller":"traceutil/trace.go:171","msg":"trace[1968503356] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"817.406411ms","start":"2026-07-25T10:31:04.205796Z","end":"2026-07-25T10:31:05.023202Z","steps":["trace[1968503356] 'agreement among raft nodes before linearized reading' (duration: 817.2751ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:05.023248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:04.205759Z","time spent":"817.481512ms","remote":"127.0.0.1:33758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-07-25T10:31:05.023184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"889.02697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-25T10:31:05.023062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"843.871026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-25T10:31:05.023301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"770.678382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-25T10:31:05.023296Z","caller":"traceutil/trace.go:171","msg":"trace[1822418782] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:11; }","duration":"889.151172ms","start":"2026-07-25T10:31:04.134129Z","end":"2026-07-25T10:31:05.02328Z","steps":["trace[1822418782] 'agreement among raft nodes before linearized reading' (duration: 889.036011ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:05.023315Z","caller":"traceutil/trace.go:171","msg":"trace[1398089632] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"844.125749ms","start":"2026-07-25T10:31:04.179181Z","end":"2026-07-25T10:31:05.023306Z","steps":["trace[1398089632] 'agreement among raft nodes before linearized reading' (duration: 843.858817ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:05.023148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:04.134193Z","time spent":"888.94996ms","remote":"127.0.0.1:33924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-25T10:31:05.023341Z","caller":"traceutil/trace.go:171","msg":"trace[284865549] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"770.758722ms","start":"2026-07-25T10:31:04.25257Z","end":"2026-07-25T10:31:05.023329Z","steps":["trace[284865549] 'agreement among raft nodes before linearized reading' (duration: 770.699162ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:05.02335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:04.179159Z","time spent":"844.183519ms","remote":"127.0.0.1:33788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-25T10:31:05.023355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:04.134113Z","time spent":"889.229122ms","remote":"127.0.0.1:33924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-25T10:31:05.023376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:04.252551Z","time spent":"770.816633ms","remote":"127.0.0.1:33788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-07-25T10:31:05.224405Z","caller":"traceutil/trace.go:171","msg":"trace[881849469] linearizableReadLoop","detail":"{readStateIndex:15; appliedIndex:14; }","duration":"194.553291ms","start":"2026-07-25T10:31:05.029823Z","end":"2026-07-25T10:31:05.224377Z","steps":["trace[881849469] 'read index received' (duration: 190.897416ms)","trace[881849469] 'applied index is now lower than readState.Index' (duration: 3.654745ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T10:31:05.22461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.770633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-25T10:31:05.224517Z","caller":"traceutil/trace.go:171","msg":"trace[1567749721] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"194.887194ms","start":"2026-07-25T10:31:05.029597Z","end":"2026-07-25T10:31:05.224484Z","steps":["trace[1567749721] 'process raft request' (duration: 191.108548ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:05.224687Z","caller":"traceutil/trace.go:171","msg":"trace[1769319156] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12; }","duration":"194.871145ms","start":"2026-07-25T10:31:05.029796Z","end":"2026-07-25T10:31:05.224667Z","steps":["trace[1769319156] 'agreement among raft nodes before linearized reading' (duration: 194.700613ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:05.225056Z","caller":"traceutil/trace.go:171","msg":"trace[1350446623] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"195.091986ms","start":"2026-07-25T10:31:05.029953Z","end":"2026-07-25T10:31:05.225045Z","steps":["trace[1350446623] 'process raft request' (duration: 194.917725ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:05.225212Z","caller":"traceutil/trace.go:171","msg":"trace[1093564774] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"195.147247ms","start":"2026-07-25T10:31:05.030048Z","end":"2026-07-25T10:31:05.225196Z","steps":["trace[1093564774] 'process raft request' (duration: 194.913044ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:05.225373Z","caller":"traceutil/trace.go:171","msg":"trace[958215079] transaction","detail":"{read_only:false; number_of_response:0; response_revision:14; }","duration":"195.249658ms","start":"2026-07-25T10:31:05.03011Z","end":"2026-07-25T10:31:05.225359Z","steps":["trace[958215079] 'process raft request' (duration: 194.897245ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:05.225449Z","caller":"traceutil/trace.go:171","msg":"trace[346067749] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"194.110287ms","start":"2026-07-25T10:31:05.031327Z","end":"2026-07-25T10:31:05.225437Z","steps":["trace[346067749] 'process raft request' (duration: 193.711283ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:05.22632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.505331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-gszvm\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-07-25T10:31:05.226363Z","caller":"traceutil/trace.go:171","msg":"trace[932755340] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-gszvm; range_end:; response_count:1; response_revision:20; }","duration":"193.557362ms","start":"2026-07-25T10:31:05.032796Z","end":"2026-07-25T10:31:05.226353Z","steps":["trace[932755340] 'agreement among raft nodes before linearized reading' (duration: 193.458171ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:05.226687Z","caller":"traceutil/trace.go:171","msg":"trace[1488356142] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"188.701216ms","start":"2026-07-25T10:31:05.037969Z","end":"2026-07-25T10:31:05.22667Z","steps":["trace[1488356142] 'process raft request' (duration: 187.929748ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:05.226719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.071678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"warn","ts":"2026-07-25T10:31:05.226717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.733676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-07-25T10:31:05.226748Z","caller":"traceutil/trace.go:171","msg":"trace[109803811] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:20; }","duration":"144.116268ms","start":"2026-07-25T10:31:05.082624Z","end":"2026-07-25T10:31:05.22674Z","steps":["trace[109803811] 'agreement among raft nodes before linearized reading' (duration: 144.066418ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:05.226762Z","caller":"traceutil/trace.go:171","msg":"trace[756567087] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:20; }","duration":"141.822746ms","start":"2026-07-25T10:31:05.084929Z","end":"2026-07-25T10:31:05.226751Z","steps":["trace[756567087] 'agreement among raft nodes before linearized reading' (duration: 141.731806ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:05.226758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.918363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-25T10:31:05.226782Z","caller":"traceutil/trace.go:171","msg":"trace[1221018116] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"194.569871ms","start":"2026-07-25T10:31:05.032174Z","end":"2026-07-25T10:31:05.226743Z","steps":["trace[1221018116] 'process raft request' (duration: 193.646553ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:05.226826Z","caller":"traceutil/trace.go:171","msg":"trace[1745889750] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:20; }","duration":"128.023035ms","start":"2026-07-25T10:31:05.098786Z","end":"2026-07-25T10:31:05.226809Z","steps":["trace[1745889750] 'agreement among raft nodes before linearized reading' (duration: 127.902694ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:05.226864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.983793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-25T10:31:05.226871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.298061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-07-25T10:31:05.226891Z","caller":"traceutil/trace.go:171","msg":"trace[936327997] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:20; }","duration":"129.042305ms","start":"2026-07-25T10:31:05.097841Z","end":"2026-07-25T10:31:05.226883Z","steps":["trace[936327997] 'agreement among raft nodes before linearized reading' (duration: 129.002044ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:05.226898Z","caller":"traceutil/trace.go:171","msg":"trace[406645446] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:20; }","duration":"144.365391ms","start":"2026-07-25T10:31:05.082525Z","end":"2026-07-25T10:31:05.22689Z","steps":["trace[406645446] 'agreement among raft nodes before linearized reading' (duration: 144.32113ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:05.226929Z","caller":"traceutil/trace.go:171","msg":"trace[549872364] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"194.129537ms","start":"2026-07-25T10:31:05.032788Z","end":"2026-07-25T10:31:05.226918Z","steps":["trace[549872364] 'process raft request' (duration: 193.074487ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:05.227053Z","caller":"traceutil/trace.go:171","msg":"trace[1841841508] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"195.634121ms","start":"2026-07-25T10:31:05.031408Z","end":"2026-07-25T10:31:05.227042Z","steps":["trace[1841841508] 'process raft request' (duration: 193.689473ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:05.227147Z","caller":"traceutil/trace.go:171","msg":"trace[1121973863] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"195.55197ms","start":"2026-07-25T10:31:05.031584Z","end":"2026-07-25T10:31:05.227136Z","steps":["trace[1121973863] 'process raft request' (duration: 194.204507ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:35.984007Z","caller":"traceutil/trace.go:171","msg":"trace[79097915] transaction","detail":"{read_only:false; response_revision:456; number_of_response:1; }","duration":"292.098019ms","start":"2026-07-25T10:31:35.691863Z","end":"2026-07-25T10:31:35.983961Z","steps":["trace[79097915] 'process raft request' (duration: 291.801148ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:53.27607Z","caller":"traceutil/trace.go:171","msg":"trace[1809894746] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"125.79851ms","start":"2026-07-25T10:31:53.150245Z","end":"2026-07-25T10:31:53.276044Z","steps":["trace[1809894746] 'process raft request' (duration: 125.739338ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:53.276288Z","caller":"traceutil/trace.go:171","msg":"trace[1072120353] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"126.47889ms","start":"2026-07-25T10:31:53.149648Z","end":"2026-07-25T10:31:53.276127Z","steps":["trace[1072120353] 'process raft request' (duration: 33.020787ms)","trace[1072120353] 'compare' (duration: 93.145283ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:31:53.73609Z","caller":"traceutil/trace.go:171","msg":"trace[1865670099] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"113.982636ms","start":"2026-07-25T10:31:53.622082Z","end":"2026-07-25T10:31:53.736064Z","steps":["trace[1865670099] 'process raft request' (duration: 113.938955ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:53.736108Z","caller":"traceutil/trace.go:171","msg":"trace[1407866715] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"116.43992ms","start":"2026-07-25T10:31:53.619639Z","end":"2026-07-25T10:31:53.736078Z","steps":["trace[1407866715] 'process raft request' (duration: 22.386019ms)","trace[1407866715] 'compare' (duration: 93.853265ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:31:53.912027Z","caller":"traceutil/trace.go:171","msg":"trace[1105961530] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"163.544327ms","start":"2026-07-25T10:31:53.748432Z","end":"2026-07-25T10:31:53.911977Z","steps":["trace[1105961530] 'process raft request' (duration: 129.060727ms)","trace[1105961530] 'compare' (duration: 34.265154ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:31:53.983612Z","caller":"traceutil/trace.go:171","msg":"trace[1502199870] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"179.336769ms","start":"2026-07-25T10:31:53.804248Z","end":"2026-07-25T10:31:53.983584Z","steps":["trace[1502199870] 'process raft request' (duration: 179.208455ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:53.983826Z","caller":"traceutil/trace.go:171","msg":"trace[462666005] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"180.222526ms","start":"2026-07-25T10:31:53.803567Z","end":"2026-07-25T10:31:53.98379Z","steps":["trace[462666005] 'process raft request' (duration: 179.780523ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:53.983881Z","caller":"traceutil/trace.go:171","msg":"trace[632381425] linearizableReadLoop","detail":"{readStateIndex:566; appliedIndex:562; }","duration":"174.554956ms","start":"2026-07-25T10:31:53.809303Z","end":"2026-07-25T10:31:53.983858Z","steps":["trace[632381425] 'read index received' (duration: 68.365353ms)","trace[632381425] 'applied index is now lower than readState.Index' (duration: 106.188743ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:31:53.983943Z","caller":"traceutil/trace.go:171","msg":"trace[1827559583] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"179.236156ms","start":"2026-07-25T10:31:53.804674Z","end":"2026-07-25T10:31:53.983911Z","steps":["trace[1827559583] 'process raft request' (duration: 178.824934ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:53.983989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.66418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T10:31:53.984023Z","caller":"traceutil/trace.go:171","msg":"trace[1345132195] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:547; }","duration":"174.733222ms","start":"2026-07-25T10:31:53.809278Z","end":"2026-07-25T10:31:53.984012Z","steps":["trace[1345132195] 'agreement among raft nodes before linearized reading' (duration: 174.647249ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:53.984214Z","caller":"traceutil/trace.go:171","msg":"trace[1443693986] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"167.813415ms","start":"2026-07-25T10:31:53.816389Z","end":"2026-07-25T10:31:53.984202Z","steps":["trace[1443693986] 'process raft request' (duration: 167.295709ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:54.177918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.614418ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T10:31:54.178161Z","caller":"traceutil/trace.go:171","msg":"trace[1108540829] linearizableReadLoop","detail":"{readStateIndex:570; appliedIndex:567; }","duration":"192.592607ms","start":"2026-07-25T10:31:53.98555Z","end":"2026-07-25T10:31:54.178143Z","steps":["trace[1108540829] 'read index received' (duration: 90.518805ms)","trace[1108540829] 'applied index is now lower than readState.Index' (duration: 102.072932ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:31:54.178227Z","caller":"traceutil/trace.go:171","msg":"trace[1337829896] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"257.450096ms","start":"2026-07-25T10:31:53.920768Z","end":"2026-07-25T10:31:54.178219Z","steps":["trace[1337829896] 'process raft request' (duration: 257.306051ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:54.178321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.746872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T10:31:54.17835Z","caller":"traceutil/trace.go:171","msg":"trace[1571634854] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"259.177727ms","start":"2026-07-25T10:31:53.919147Z","end":"2026-07-25T10:31:54.178325Z","steps":["trace[1571634854] 'process raft request' (duration: 258.859147ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:54.178409Z","caller":"traceutil/trace.go:171","msg":"trace[829371693] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:550; }","duration":"192.879296ms","start":"2026-07-25T10:31:53.98551Z","end":"2026-07-25T10:31:54.17839Z","steps":["trace[829371693] 'agreement among raft nodes before linearized reading' (duration: 192.723331ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:54.178802Z","caller":"traceutil/trace.go:171","msg":"trace[372109564] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"260.657651ms","start":"2026-07-25T10:31:53.917439Z","end":"2026-07-25T10:31:54.178097Z","steps":["trace[372109564] 'process raft request' (duration: 158.619ms)","trace[372109564] 'compare' (duration: 101.438873ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:31:54.206899Z","caller":"traceutil/trace.go:171","msg":"trace[413664440] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"217.904686ms","start":"2026-07-25T10:31:53.988972Z","end":"2026-07-25T10:31:54.206877Z","steps":["trace[413664440] 'process raft request' (duration: 217.746751ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:54.206922Z","caller":"traceutil/trace.go:171","msg":"trace[613066473] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"217.02249ms","start":"2026-07-25T10:31:53.989883Z","end":"2026-07-25T10:31:54.206906Z","steps":["trace[613066473] 'process raft request' (duration: 216.930727ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:54.207117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.055304ms","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-07-25T10:31:54.207172Z","caller":"traceutil/trace.go:171","msg":"trace[724784448] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:553; }","duration":"144.155387ms","start":"2026-07-25T10:31:54.063001Z","end":"2026-07-25T10:31:54.207157Z","steps":["trace[724784448] 'agreement among raft nodes before linearized reading' (duration: 144.042354ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:54.207356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.016589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/cilium-operator\" ","response":"range_response_count:1 size:4335"} {"level":"info","ts":"2026-07-25T10:31:54.207399Z","caller":"traceutil/trace.go:171","msg":"trace[564812349] range","detail":"{range_begin:/registry/deployments/kube-system/cilium-operator; range_end:; response_count:1; response_revision:553; }","duration":"215.173104ms","start":"2026-07-25T10:31:53.992215Z","end":"2026-07-25T10:31:54.207389Z","steps":["trace[564812349] 'agreement among raft nodes before linearized reading' (duration: 215.02096ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:54.20741Z","caller":"traceutil/trace.go:171","msg":"trace[1176714406] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"216.905105ms","start":"2026-07-25T10:31:53.990492Z","end":"2026-07-25T10:31:54.207397Z","steps":["trace[1176714406] 'process raft request' (duration: 216.37424ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:54.208024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.603779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329952"} {"level":"info","ts":"2026-07-25T10:31:54.208149Z","caller":"traceutil/trace.go:171","msg":"trace[1017760294] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:553; }","duration":"147.755474ms","start":"2026-07-25T10:31:54.060372Z","end":"2026-07-25T10:31:54.208128Z","steps":["trace[1017760294] 'agreement among raft nodes before linearized reading' (duration: 146.969621ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:54.427299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.517684ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-25T10:31:54.427383Z","caller":"traceutil/trace.go:171","msg":"trace[1976775820] linearizableReadLoop","detail":"{readStateIndex:574; appliedIndex:573; }","duration":"220.362633ms","start":"2026-07-25T10:31:54.20701Z","end":"2026-07-25T10:31:54.427372Z","steps":["trace[1976775820] 'read index received' (duration: 91.742506ms)","trace[1976775820] 'applied index is now lower than readState.Index' (duration: 128.619277ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:31:54.427435Z","caller":"traceutil/trace.go:171","msg":"trace[526324726] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"244.733255ms","start":"2026-07-25T10:31:54.18267Z","end":"2026-07-25T10:31:54.427403Z","steps":["trace[526324726] 'process raft request' (duration: 116.060416ms)","trace[526324726] 'compare' (duration: 128.415242ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T10:31:54.4275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.197232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/cilium\" ","response":"range_response_count:1 size:14463"} {"level":"info","ts":"2026-07-25T10:31:54.427521Z","caller":"traceutil/trace.go:171","msg":"trace[715786214] range","detail":"{range_begin:/registry/daemonsets/kube-system/cilium; range_end:; response_count:1; response_revision:554; }","duration":"236.234704ms","start":"2026-07-25T10:31:54.19128Z","end":"2026-07-25T10:31:54.427515Z","steps":["trace[715786214] 'agreement among raft nodes before linearized reading' (duration: 236.137551ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:54.427711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.065466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-5tsx8\" ","response":"range_response_count:1 size:15076"} {"level":"info","ts":"2026-07-25T10:31:54.427819Z","caller":"traceutil/trace.go:171","msg":"trace[148621221] range","detail":"{range_begin:/registry/pods/kube-system/cilium-5tsx8; range_end:; response_count:1; response_revision:554; }","duration":"243.193559ms","start":"2026-07-25T10:31:54.184577Z","end":"2026-07-25T10:31:54.427771Z","steps":["trace[148621221] 'agreement among raft nodes before linearized reading' (duration: 242.881ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:54.491362Z","caller":"traceutil/trace.go:171","msg":"trace[1446440624] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"273.677032ms","start":"2026-07-25T10:31:54.217663Z","end":"2026-07-25T10:31:54.49134Z","steps":["trace[1446440624] 'process raft request' (duration: 273.549438ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:54.491466Z","caller":"traceutil/trace.go:171","msg":"trace[1264001672] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"277.65038ms","start":"2026-07-25T10:31:54.213787Z","end":"2026-07-25T10:31:54.491437Z","steps":["trace[1264001672] 'process raft request' (duration: 277.31762ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:54.491631Z","caller":"traceutil/trace.go:171","msg":"trace[86957830] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"272.26747ms","start":"2026-07-25T10:31:54.219331Z","end":"2026-07-25T10:31:54.491598Z","steps":["trace[86957830] 'process raft request' (duration: 271.93133ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:54.492395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.210213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329952"} {"level":"info","ts":"2026-07-25T10:31:54.49271Z","caller":"traceutil/trace.go:171","msg":"trace[820180506] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:557; }","duration":"183.504883ms","start":"2026-07-25T10:31:54.309111Z","end":"2026-07-25T10:31:54.492616Z","steps":["trace[820180506] 'agreement among raft nodes before linearized reading' (duration: 182.40963ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:54.589858Z","caller":"traceutil/trace.go:171","msg":"trace[520416531] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"158.780311ms","start":"2026-07-25T10:31:54.431047Z","end":"2026-07-25T10:31:54.589828Z","steps":["trace[520416531] 'process raft request' (duration: 151.272448ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:54.589909Z","caller":"traceutil/trace.go:171","msg":"trace[1814483756] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"147.61804ms","start":"2026-07-25T10:31:54.442262Z","end":"2026-07-25T10:31:54.58988Z","steps":["trace[1814483756] 'process raft request' (duration: 147.478526ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:54.590036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.10017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/cilium\" ","response":"range_response_count:1 size:14463"} {"level":"info","ts":"2026-07-25T10:31:54.59012Z","caller":"traceutil/trace.go:171","msg":"trace[1890134891] range","detail":"{range_begin:/registry/daemonsets/kube-system/cilium; range_end:; response_count:1; response_revision:559; }","duration":"160.220443ms","start":"2026-07-25T10:31:54.429882Z","end":"2026-07-25T10:31:54.590102Z","steps":["trace[1890134891] 'agreement among raft nodes before linearized reading' (duration: 159.992066ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:54.655053Z","caller":"traceutil/trace.go:171","msg":"trace[1058719404] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"152.960738ms","start":"2026-07-25T10:31:54.502043Z","end":"2026-07-25T10:31:54.655004Z","steps":["trace[1058719404] 'process raft request' (duration: 152.771452ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:54.655135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.300786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-q68qv\" ","response":"range_response_count:1 size:3637"} {"level":"info","ts":"2026-07-25T10:31:54.655205Z","caller":"traceutil/trace.go:171","msg":"trace[1048937674] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-q68qv; range_end:; response_count:1; response_revision:560; }","duration":"158.387078ms","start":"2026-07-25T10:31:54.496797Z","end":"2026-07-25T10:31:54.655185Z","steps":["trace[1048937674] 'agreement among raft nodes before linearized reading' (duration: 158.191572ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:54.655206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.555433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-5tsx8\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-07-25T10:31:54.655339Z","caller":"traceutil/trace.go:171","msg":"trace[772266380] range","detail":"{range_begin:/registry/pods/kube-system/cilium-5tsx8; range_end:; response_count:1; response_revision:560; }","duration":"158.828222ms","start":"2026-07-25T10:31:54.496477Z","end":"2026-07-25T10:31:54.655305Z","steps":["trace[772266380] 'agreement among raft nodes before linearized reading' (duration: 158.561714ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:54.837796Z","caller":"traceutil/trace.go:171","msg":"trace[27142925] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"176.29847ms","start":"2026-07-25T10:31:54.661471Z","end":"2026-07-25T10:31:54.83777Z","steps":["trace[27142925] 'process raft request' (duration: 140.619143ms)","trace[27142925] 'compare' (duration: 35.035407ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:31:56.193935Z","caller":"traceutil/trace.go:171","msg":"trace[1680983645] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"348.830848ms","start":"2026-07-25T10:31:55.84508Z","end":"2026-07-25T10:31:56.193911Z","steps":["trace[1680983645] 'process raft request' (duration: 348.709135ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:56.194071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:55.84506Z","time spent":"348.945852ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T10:31:56.53086Z","caller":"traceutil/trace.go:171","msg":"trace[86694210] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"676.703743ms","start":"2026-07-25T10:31:55.854127Z","end":"2026-07-25T10:31:56.530831Z","steps":["trace[86694210] 'process raft request' (duration: 676.578129ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:56.530876Z","caller":"traceutil/trace.go:171","msg":"trace[1964195160] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"668.858912ms","start":"2026-07-25T10:31:55.861994Z","end":"2026-07-25T10:31:56.530853Z","steps":["trace[1964195160] 'process raft request' (duration: 668.754259ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:56.530857Z","caller":"traceutil/trace.go:171","msg":"trace[401881658] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"676.743884ms","start":"2026-07-25T10:31:55.854064Z","end":"2026-07-25T10:31:56.530808Z","steps":["trace[401881658] 'process raft request' (duration: 676.531148ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:56.531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:55.854123Z","time spent":"676.815026ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T10:31:56.531007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:55.861976Z","time spent":"668.971076ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T10:31:56.53105Z","caller":"traceutil/trace.go:171","msg":"trace[2119751010] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"656.985024ms","start":"2026-07-25T10:31:55.874039Z","end":"2026-07-25T10:31:56.531024Z","steps":["trace[2119751010] 'process raft request' (duration: 656.745987ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:56.531134Z","caller":"traceutil/trace.go:171","msg":"trace[1223162319] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"650.791883ms","start":"2026-07-25T10:31:55.880332Z","end":"2026-07-25T10:31:56.531124Z","steps":["trace[1223162319] 'process raft request' (duration: 650.489844ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:56.531177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:55.874023Z","time spent":"657.076697ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T10:31:56.531186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:55.880308Z","time spent":"650.857944ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T10:31:56.531173Z","caller":"traceutil/trace.go:171","msg":"trace[1687739920] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"646.774935ms","start":"2026-07-25T10:31:55.884376Z","end":"2026-07-25T10:31:56.531151Z","steps":["trace[1687739920] 'process raft request' (duration: 646.634301ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:56.531292Z","caller":"traceutil/trace.go:171","msg":"trace[433491990] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"638.77064ms","start":"2026-07-25T10:31:55.892514Z","end":"2026-07-25T10:31:56.531284Z","steps":["trace[433491990] 'process raft request' (duration: 638.575544ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:56.531281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:55.884357Z","time spent":"646.875578ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T10:31:56.531263Z","caller":"traceutil/trace.go:171","msg":"trace[2036796285] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"649.289479ms","start":"2026-07-25T10:31:55.881863Z","end":"2026-07-25T10:31:56.531153Z","steps":["trace[2036796285] 'process raft request' (duration: 649.094323ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:56.531479Z","caller":"traceutil/trace.go:171","msg":"trace[1327945522] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"637.011479ms","start":"2026-07-25T10:31:55.894454Z","end":"2026-07-25T10:31:56.531465Z","steps":["trace[1327945522] 'process raft request' (duration: 636.738901ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:56.531479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:55.881858Z","time spent":"649.541486ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T10:31:56.531541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:55.894425Z","time spent":"637.092231ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T10:31:56.531577Z","caller":"traceutil/trace.go:171","msg":"trace[895162892] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"621.0346ms","start":"2026-07-25T10:31:55.91053Z","end":"2026-07-25T10:31:56.531564Z","steps":["trace[895162892] 'process raft request' (duration: 620.825854ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:56.531594Z","caller":"traceutil/trace.go:171","msg":"trace[1953947536] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"522.012127ms","start":"2026-07-25T10:31:56.009565Z","end":"2026-07-25T10:31:56.531577Z","steps":["trace[1953947536] 'process raft request' (duration: 521.885464ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:56.531666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:55.910513Z","time spent":"621.096502ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T10:31:56.531673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.332374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.53\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-07-25T10:31:56.531684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:56.009545Z","time spent":"522.102439ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T10:31:56.531724Z","caller":"traceutil/trace.go:171","msg":"trace[1354680747] range","detail":"{range_begin:/registry/masterleases/199.204.45.53; range_end:; response_count:1; response_revision:576; }","duration":"599.440307ms","start":"2026-07-25T10:31:55.93227Z","end":"2026-07-25T10:31:56.53171Z","steps":["trace[1354680747] 'agreement among raft nodes before linearized reading' (duration: 599.321984ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:56.53134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:55.892487Z","time spent":"638.827782ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T10:31:56.531778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:55.932229Z","time spent":"599.53801ms","remote":"127.0.0.1:33710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.53\" "} {"level":"info","ts":"2026-07-25T10:31:56.531558Z","caller":"traceutil/trace.go:171","msg":"trace[1892900507] linearizableReadLoop","detail":"{readStateIndex:595; appliedIndex:584; }","duration":"599.152728ms","start":"2026-07-25T10:31:55.932376Z","end":"2026-07-25T10:31:56.531529Z","steps":["trace[1892900507] 'read index received' (duration: 261.498757ms)","trace[1892900507] 'applied index is now lower than readState.Index' (duration: 337.652911ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T10:31:56.531825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:55.854045Z","time spent":"677.743382ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T10:31:56.683644Z","caller":"traceutil/trace.go:171","msg":"trace[1290176299] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:596; }","duration":"151.812111ms","start":"2026-07-25T10:31:56.531813Z","end":"2026-07-25T10:31:56.683625Z","steps":["trace[1290176299] 'read index received' (duration: 141.602405ms)","trace[1290176299] 'applied index is now lower than readState.Index' (duration: 10.208896ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T10:31:56.683766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.954545ms","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-07-25T10:31:56.683787Z","caller":"traceutil/trace.go:171","msg":"trace[2143570095] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:578; }","duration":"184.030007ms","start":"2026-07-25T10:31:56.499749Z","end":"2026-07-25T10:31:56.683779Z","steps":["trace[2143570095] 'agreement among raft nodes before linearized reading' (duration: 183.944084ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:56.683929Z","caller":"traceutil/trace.go:171","msg":"trace[1587414851] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"482.362476ms","start":"2026-07-25T10:31:56.20156Z","end":"2026-07-25T10:31:56.683922Z","steps":["trace[1587414851] 'process raft request' (duration: 482.007005ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:56.683988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:56.201548Z","time spent":"482.399406ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6888,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T10:31:56.684106Z","caller":"traceutil/trace.go:171","msg":"trace[1050973976] transaction","detail":"{read_only:false; number_of_response:1; response_revision:578; }","duration":"482.421527ms","start":"2026-07-25T10:31:56.201673Z","end":"2026-07-25T10:31:56.684095Z","steps":["trace[1050973976] 'process raft request' (duration: 481.930662ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:56.684055Z","caller":"traceutil/trace.go:171","msg":"trace[107407537] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"484.437195ms","start":"2026-07-25T10:31:56.199599Z","end":"2026-07-25T10:31:56.684037Z","steps":["trace[107407537] 'process raft request' (duration: 473.724304ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:56.684157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:56.201648Z","time spent":"482.481989ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":6938,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T10:31:56.684285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:56.199569Z","time spent":"484.573779ms","remote":"127.0.0.1:34140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T10:31:56.686451Z","caller":"traceutil/trace.go:171","msg":"trace[1213574410] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"131.710477ms","start":"2026-07-25T10:31:56.554726Z","end":"2026-07-25T10:31:56.686437Z","steps":["trace[1213574410] 'process raft request' (duration: 131.665516ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:56.686557Z","caller":"traceutil/trace.go:171","msg":"trace[1888267960] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"141.532483ms","start":"2026-07-25T10:31:56.545003Z","end":"2026-07-25T10:31:56.686536Z","steps":["trace[1888267960] 'process raft request' (duration: 141.155132ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:56.686593Z","caller":"traceutil/trace.go:171","msg":"trace[2351479] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"139.643257ms","start":"2026-07-25T10:31:56.546942Z","end":"2026-07-25T10:31:56.686585Z","steps":["trace[2351479] 'process raft request' (duration: 139.248426ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:56.686575Z","caller":"traceutil/trace.go:171","msg":"trace[1662553501] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"139.893144ms","start":"2026-07-25T10:31:56.54666Z","end":"2026-07-25T10:31:56.686554Z","steps":["trace[1662553501] 'process raft request' (duration: 139.512263ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:56.686655Z","caller":"traceutil/trace.go:171","msg":"trace[372265551] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"138.053011ms","start":"2026-07-25T10:31:56.548597Z","end":"2026-07-25T10:31:56.68665Z","steps":["trace[372265551] 'process raft request' (duration: 137.628199ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:56.686696Z","caller":"traceutil/trace.go:171","msg":"trace[695831043] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"134.620901ms","start":"2026-07-25T10:31:56.552071Z","end":"2026-07-25T10:31:56.686692Z","steps":["trace[695831043] 'process raft request' (duration: 134.208669ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:56.686727Z","caller":"traceutil/trace.go:171","msg":"trace[605015569] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"144.632453ms","start":"2026-07-25T10:31:56.542083Z","end":"2026-07-25T10:31:56.686715Z","steps":["trace[605015569] 'process raft request' (duration: 144.025345ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:56.686747Z","caller":"traceutil/trace.go:171","msg":"trace[868586382] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"133.191421ms","start":"2026-07-25T10:31:56.553551Z","end":"2026-07-25T10:31:56.686742Z","steps":["trace[868586382] 'process raft request' (duration: 132.761888ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:56.866267Z","caller":"traceutil/trace.go:171","msg":"trace[1750102411] transaction","detail":"{read_only:false; number_of_response:0; response_revision:589; }","duration":"173.358817ms","start":"2026-07-25T10:31:56.692888Z","end":"2026-07-25T10:31:56.866246Z","steps":["trace[1750102411] 'process raft request' (duration: 173.210823ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:56.866301Z","caller":"traceutil/trace.go:171","msg":"trace[543625850] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"173.010987ms","start":"2026-07-25T10:31:56.693263Z","end":"2026-07-25T10:31:56.866274Z","steps":["trace[543625850] 'process raft request' (duration: 172.860723ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:56.866392Z","caller":"traceutil/trace.go:171","msg":"trace[283729446] transaction","detail":"{read_only:false; number_of_response:0; response_revision:590; }","duration":"172.120942ms","start":"2026-07-25T10:31:56.694208Z","end":"2026-07-25T10:31:56.866329Z","steps":["trace[283729446] 'process raft request' (duration: 172.018089ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:56.866772Z","caller":"traceutil/trace.go:171","msg":"trace[1535939502] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"166.23916ms","start":"2026-07-25T10:31:56.700516Z","end":"2026-07-25T10:31:56.866755Z","steps":["trace[1535939502] 'process raft request' (duration: 165.751666ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:56.866831Z","caller":"traceutil/trace.go:171","msg":"trace[1450206347] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"160.920796ms","start":"2026-07-25T10:31:56.705898Z","end":"2026-07-25T10:31:56.866819Z","steps":["trace[1450206347] 'process raft request' (duration: 160.431632ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:56.866772Z","caller":"traceutil/trace.go:171","msg":"trace[1144657352] transaction","detail":"{read_only:false; number_of_response:0; response_revision:590; }","duration":"171.914865ms","start":"2026-07-25T10:31:56.694846Z","end":"2026-07-25T10:31:56.86676Z","steps":["trace[1144657352] 'process raft request' (duration: 171.40492ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:56.867064Z","caller":"traceutil/trace.go:171","msg":"trace[901071855] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"151.077419ms","start":"2026-07-25T10:31:56.715973Z","end":"2026-07-25T10:31:56.86705Z","steps":["trace[901071855] 'process raft request' (duration: 150.725339ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:56.867069Z","caller":"traceutil/trace.go:171","msg":"trace[836057326] transaction","detail":"{read_only:false; number_of_response:0; response_revision:589; }","duration":"173.381708ms","start":"2026-07-25T10:31:56.692831Z","end":"2026-07-25T10:31:56.866212Z","steps":["trace[836057326] 'process raft request' (duration: 170.179785ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:56.867157Z","caller":"traceutil/trace.go:171","msg":"trace[454183342] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"128.606117ms","start":"2026-07-25T10:31:56.738539Z","end":"2026-07-25T10:31:56.867145Z","steps":["trace[454183342] 'process raft request' (duration: 128.252057ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:56.867118Z","caller":"traceutil/trace.go:171","msg":"trace[1992433106] linearizableReadLoop","detail":"{readStateIndex:616; appliedIndex:611; }","duration":"171.267137ms","start":"2026-07-25T10:31:56.695821Z","end":"2026-07-25T10:31:56.867088Z","steps":["trace[1992433106] 'read index received' (duration: 68.515321ms)","trace[1992433106] 'applied index is now lower than readState.Index' (duration: 102.750826ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:31:56.867204Z","caller":"traceutil/trace.go:171","msg":"trace[489102956] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"157.552318ms","start":"2026-07-25T10:31:56.709643Z","end":"2026-07-25T10:31:56.867195Z","steps":["trace[489102956] 'process raft request' (duration: 156.850407ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:56.867273Z","caller":"traceutil/trace.go:171","msg":"trace[253642397] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"106.129094ms","start":"2026-07-25T10:31:56.761133Z","end":"2026-07-25T10:31:56.867262Z","steps":["trace[253642397] 'process raft request' (duration: 105.831995ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:56.867662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.820603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:10078"} {"level":"info","ts":"2026-07-25T10:31:56.86771Z","caller":"traceutil/trace.go:171","msg":"trace[1908077785] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:597; }","duration":"171.894544ms","start":"2026-07-25T10:31:56.695802Z","end":"2026-07-25T10:31:56.867696Z","steps":["trace[1908077785] 'agreement among raft nodes before linearized reading' (duration: 171.509383ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:57.212934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.025875ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T10:31:57.213049Z","caller":"traceutil/trace.go:171","msg":"trace[2065804950] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"248.603128ms","start":"2026-07-25T10:31:56.964428Z","end":"2026-07-25T10:31:57.213031Z","steps":["trace[2065804950] 'process raft request' (duration: 120.327655ms)","trace[2065804950] 'compare' (duration: 127.855721ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:31:57.237113Z","caller":"traceutil/trace.go:171","msg":"trace[669112716] linearizableReadLoop","detail":"{readStateIndex:631; appliedIndex:630; }","duration":"106.392692ms","start":"2026-07-25T10:31:57.130703Z","end":"2026-07-25T10:31:57.237095Z","steps":["trace[669112716] 'read index received' (duration: 106.244948ms)","trace[669112716] 'applied index is now lower than readState.Index' (duration: 147.204µs)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:31:57.237246Z","caller":"traceutil/trace.go:171","msg":"trace[1759969128] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"235.81099ms","start":"2026-07-25T10:31:57.001412Z","end":"2026-07-25T10:31:57.237223Z","steps":["trace[1759969128] 'process raft request' (duration: 235.519202ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:57.237301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.573418ms","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-07-25T10:31:57.237507Z","caller":"traceutil/trace.go:171","msg":"trace[835171725] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:605; }","duration":"106.830585ms","start":"2026-07-25T10:31:57.13066Z","end":"2026-07-25T10:31:57.237491Z","steps":["trace[835171725] 'agreement among raft nodes before linearized reading' (duration: 106.501105ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:57.522112Z","caller":"traceutil/trace.go:171","msg":"trace[173547691] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"297.041322ms","start":"2026-07-25T10:31:57.225045Z","end":"2026-07-25T10:31:57.522087Z","steps":["trace[173547691] 'process raft request' (duration: 246.762804ms)","trace[173547691] 'compare' (duration: 50.068512ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:31:57.522424Z","caller":"traceutil/trace.go:171","msg":"trace[1305815249] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"293.894421ms","start":"2026-07-25T10:31:57.228508Z","end":"2026-07-25T10:31:57.522402Z","steps":["trace[1305815249] 'process raft request' (duration: 293.52323ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:57.522571Z","caller":"traceutil/trace.go:171","msg":"trace[1300608545] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"260.423237ms","start":"2026-07-25T10:31:57.262129Z","end":"2026-07-25T10:31:57.522553Z","steps":["trace[1300608545] 'process raft request' (duration: 260.347515ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:57.522599Z","caller":"traceutil/trace.go:171","msg":"trace[1837677379] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"280.772163ms","start":"2026-07-25T10:31:57.241787Z","end":"2026-07-25T10:31:57.522559Z","steps":["trace[1837677379] 'process raft request' (duration: 280.521646ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:57.809808Z","caller":"traceutil/trace.go:171","msg":"trace[550014617] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:636; }","duration":"198.993859ms","start":"2026-07-25T10:31:57.610787Z","end":"2026-07-25T10:31:57.809781Z","steps":["trace[550014617] 'read index received' (duration: 762.992µs)","trace[550014617] 'applied index is now lower than readState.Index' (duration: 198.229717ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:31:57.809878Z","caller":"traceutil/trace.go:171","msg":"trace[239960099] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"237.100846ms","start":"2026-07-25T10:31:57.572744Z","end":"2026-07-25T10:31:57.809844Z","steps":["trace[239960099] 'process raft request' (duration: 166.943356ms)","trace[239960099] 'compare' (duration: 69.971064ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T10:31:57.810212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.184014ms","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-07-25T10:31:57.810276Z","caller":"traceutil/trace.go:171","msg":"trace[862752430] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:612; }","duration":"199.512794ms","start":"2026-07-25T10:31:57.610749Z","end":"2026-07-25T10:31:57.810261Z","steps":["trace[862752430] 'agreement among raft nodes before linearized reading' (duration: 199.176344ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:57.810446Z","caller":"traceutil/trace.go:171","msg":"trace[1764018908] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"188.360763ms","start":"2026-07-25T10:31:57.62206Z","end":"2026-07-25T10:31:57.81042Z","steps":["trace[1764018908] 'process raft request' (duration: 188.197578ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:57.843933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.223425ms","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-07-25T10:31:57.844009Z","caller":"traceutil/trace.go:171","msg":"trace[1295479310] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:614; }","duration":"224.344759ms","start":"2026-07-25T10:31:57.61965Z","end":"2026-07-25T10:31:57.843994Z","steps":["trace[1295479310] 'agreement among raft nodes before linearized reading' (duration: 224.194174ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:58.384496Z","caller":"traceutil/trace.go:171","msg":"trace[1671698012] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"256.572429ms","start":"2026-07-25T10:31:58.127893Z","end":"2026-07-25T10:31:58.384465Z","steps":["trace[1671698012] 'process raft request' (duration: 239.739769ms)","trace[1671698012] 'compare' (duration: 15.846332ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:31:58.384742Z","caller":"traceutil/trace.go:171","msg":"trace[1177919535] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"253.775469ms","start":"2026-07-25T10:31:58.130947Z","end":"2026-07-25T10:31:58.384722Z","steps":["trace[1177919535] 'process raft request' (duration: 252.897384ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:31:58.385483Z","caller":"traceutil/trace.go:171","msg":"trace[651009891] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"218.7761ms","start":"2026-07-25T10:31:58.166661Z","end":"2026-07-25T10:31:58.385437Z","steps":["trace[651009891] 'process raft request' (duration: 218.40588ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:59.234793Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794900824283797054,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-25T10:31:59.601462Z","caller":"traceutil/trace.go:171","msg":"trace[159072386] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"875.924169ms","start":"2026-07-25T10:31:58.725513Z","end":"2026-07-25T10:31:59.601437Z","steps":["trace[159072386] 'process raft request' (duration: 875.575909ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:59.601657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:58.725494Z","time spent":"876.037683ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208461,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T10:31:59.611303Z","caller":"traceutil/trace.go:171","msg":"trace[268037291] linearizableReadLoop","detail":"{readStateIndex:672; appliedIndex:670; }","duration":"877.367928ms","start":"2026-07-25T10:31:58.733915Z","end":"2026-07-25T10:31:59.611283Z","steps":["trace[268037291] 'read index received' (duration: 867.221391ms)","trace[268037291] 'applied index is now lower than readState.Index' (duration: 10.145487ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:31:59.611431Z","caller":"traceutil/trace.go:171","msg":"trace[1565202767] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"767.235607ms","start":"2026-07-25T10:31:58.844169Z","end":"2026-07-25T10:31:59.611405Z","steps":["trace[1565202767] 'process raft request' (duration: 766.706412ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:59.611501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"843.184913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-25T10:31:59.611544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:58.84414Z","time spent":"767.3165ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570090,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T10:31:59.611586Z","caller":"traceutil/trace.go:171","msg":"trace[1854196894] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:646; }","duration":"843.333398ms","start":"2026-07-25T10:31:58.768234Z","end":"2026-07-25T10:31:59.611567Z","steps":["trace[1854196894] 'agreement among raft nodes before linearized reading' (duration: 843.191724ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:59.611635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:58.768211Z","time spent":"843.414379ms","remote":"127.0.0.1:33924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-25T10:31:59.61172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"802.602636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T10:31:59.611766Z","caller":"traceutil/trace.go:171","msg":"trace[222183248] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:646; }","duration":"802.670978ms","start":"2026-07-25T10:31:58.80908Z","end":"2026-07-25T10:31:59.611751Z","steps":["trace[222183248] 'agreement among raft nodes before linearized reading' (duration: 802.588616ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:59.611853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:58.809067Z","time spent":"802.75903ms","remote":"127.0.0.1:33674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-25T10:31:59.612618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"878.688796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:570105"} {"level":"info","ts":"2026-07-25T10:31:59.612692Z","caller":"traceutil/trace.go:171","msg":"trace[348986098] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:646; }","duration":"878.781799ms","start":"2026-07-25T10:31:58.733878Z","end":"2026-07-25T10:31:59.61266Z","steps":["trace[348986098] 'agreement among raft nodes before linearized reading' (duration: 877.809831ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:31:59.61273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:31:58.73386Z","time spent":"878.86153ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":93,"response count":1,"response size":570129,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" "} {"level":"info","ts":"2026-07-25T10:32:05.139562Z","caller":"traceutil/trace.go:171","msg":"trace[2143277160] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"127.108355ms","start":"2026-07-25T10:32:05.012433Z","end":"2026-07-25T10:32:05.139541Z","steps":["trace[2143277160] 'process raft request' (duration: 126.719104ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:32:05.939954Z","caller":"traceutil/trace.go:171","msg":"trace[854488580] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"256.359088ms","start":"2026-07-25T10:32:05.68357Z","end":"2026-07-25T10:32:05.939929Z","steps":["trace[854488580] 'process raft request' (duration: 254.857068ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:32:05.940239Z","caller":"traceutil/trace.go:171","msg":"trace[303613818] linearizableReadLoop","detail":"{readStateIndex:703; appliedIndex:702; }","duration":"128.445211ms","start":"2026-07-25T10:32:05.811515Z","end":"2026-07-25T10:32:05.93996Z","steps":["trace[303613818] 'read index received' (duration: 126.1732ms)","trace[303613818] 'applied index is now lower than readState.Index' (duration: 2.269161ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T10:32:06.161464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.914838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-25T10:32:06.161559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.739775ms","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-07-25T10:32:06.161601Z","caller":"traceutil/trace.go:171","msg":"trace[1766415361] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:676; }","duration":"350.062943ms","start":"2026-07-25T10:32:05.811488Z","end":"2026-07-25T10:32:06.161551Z","steps":["trace[1766415361] 'agreement among raft nodes before linearized reading' (duration: 128.581935ms)","trace[1766415361] 'range keys from in-memory index tree' (duration: 221.324244ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:32:06.161638Z","caller":"traceutil/trace.go:171","msg":"trace[1215924450] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:676; }","duration":"280.830807ms","start":"2026-07-25T10:32:05.880782Z","end":"2026-07-25T10:32:06.161613Z","steps":["trace[1215924450] 'agreement among raft nodes before linearized reading' (duration: 60.197742ms)","trace[1215924450] 'range keys from in-memory index tree' (duration: 220.255185ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T10:32:06.161652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:05.811469Z","time spent":"350.173885ms","remote":"127.0.0.1:33674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-25T10:32:06.161727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.799647ms","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-07-25T10:32:06.16182Z","caller":"traceutil/trace.go:171","msg":"trace[1178791247] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:676; }","duration":"280.900909ms","start":"2026-07-25T10:32:05.88089Z","end":"2026-07-25T10:32:06.161791Z","steps":["trace[1178791247] 'agreement among raft nodes before linearized reading' (duration: 60.247104ms)","trace[1178791247] 'range keys from in-memory index tree' (duration: 220.263055ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T10:32:06.161475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.414293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.53\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-07-25T10:32:06.161897Z","caller":"traceutil/trace.go:171","msg":"trace[964159084] range","detail":"{range_begin:/registry/masterleases/199.204.45.53; range_end:; response_count:1; response_revision:676; }","duration":"228.908856ms","start":"2026-07-25T10:32:05.932976Z","end":"2026-07-25T10:32:06.161885Z","steps":["trace[964159084] 'range keys from in-memory index tree' (duration: 220.110821ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:32:06.332034Z","caller":"traceutil/trace.go:171","msg":"trace[136988554] linearizableReadLoop","detail":"{readStateIndex:704; appliedIndex:703; }","duration":"168.994918ms","start":"2026-07-25T10:32:06.163016Z","end":"2026-07-25T10:32:06.332011Z","steps":["trace[136988554] 'read index received' (duration: 168.911885ms)","trace[136988554] 'applied index is now lower than readState.Index' (duration: 82.073µs)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:32:06.332089Z","caller":"traceutil/trace.go:171","msg":"trace[557695091] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"332.776509ms","start":"2026-07-25T10:32:05.999272Z","end":"2026-07-25T10:32:06.332048Z","steps":["trace[557695091] 'process raft request' (duration: 332.578993ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:06.332239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:05.999251Z","time spent":"332.916503ms","remote":"127.0.0.1:33992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1092,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T10:32:06.332168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.132051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T10:32:06.332385Z","caller":"traceutil/trace.go:171","msg":"trace[2025856497] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:677; }","duration":"169.379328ms","start":"2026-07-25T10:32:06.162934Z","end":"2026-07-25T10:32:06.332314Z","steps":["trace[2025856497] 'agreement among raft nodes before linearized reading' (duration: 169.163882ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:06.581593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.92715ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"info","ts":"2026-07-25T10:32:06.581938Z","caller":"traceutil/trace.go:171","msg":"trace[1786285933] linearizableReadLoop","detail":"{readStateIndex:707; appliedIndex:704; }","duration":"237.193869ms","start":"2026-07-25T10:32:06.344726Z","end":"2026-07-25T10:32:06.58192Z","steps":["trace[1786285933] 'read index received' (duration: 39.94369ms)","trace[1786285933] 'applied index is now lower than readState.Index' (duration: 197.249319ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:32:06.582064Z","caller":"traceutil/trace.go:171","msg":"trace[1011101240] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"416.07843ms","start":"2026-07-25T10:32:06.165975Z","end":"2026-07-25T10:32:06.582054Z","steps":["trace[1011101240] 'process raft request' (duration: 415.71931ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:06.582157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:06.163075Z","time spent":"419.077739ms","remote":"127.0.0.1:33710","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-07-25T10:32:06.582234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:06.165954Z","time spent":"416.169022ms","remote":"127.0.0.1:33924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T10:32:06.582574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.837067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T10:32:06.582517Z","caller":"traceutil/trace.go:171","msg":"trace[1942055157] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"416.520021ms","start":"2026-07-25T10:32:06.165974Z","end":"2026-07-25T10:32:06.582494Z","steps":["trace[1942055157] 'process raft request' (duration: 415.904505ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:06.582738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:06.165953Z","time spent":"416.719216ms","remote":"127.0.0.1:33924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T10:32:06.582636Z","caller":"traceutil/trace.go:171","msg":"trace[648862003] range","detail":"{range_begin:/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system; range_end:; response_count:0; response_revision:679; }","duration":"237.928079ms","start":"2026-07-25T10:32:06.344693Z","end":"2026-07-25T10:32:06.582621Z","steps":["trace[648862003] 'agreement among raft nodes before linearized reading' (duration: 237.831586ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:32:06.744705Z","caller":"traceutil/trace.go:171","msg":"trace[1139522597] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"161.804367ms","start":"2026-07-25T10:32:06.582873Z","end":"2026-07-25T10:32:06.744677Z","steps":["trace[1139522597] 'process raft request' (duration: 147.553228ms)","trace[1139522597] 'compare' (duration: 14.121295ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:32:06.793115Z","caller":"traceutil/trace.go:171","msg":"trace[558494751] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"197.780092ms","start":"2026-07-25T10:32:06.595309Z","end":"2026-07-25T10:32:06.793089Z","steps":["trace[558494751] 'process raft request' (duration: 197.552246ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:07.870005Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794900824283797167,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-25T10:32:07.960317Z","caller":"traceutil/trace.go:171","msg":"trace[37710462] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"980.053851ms","start":"2026-07-25T10:32:06.98024Z","end":"2026-07-25T10:32:07.960294Z","steps":["trace[37710462] 'process raft request' (duration: 979.915107ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:07.960458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:06.980221Z","time spent":"980.163203ms","remote":"127.0.0.1:33924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T10:32:07.970488Z","caller":"traceutil/trace.go:171","msg":"trace[1808303711] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"976.022332ms","start":"2026-07-25T10:32:06.994449Z","end":"2026-07-25T10:32:07.970471Z","steps":["trace[1808303711] 'process raft request' (duration: 975.408135ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:07.970628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:06.994423Z","time spent":"976.129024ms","remote":"127.0.0.1:33774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036265,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T10:32:07.970665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"601.239781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-25T10:32:07.970746Z","caller":"traceutil/trace.go:171","msg":"trace[439331847] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:683; }","duration":"601.366504ms","start":"2026-07-25T10:32:07.369356Z","end":"2026-07-25T10:32:07.970723Z","steps":["trace[439331847] 'agreement among raft nodes before linearized reading' (duration: 601.2212ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:07.97081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:07.369338Z","time spent":"601.458776ms","remote":"127.0.0.1:33844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":11,"response size":31,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"info","ts":"2026-07-25T10:32:07.970402Z","caller":"traceutil/trace.go:171","msg":"trace[981388036] linearizableReadLoop","detail":"{readStateIndex:711; appliedIndex:709; }","duration":"600.967804ms","start":"2026-07-25T10:32:07.369403Z","end":"2026-07-25T10:32:07.97037Z","steps":["trace[981388036] 'read index received' (duration: 590.796527ms)","trace[981388036] 'applied index is now lower than readState.Index' (duration: 10.169667ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T10:32:07.971142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.380464ms","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-07-25T10:32:07.971169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.674484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T10:32:07.971211Z","caller":"traceutil/trace.go:171","msg":"trace[1786355310] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:683; }","duration":"159.740236ms","start":"2026-07-25T10:32:07.811458Z","end":"2026-07-25T10:32:07.971198Z","steps":["trace[1786355310] 'agreement among raft nodes before linearized reading' (duration: 159.663584ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:32:07.971191Z","caller":"traceutil/trace.go:171","msg":"trace[1474893425] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:683; }","duration":"315.466066ms","start":"2026-07-25T10:32:07.655709Z","end":"2026-07-25T10:32:07.971175Z","steps":["trace[1474893425] 'agreement among raft nodes before linearized reading' (duration: 315.367374ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:07.97129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.314586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-25T10:32:07.971341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:07.655691Z","time spent":"315.569578ms","remote":"127.0.0.1:33924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-25T10:32:07.97135Z","caller":"traceutil/trace.go:171","msg":"trace[213602712] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:683; }","duration":"314.399188ms","start":"2026-07-25T10:32:07.656924Z","end":"2026-07-25T10:32:07.971323Z","steps":["trace[213602712] 'agreement among raft nodes before linearized reading' (duration: 314.245704ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:07.971392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:07.656901Z","time spent":"314.48032ms","remote":"127.0.0.1:33924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-25T10:32:10.004336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.65437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-25T10:32:10.004343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.410242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-25T10:32:10.004418Z","caller":"traceutil/trace.go:171","msg":"trace[1337544564] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:726; }","duration":"191.809164ms","start":"2026-07-25T10:32:09.812592Z","end":"2026-07-25T10:32:10.004401Z","steps":["trace[1337544564] 'range keys from in-memory index tree' (duration: 191.534047ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:32:10.004464Z","caller":"traceutil/trace.go:171","msg":"trace[1090531641] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:726; }","duration":"189.515034ms","start":"2026-07-25T10:32:09.8149Z","end":"2026-07-25T10:32:10.004415Z","steps":["trace[1090531641] 'count revisions from in-memory index tree' (duration: 189.37112ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:32:10.01132Z","caller":"traceutil/trace.go:171","msg":"trace[1803441520] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"172.180775ms","start":"2026-07-25T10:32:09.83912Z","end":"2026-07-25T10:32:10.011301Z","steps":["trace[1803441520] 'process raft request' (duration: 171.910928ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:32:20.994224Z","caller":"traceutil/trace.go:171","msg":"trace[2086600667] transaction","detail":"{read_only:false; response_revision:832; number_of_response:1; }","duration":"297.717535ms","start":"2026-07-25T10:32:20.696484Z","end":"2026-07-25T10:32:20.994201Z","steps":["trace[2086600667] 'process raft request' (duration: 297.584131ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:24.132936Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794900824283797570,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-25T10:32:24.593922Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.07411188s","expected-duration":"1s"} {"level":"info","ts":"2026-07-25T10:32:24.594329Z","caller":"traceutil/trace.go:171","msg":"trace[2019975803] linearizableReadLoop","detail":"{readStateIndex:883; appliedIndex:882; }","duration":"961.408935ms","start":"2026-07-25T10:32:23.632893Z","end":"2026-07-25T10:32:24.594302Z","steps":["trace[2019975803] 'read index received' (duration: 961.19105ms)","trace[2019975803] 'applied index is now lower than readState.Index' (duration: 216.685µs)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:32:24.594389Z","caller":"traceutil/trace.go:171","msg":"trace[499771865] transaction","detail":"{read_only:false; response_revision:850; number_of_response:1; }","duration":"1.074637653s","start":"2026-07-25T10:32:23.519724Z","end":"2026-07-25T10:32:24.594361Z","steps":["trace[499771865] 'process raft request' (duration: 1.074449658s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:24.59448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"961.570859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T10:32:24.594526Z","caller":"traceutil/trace.go:171","msg":"trace[218402200] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:850; }","duration":"961.63707ms","start":"2026-07-25T10:32:23.632878Z","end":"2026-07-25T10:32:24.594515Z","steps":["trace[218402200] 'agreement among raft nodes before linearized reading' (duration: 961.548448ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:24.594559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:23.632816Z","time spent":"961.733782ms","remote":"127.0.0.1:33872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":29,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-07-25T10:32:24.59471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:23.519702Z","time spent":"1.074751676s","remote":"127.0.0.1:33924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T10:32:24.594744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.19451ms","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-07-25T10:32:24.594798Z","caller":"traceutil/trace.go:171","msg":"trace[918901521] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:850; }","duration":"508.282092ms","start":"2026-07-25T10:32:24.086498Z","end":"2026-07-25T10:32:24.59478Z","steps":["trace[918901521] 'agreement among raft nodes before linearized reading' (duration: 508.146549ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:24.594812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"783.204325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-25T10:32:24.594842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:24.086477Z","time spent":"508.355243ms","remote":"127.0.0.1:33924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-25T10:32:24.59486Z","caller":"traceutil/trace.go:171","msg":"trace[658632088] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:850; }","duration":"783.282297ms","start":"2026-07-25T10:32:23.811561Z","end":"2026-07-25T10:32:24.594843Z","steps":["trace[658632088] 'agreement among raft nodes before linearized reading' (duration: 783.216265ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:24.594724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"912.31814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-hhx8r\" ","response":"range_response_count:1 size:3964"} {"level":"warn","ts":"2026-07-25T10:32:24.5949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:23.81154Z","time spent":"783.350518ms","remote":"127.0.0.1:33674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-25T10:32:24.59492Z","caller":"traceutil/trace.go:171","msg":"trace[2098909150] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-hhx8r; range_end:; response_count:1; response_revision:850; }","duration":"912.552645ms","start":"2026-07-25T10:32:23.682354Z","end":"2026-07-25T10:32:24.594906Z","steps":["trace[2098909150] 'agreement among raft nodes before linearized reading' (duration: 912.128105ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:24.594962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:23.682338Z","time spent":"912.612767ms","remote":"127.0.0.1:33844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-hhx8r\" "} {"level":"warn","ts":"2026-07-25T10:32:24.595566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.393727ms","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-07-25T10:32:24.595693Z","caller":"traceutil/trace.go:171","msg":"trace[1614812944] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:850; }","duration":"510.365549ms","start":"2026-07-25T10:32:24.085293Z","end":"2026-07-25T10:32:24.595658Z","steps":["trace[1614812944] 'agreement among raft nodes before linearized reading' (duration: 509.205203ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:32:24.595811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:32:24.085273Z","time spent":"510.461962ms","remote":"127.0.0.1:33924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-25T10:32:30.744748Z","caller":"traceutil/trace.go:171","msg":"trace[1728019814] linearizableReadLoop","detail":"{readStateIndex:950; appliedIndex:948; }","duration":"117.915238ms","start":"2026-07-25T10:32:30.626807Z","end":"2026-07-25T10:32:30.744723Z","steps":["trace[1728019814] 'read index received' (duration: 33.846223ms)","trace[1728019814] 'applied index is now lower than readState.Index' (duration: 84.068025ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:32:30.744873Z","caller":"traceutil/trace.go:171","msg":"trace[1452107074] transaction","detail":"{read_only:false; response_revision:916; number_of_response:1; }","duration":"119.383321ms","start":"2026-07-25T10:32:30.625419Z","end":"2026-07-25T10:32:30.744803Z","steps":["trace[1452107074] 'process raft request' (duration: 65.150801ms)","trace[1452107074] 'compare' (duration: 54.043796ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T10:32:30.744977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.156324ms","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-07-25T10:32:30.745058Z","caller":"traceutil/trace.go:171","msg":"trace[538805734] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:916; }","duration":"118.317537ms","start":"2026-07-25T10:32:30.626724Z","end":"2026-07-25T10:32:30.745042Z","steps":["trace[538805734] 'agreement among raft nodes before linearized reading' (duration: 118.086152ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:34:04.946851Z","caller":"traceutil/trace.go:171","msg":"trace[458329187] transaction","detail":"{read_only:false; response_revision:1481; number_of_response:1; }","duration":"101.020925ms","start":"2026-07-25T10:34:04.845798Z","end":"2026-07-25T10:34:04.946819Z","steps":["trace[458329187] 'process raft request' (duration: 100.536628ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:34:11.927071Z","caller":"traceutil/trace.go:171","msg":"trace[757261315] transaction","detail":"{read_only:false; response_revision:1658; number_of_response:1; }","duration":"156.76817ms","start":"2026-07-25T10:34:11.770277Z","end":"2026-07-25T10:34:11.927045Z","steps":["trace[757261315] 'process raft request' (duration: 156.610467ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:34:11.934517Z","caller":"traceutil/trace.go:171","msg":"trace[1291722101] linearizableReadLoop","detail":"{readStateIndex:1718; appliedIndex:1716; }","duration":"123.033339ms","start":"2026-07-25T10:34:11.811467Z","end":"2026-07-25T10:34:11.934501Z","steps":["trace[1291722101] 'read index received' (duration: 115.436223ms)","trace[1291722101] 'applied index is now lower than readState.Index' (duration: 7.596136ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:34:11.93455Z","caller":"traceutil/trace.go:171","msg":"trace[662851435] transaction","detail":"{read_only:false; response_revision:1659; number_of_response:1; }","duration":"163.740947ms","start":"2026-07-25T10:34:11.770781Z","end":"2026-07-25T10:34:11.934522Z","steps":["trace[662851435] 'process raft request' (duration: 163.567855ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:34:11.934971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.492455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T10:34:11.935012Z","caller":"traceutil/trace.go:171","msg":"trace[1057583456] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1660; }","duration":"123.581736ms","start":"2026-07-25T10:34:11.811419Z","end":"2026-07-25T10:34:11.935001Z","steps":["trace[1057583456] 'agreement among raft nodes before linearized reading' (duration: 123.506905ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:34:13.275195Z","caller":"traceutil/trace.go:171","msg":"trace[517020837] transaction","detail":"{read_only:false; response_revision:1675; number_of_response:1; }","duration":"166.789889ms","start":"2026-07-25T10:34:13.108384Z","end":"2026-07-25T10:34:13.275174Z","steps":["trace[517020837] 'process raft request' (duration: 166.656967ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:34:13.275703Z","caller":"traceutil/trace.go:171","msg":"trace[1452660151] linearizableReadLoop","detail":"{readStateIndex:1735; appliedIndex:1733; }","duration":"118.142102ms","start":"2026-07-25T10:34:13.157541Z","end":"2026-07-25T10:34:13.275683Z","steps":["trace[1452660151] 'read index received' (duration: 117.535254ms)","trace[1452660151] 'applied index is now lower than readState.Index' (duration: 605.908µs)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:34:13.275909Z","caller":"traceutil/trace.go:171","msg":"trace[1710566935] transaction","detail":"{read_only:false; response_revision:1676; number_of_response:1; }","duration":"162.203785ms","start":"2026-07-25T10:34:13.113693Z","end":"2026-07-25T10:34:13.275897Z","steps":["trace[1710566935] 'process raft request' (duration: 161.896171ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:34:13.276103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.557759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-25T10:34:13.276135Z","caller":"traceutil/trace.go:171","msg":"trace[623193905] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1676; }","duration":"118.637299ms","start":"2026-07-25T10:34:13.157488Z","end":"2026-07-25T10:34:13.276125Z","steps":["trace[623193905] 'agreement among raft nodes before linearized reading' (duration: 118.545658ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:34:20.882731Z","caller":"traceutil/trace.go:171","msg":"trace[507646486] transaction","detail":"{read_only:false; response_revision:1740; number_of_response:1; }","duration":"758.488199ms","start":"2026-07-25T10:34:20.124218Z","end":"2026-07-25T10:34:20.882706Z","steps":["trace[507646486] 'process raft request' (duration: 758.333847ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:34:20.882887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:34:20.124203Z","time spent":"758.609031ms","remote":"127.0.0.1:33844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7289,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T10:34:21.483229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.780427ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T10:34:21.483315Z","caller":"traceutil/trace.go:171","msg":"trace[885184188] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1740; }","duration":"326.878578ms","start":"2026-07-25T10:34:21.156424Z","end":"2026-07-25T10:34:21.483302Z","steps":["trace[885184188] 'range keys from in-memory index tree' (duration: 326.754106ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:34:21.483539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"593.350634ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T10:34:21.483716Z","caller":"traceutil/trace.go:171","msg":"trace[719266745] transaction","detail":"{read_only:false; response_revision:1741; number_of_response:1; }","duration":"1.132839673s","start":"2026-07-25T10:34:20.350857Z","end":"2026-07-25T10:34:21.483697Z","steps":["trace[719266745] 'process raft request' (duration: 539.273566ms)","trace[719266745] 'compare' (duration: 593.227033ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T10:34:21.483812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:34:20.350832Z","time spent":"1.132928784s","remote":"127.0.0.1:33924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T10:34:21.483803Z","caller":"traceutil/trace.go:171","msg":"trace[4235537] transaction","detail":"{read_only:false; response_revision:1742; number_of_response:1; }","duration":"809.741257ms","start":"2026-07-25T10:34:20.674027Z","end":"2026-07-25T10:34:21.483768Z","steps":["trace[4235537] 'process raft request' (duration: 809.575455ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:34:21.483813Z","caller":"traceutil/trace.go:171","msg":"trace[1780093383] linearizableReadLoop","detail":"{readStateIndex:1802; appliedIndex:1800; }","duration":"1.062447039s","start":"2026-07-25T10:34:20.42133Z","end":"2026-07-25T10:34:21.483777Z","steps":["trace[1780093383] 'read index received' (duration: 461.293919ms)","trace[1780093383] 'applied index is now lower than readState.Index' (duration: 601.14935ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T10:34:21.483943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:34:20.673985Z","time spent":"809.88673ms","remote":"127.0.0.1:33924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T10:34:21.682614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.941919ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"warn","ts":"2026-07-25T10:34:21.682852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.26149606s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" ","response":"range_response_count:1 size:1035"} {"level":"info","ts":"2026-07-25T10:34:21.682927Z","caller":"traceutil/trace.go:171","msg":"trace[1604922154] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:1; response_revision:1742; }","duration":"1.261617581s","start":"2026-07-25T10:34:20.421289Z","end":"2026-07-25T10:34:21.682907Z","steps":["trace[1604922154] 'agreement among raft nodes before linearized reading' (duration: 1.06256519s)","trace[1604922154] 'range keys from in-memory index tree' (duration: 198.825997ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T10:34:21.683004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:34:20.421271Z","time spent":"1.261692622s","remote":"127.0.0.1:33950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":1059,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" "} {"level":"info","ts":"2026-07-25T10:34:21.683368Z","caller":"traceutil/trace.go:171","msg":"trace[2085986543] linearizableReadLoop","detail":"{readStateIndex:1805; appliedIndex:1803; }","duration":"199.472466ms","start":"2026-07-25T10:34:21.483883Z","end":"2026-07-25T10:34:21.683356Z","steps":["trace[2085986543] 'read index received' (duration: 66.191µs)","trace[2085986543] 'applied index is now lower than readState.Index' (duration: 199.404595ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:34:21.683547Z","caller":"traceutil/trace.go:171","msg":"trace[441349122] transaction","detail":"{read_only:false; response_revision:1743; number_of_response:1; }","duration":"385.331527ms","start":"2026-07-25T10:34:21.298179Z","end":"2026-07-25T10:34:21.68351Z","steps":["trace[441349122] 'process raft request' (duration: 384.519716ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:34:21.683655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:34:21.298157Z","time spent":"385.438659ms","remote":"127.0.0.1:33924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T10:34:21.700728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.130199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-07-25T10:34:21.700742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.659558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-25T10:34:21.700807Z","caller":"traceutil/trace.go:171","msg":"trace[749558707] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1743; }","duration":"370.21758ms","start":"2026-07-25T10:34:21.330569Z","end":"2026-07-25T10:34:21.700787Z","steps":["trace[749558707] 'agreement among raft nodes before linearized reading' (duration: 352.938384ms)","trace[749558707] 'range keys from in-memory index tree' (duration: 17.096224ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:34:21.700826Z","caller":"traceutil/trace.go:171","msg":"trace[324232573] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1743; }","duration":"387.772491ms","start":"2026-07-25T10:34:21.313025Z","end":"2026-07-25T10:34:21.700797Z","steps":["trace[324232573] 'agreement among raft nodes before linearized reading' (duration: 370.499085ms)","trace[324232573] 'range keys from in-memory index tree' (duration: 17.079433ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T10:34:21.700845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:34:21.330523Z","time spent":"370.314262ms","remote":"127.0.0.1:33924","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-07-25T10:34:21.700823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.792686ms","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-07-25T10:34:21.700874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:34:21.313009Z","time spent":"387.853132ms","remote":"127.0.0.1:33924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-25T10:34:21.700868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.250596ms","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-07-25T10:34:21.700897Z","caller":"traceutil/trace.go:171","msg":"trace[1296769347] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1743; }","duration":"383.922098ms","start":"2026-07-25T10:34:21.316955Z","end":"2026-07-25T10:34:21.700878Z","steps":["trace[1296769347] 'agreement among raft nodes before linearized reading' (duration: 366.56058ms)","trace[1296769347] 'range keys from in-memory index tree' (duration: 17.146314ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:34:21.700923Z","caller":"traceutil/trace.go:171","msg":"trace[314052533] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1743; }","duration":"366.324997ms","start":"2026-07-25T10:34:21.334581Z","end":"2026-07-25T10:34:21.700906Z","steps":["trace[314052533] 'agreement among raft nodes before linearized reading' (duration: 349.078821ms)","trace[314052533] 'range keys from in-memory index tree' (duration: 17.143254ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T10:34:21.700945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:34:21.316922Z","time spent":"384.01483ms","remote":"127.0.0.1:33924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-25T10:34:21.70095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:34:21.334573Z","time spent":"366.371468ms","remote":"127.0.0.1:33924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-25T10:34:21.701073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"889.404072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T10:34:21.701115Z","caller":"traceutil/trace.go:171","msg":"trace[1998245363] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1743; }","duration":"889.476344ms","start":"2026-07-25T10:34:20.811624Z","end":"2026-07-25T10:34:21.7011Z","steps":["trace[1998245363] 'agreement among raft nodes before linearized reading' (duration: 871.865713ms)","trace[1998245363] 'range keys from in-memory index tree' (duration: 17.55542ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T10:34:21.701146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:34:20.811604Z","time spent":"889.536474ms","remote":"127.0.0.1:33674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-25T10:34:21.701611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.155183ms","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-07-25T10:34:21.701649Z","caller":"traceutil/trace.go:171","msg":"trace[631248434] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1743; }","duration":"368.218993ms","start":"2026-07-25T10:34:21.333418Z","end":"2026-07-25T10:34:21.701637Z","steps":["trace[631248434] 'agreement among raft nodes before linearized reading' (duration: 350.064855ms)","trace[631248434] 'range keys from in-memory index tree' (duration: 17.52697ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T10:34:21.70168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:34:21.333406Z","time spent":"368.267484ms","remote":"127.0.0.1:33924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-25T10:34:22.341996Z","caller":"traceutil/trace.go:171","msg":"trace[1967796739] transaction","detail":"{read_only:false; response_revision:1746; number_of_response:1; }","duration":"636.013274ms","start":"2026-07-25T10:34:21.705965Z","end":"2026-07-25T10:34:22.341978Z","steps":["trace[1967796739] 'process raft request' (duration: 635.964073ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:34:22.342074Z","caller":"traceutil/trace.go:171","msg":"trace[485373200] transaction","detail":"{read_only:false; response_revision:1745; number_of_response:1; }","duration":"637.071278ms","start":"2026-07-25T10:34:21.704966Z","end":"2026-07-25T10:34:22.342038Z","steps":["trace[485373200] 'process raft request' (duration: 636.846824ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:34:22.342246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:34:21.70495Z","time spent":"637.214159ms","remote":"127.0.0.1:33924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T10:34:22.342114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:34:21.705951Z","time spent":"636.096645ms","remote":"127.0.0.1:33924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T10:34:22.342439Z","caller":"traceutil/trace.go:171","msg":"trace[445848826] linearizableReadLoop","detail":"{readStateIndex:1808; appliedIndex:1805; }","duration":"636.374739ms","start":"2026-07-25T10:34:21.706039Z","end":"2026-07-25T10:34:22.342413Z","steps":["trace[445848826] 'read index received' (duration: 14.238625ms)","trace[445848826] 'applied index is now lower than readState.Index' (duration: 622.135104ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:34:22.342492Z","caller":"traceutil/trace.go:171","msg":"trace[914883408] transaction","detail":"{read_only:false; response_revision:1748; number_of_response:1; }","duration":"636.234317ms","start":"2026-07-25T10:34:21.706248Z","end":"2026-07-25T10:34:22.342482Z","steps":["trace[914883408] 'process raft request' (duration: 636.020174ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:34:22.342538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:34:21.706162Z","time spent":"636.350318ms","remote":"127.0.0.1:33924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T10:34:22.342595Z","caller":"traceutil/trace.go:171","msg":"trace[2062120861] transaction","detail":"{read_only:false; response_revision:1747; number_of_response:1; }","duration":"636.328988ms","start":"2026-07-25T10:34:21.706251Z","end":"2026-07-25T10:34:22.34258Z","steps":["trace[2062120861] 'process raft request' (duration: 635.705059ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:34:22.342629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.224408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T10:34:22.342653Z","caller":"traceutil/trace.go:171","msg":"trace[2029290684] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1748; }","duration":"530.309679ms","start":"2026-07-25T10:34:21.812335Z","end":"2026-07-25T10:34:22.342644Z","steps":["trace[2029290684] 'agreement among raft nodes before linearized reading' (duration: 530.270178ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:34:22.34267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:34:21.812318Z","time spent":"530.349289ms","remote":"127.0.0.1:33674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-25T10:34:22.342662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:34:21.70624Z","time spent":"636.388149ms","remote":"127.0.0.1:33924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T10:34:22.342679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"636.619202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5993"} {"level":"info","ts":"2026-07-25T10:34:22.342717Z","caller":"traceutil/trace.go:171","msg":"trace[609644734] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1748; }","duration":"636.693443ms","start":"2026-07-25T10:34:21.706013Z","end":"2026-07-25T10:34:22.342706Z","steps":["trace[609644734] 'agreement among raft nodes before linearized reading' (duration: 636.53425ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:34:22.342753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:34:21.706005Z","time spent":"636.739983ms","remote":"127.0.0.1:33842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":6017,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-07-25T10:34:35.537441Z","caller":"traceutil/trace.go:171","msg":"trace[1286539481] transaction","detail":"{read_only:false; response_revision:1991; number_of_response:1; }","duration":"225.571545ms","start":"2026-07-25T10:34:35.311838Z","end":"2026-07-25T10:34:35.53741Z","steps":["trace[1286539481] 'process raft request' (duration: 225.310491ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:34:35.538095Z","caller":"traceutil/trace.go:171","msg":"trace[1057058363] transaction","detail":"{read_only:false; response_revision:1992; number_of_response:1; }","duration":"225.218351ms","start":"2026-07-25T10:34:35.312841Z","end":"2026-07-25T10:34:35.53806Z","steps":["trace[1057058363] 'process raft request' (duration: 224.499831ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:34:35.538137Z","caller":"traceutil/trace.go:171","msg":"trace[1771758776] transaction","detail":"{read_only:false; response_revision:1993; number_of_response:1; }","duration":"225.190571ms","start":"2026-07-25T10:34:35.312933Z","end":"2026-07-25T10:34:35.538124Z","steps":["trace[1771758776] 'process raft request' (duration: 225.023518ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:34:35.538298Z","caller":"traceutil/trace.go:171","msg":"trace[1081629713] transaction","detail":"{read_only:false; response_revision:1994; number_of_response:1; }","duration":"225.246791ms","start":"2026-07-25T10:34:35.313015Z","end":"2026-07-25T10:34:35.538261Z","steps":["trace[1081629713] 'process raft request' (duration: 225.016618ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:34:35.538633Z","caller":"traceutil/trace.go:171","msg":"trace[1577775815] transaction","detail":"{read_only:false; response_revision:1996; number_of_response:1; }","duration":"211.130603ms","start":"2026-07-25T10:34:35.327485Z","end":"2026-07-25T10:34:35.538616Z","steps":["trace[1577775815] 'process raft request' (duration: 211.045562ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:34:35.538643Z","caller":"traceutil/trace.go:171","msg":"trace[889043272] transaction","detail":"{read_only:false; response_revision:1995; number_of_response:1; }","duration":"225.377063ms","start":"2026-07-25T10:34:35.313251Z","end":"2026-07-25T10:34:35.538628Z","steps":["trace[889043272] 'process raft request' (duration: 224.835276ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:34:35.740072Z","caller":"traceutil/trace.go:171","msg":"trace[1307327579] transaction","detail":"{read_only:false; response_revision:1997; number_of_response:1; }","duration":"194.787436ms","start":"2026-07-25T10:34:35.545251Z","end":"2026-07-25T10:34:35.740038Z","steps":["trace[1307327579] 'process raft request' (duration: 194.615083ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:34:35.746417Z","caller":"traceutil/trace.go:171","msg":"trace[1542372809] transaction","detail":"{read_only:false; response_revision:1999; number_of_response:1; }","duration":"193.988444ms","start":"2026-07-25T10:34:35.55241Z","end":"2026-07-25T10:34:35.746398Z","steps":["trace[1542372809] 'process raft request' (duration: 193.933874ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:34:35.746454Z","caller":"traceutil/trace.go:171","msg":"trace[320859463] transaction","detail":"{read_only:false; response_revision:1998; number_of_response:1; }","duration":"197.319789ms","start":"2026-07-25T10:34:35.549115Z","end":"2026-07-25T10:34:35.746435Z","steps":["trace[320859463] 'process raft request' (duration: 197.126046ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:34:39.874404Z","caller":"traceutil/trace.go:171","msg":"trace[1618822283] transaction","detail":"{read_only:false; response_revision:2031; number_of_response:1; }","duration":"115.118394ms","start":"2026-07-25T10:34:39.759259Z","end":"2026-07-25T10:34:39.874377Z","steps":["trace[1618822283] 'process raft request' (duration: 114.936041ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:34:57.566236Z","caller":"traceutil/trace.go:171","msg":"trace[1242874084] transaction","detail":"{read_only:false; response_revision:2142; number_of_response:1; }","duration":"125.838945ms","start":"2026-07-25T10:34:57.440375Z","end":"2026-07-25T10:34:57.566214Z","steps":["trace[1242874084] 'process raft request' (duration: 125.697253ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:35:03.6841Z","caller":"traceutil/trace.go:171","msg":"trace[1065229888] transaction","detail":"{read_only:false; response_revision:2173; number_of_response:1; }","duration":"102.33099ms","start":"2026-07-25T10:35:03.581748Z","end":"2026-07-25T10:35:03.684079Z","steps":["trace[1065229888] 'process raft request' (duration: 102.199439ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:35:04.09738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.979797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T10:35:04.097479Z","caller":"traceutil/trace.go:171","msg":"trace[968398459] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2173; }","duration":"285.127039ms","start":"2026-07-25T10:35:03.812327Z","end":"2026-07-25T10:35:04.097454Z","steps":["trace[968398459] 'range keys from in-memory index tree' (duration: 284.887217ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:35:04.097726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.401058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-25T10:35:04.097778Z","caller":"traceutil/trace.go:171","msg":"trace[526306019] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:2173; }","duration":"340.490339ms","start":"2026-07-25T10:35:03.757268Z","end":"2026-07-25T10:35:04.097759Z","steps":["trace[526306019] 'count revisions from in-memory index tree' (duration: 340.313377ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:35:04.09781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:35:03.757247Z","time spent":"340.552881ms","remote":"127.0.0.1:47400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":31,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "} {"level":"info","ts":"2026-07-25T10:35:04.101774Z","caller":"traceutil/trace.go:171","msg":"trace[67470757] linearizableReadLoop","detail":"{readStateIndex:2266; appliedIndex:2265; }","duration":"121.294986ms","start":"2026-07-25T10:35:03.980465Z","end":"2026-07-25T10:35:04.10176Z","steps":["trace[67470757] 'read index received' (duration: 121.106924ms)","trace[67470757] 'applied index is now lower than readState.Index' (duration: 187.402µs)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:35:04.101797Z","caller":"traceutil/trace.go:171","msg":"trace[211152957] transaction","detail":"{read_only:false; response_revision:2174; number_of_response:1; }","duration":"138.007335ms","start":"2026-07-25T10:35:03.963778Z","end":"2026-07-25T10:35:04.101785Z","steps":["trace[211152957] 'process raft request' (duration: 137.839883ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:35:04.101914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.452608ms","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-07-25T10:35:04.101941Z","caller":"traceutil/trace.go:171","msg":"trace[1967859493] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2174; }","duration":"121.481558ms","start":"2026-07-25T10:35:03.98045Z","end":"2026-07-25T10:35:04.101932Z","steps":["trace[1967859493] 'agreement among raft nodes before linearized reading' (duration: 121.380837ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:35:18.671222Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794900824283800446,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-25T10:35:18.677045Z","caller":"traceutil/trace.go:171","msg":"trace[1197065270] transaction","detail":"{read_only:false; response_revision:2256; number_of_response:1; }","duration":"525.794709ms","start":"2026-07-25T10:35:18.151225Z","end":"2026-07-25T10:35:18.67702Z","steps":["trace[1197065270] 'process raft request' (duration: 525.607107ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:35:18.677084Z","caller":"traceutil/trace.go:171","msg":"trace[1623228026] linearizableReadLoop","detail":"{readStateIndex:2351; appliedIndex:2350; }","duration":"505.973363ms","start":"2026-07-25T10:35:18.171012Z","end":"2026-07-25T10:35:18.676985Z","steps":["trace[1623228026] 'read index received' (duration: 505.76656ms)","trace[1623228026] 'applied index is now lower than readState.Index' (duration: 205.813µs)"],"step_count":2} {"level":"warn","ts":"2026-07-25T10:35:18.677176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:35:18.151199Z","time spent":"525.90264ms","remote":"127.0.0.1:33924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T10:35:18.677504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.578243ms","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-07-25T10:35:18.677633Z","caller":"traceutil/trace.go:171","msg":"trace[301511151] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:2256; }","duration":"258.817235ms","start":"2026-07-25T10:35:18.418792Z","end":"2026-07-25T10:35:18.677609Z","steps":["trace[301511151] 'agreement among raft nodes before linearized reading' (duration: 258.489981ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:35:18.677959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.939384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-25T10:35:18.678027Z","caller":"traceutil/trace.go:171","msg":"trace[786082583] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2256; }","duration":"507.048885ms","start":"2026-07-25T10:35:18.170963Z","end":"2026-07-25T10:35:18.678011Z","steps":["trace[786082583] 'agreement among raft nodes before linearized reading' (duration: 506.165325ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:35:18.67806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:35:18.170942Z","time spent":"507.110616ms","remote":"127.0.0.1:33924","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":"warn","ts":"2026-07-25T10:35:19.308293Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794900824283800451,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-25T10:35:19.549963Z","caller":"traceutil/trace.go:171","msg":"trace[665713592] transaction","detail":"{read_only:false; response_revision:2257; number_of_response:1; }","duration":"867.736996ms","start":"2026-07-25T10:35:18.682209Z","end":"2026-07-25T10:35:19.549946Z","steps":["trace[665713592] 'process raft request' (duration: 866.39817ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:35:19.550058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:35:18.682186Z","time spent":"867.824576ms","remote":"127.0.0.1:33924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T10:35:19.558712Z","caller":"traceutil/trace.go:171","msg":"trace[1171116305] linearizableReadLoop","detail":"{readStateIndex:2358; appliedIndex:2351; }","duration":"750.497638ms","start":"2026-07-25T10:35:18.808192Z","end":"2026-07-25T10:35:19.55869Z","steps":["trace[1171116305] 'read index received' (duration: 740.58206ms)","trace[1171116305] 'applied index is now lower than readState.Index' (duration: 9.914398ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T10:35:19.558914Z","caller":"traceutil/trace.go:171","msg":"trace[865464324] transaction","detail":"{read_only:false; response_revision:2259; number_of_response:1; }","duration":"876.354058ms","start":"2026-07-25T10:35:18.682549Z","end":"2026-07-25T10:35:19.558903Z","steps":["trace[865464324] 'process raft request' (duration: 875.914383ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:35:19.559012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:35:18.682524Z","time spent":"876.419329ms","remote":"127.0.0.1:33924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T10:35:19.559028Z","caller":"traceutil/trace.go:171","msg":"trace[1894144110] transaction","detail":"{read_only:false; response_revision:2260; number_of_response:1; }","duration":"876.174436ms","start":"2026-07-25T10:35:18.682832Z","end":"2026-07-25T10:35:19.559007Z","steps":["trace[1894144110] 'process raft request' (duration: 875.70609ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:35:19.559016Z","caller":"traceutil/trace.go:171","msg":"trace[87396129] transaction","detail":"{read_only:false; response_revision:2258; number_of_response:1; }","duration":"876.607572ms","start":"2026-07-25T10:35:18.682382Z","end":"2026-07-25T10:35:19.558989Z","steps":["trace[87396129] 'process raft request' (duration: 875.985394ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T10:35:19.559053Z","caller":"traceutil/trace.go:171","msg":"trace[1760800813] transaction","detail":"{read_only:false; response_revision:2262; number_of_response:1; }","duration":"800.12817ms","start":"2026-07-25T10:35:18.758777Z","end":"2026-07-25T10:35:19.558905Z","steps":["trace[1760800813] 'process raft request' (duration: 799.839796ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:35:19.559143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:35:18.68282Z","time spent":"876.262248ms","remote":"127.0.0.1:33924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T10:35:19.559182Z","caller":"traceutil/trace.go:171","msg":"trace[1479017344] transaction","detail":"{read_only:false; response_revision:2261; number_of_response:1; }","duration":"876.333288ms","start":"2026-07-25T10:35:18.682845Z","end":"2026-07-25T10:35:19.559178Z","steps":["trace[1479017344] 'process raft request' (duration: 875.740991ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:35:19.559169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:35:18.68237Z","time spent":"876.728373ms","remote":"127.0.0.1:33924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T10:35:19.559214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:35:18.682835Z","time spent":"876.360138ms","remote":"127.0.0.1:33924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T10:35:19.55923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"750.972494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-25T10:35:19.559311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"679.600512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T10:35:19.559333Z","caller":"traceutil/trace.go:171","msg":"trace[886239433] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:2263; }","duration":"679.649093ms","start":"2026-07-25T10:35:18.879676Z","end":"2026-07-25T10:35:19.559325Z","steps":["trace[886239433] 'agreement among raft nodes before linearized reading' (duration: 679.608442ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:35:19.559348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:35:18.879661Z","time spent":"679.683764ms","remote":"127.0.0.1:47296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"info","ts":"2026-07-25T10:35:19.559384Z","caller":"traceutil/trace.go:171","msg":"trace[685957774] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2263; }","duration":"751.155415ms","start":"2026-07-25T10:35:18.808161Z","end":"2026-07-25T10:35:19.559316Z","steps":["trace[685957774] 'agreement among raft nodes before linearized reading' (duration: 750.969883ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:35:19.55946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:35:18.808146Z","time spent":"751.303458ms","remote":"127.0.0.1:33674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-25T10:35:19.559158Z","caller":"traceutil/trace.go:171","msg":"trace[2072658628] transaction","detail":"{read_only:false; response_revision:2263; number_of_response:1; }","duration":"266.664859ms","start":"2026-07-25T10:35:19.292486Z","end":"2026-07-25T10:35:19.559151Z","steps":["trace[2072658628] 'process raft request' (duration: 266.161973ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T10:35:19.559585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T10:35:18.758754Z","time spent":"800.541534ms","remote":"127.0.0.1:33924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T10:35:28.13531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.203063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/\" range_end:\"/registry/secrets/openstack0\" ","response":"range_response_count:4 size:233962"} {"level":"info","ts":"2026-07-25T10:35:28.135391Z","caller":"traceutil/trace.go:171","msg":"trace[2076800341] range","detail":"{range_begin:/registry/secrets/openstack/; range_end:/registry/secrets/openstack0; response_count:4; response_revision:2306; }","duration":"104.377715ms","start":"2026-07-25T10:35:28.030997Z","end":"2026-07-25T10:35:28.135374Z","steps":["trace[2076800341] 'range keys from in-memory index tree' (duration: 103.855979ms)"],"step_count":1}