{"level":"warn","ts":"2026-06-05T17:56:43.10891Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-05T17:56:43.108986Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.116: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.116:2380","--initial-cluster=instance=https://199.204.45.116:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.116:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.116: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-06-05T17:56:43.109046Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-05T17:56:43.109058Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.116:2380"]} {"level":"info","ts":"2026-06-05T17:56:43.109073Z","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-06-05T17:56:43.10965Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"]} {"level":"info","ts":"2026-06-05T17:56:43.109762Z","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.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.116: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-06-05T17:56:44.310742Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"1.151089307s"} {"level":"warn","ts":"2026-06-05T17:56:45.427049Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.114298953s","expected-duration":"1s"} {"level":"info","ts":"2026-06-05T17:56:45.437641Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5caa70ef1dd6dc04","cluster-id":"45afccab143d2c82"} {"level":"info","ts":"2026-06-05T17:56:45.437745Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=()"} {"level":"info","ts":"2026-06-05T17:56:45.437788Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 0"} {"level":"info","ts":"2026-06-05T17:56:45.437809Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5caa70ef1dd6dc04 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-05T17:56:45.437834Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 1"} {"level":"info","ts":"2026-06-05T17:56:45.437952Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"} {"level":"warn","ts":"2026-06-05T17:56:45.446559Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-05T17:56:45.450389Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-05T17:56:45.452585Z","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-06-05T17:56:45.456115Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5caa70ef1dd6dc04","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-05T17:56:45.4563Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5caa70ef1dd6dc04","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-05T17:56:45.456523Z","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-06-05T17:56:45.456668Z","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-06-05T17:56:45.456684Z","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-06-05T17:56:45.458578Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"} {"level":"info","ts":"2026-06-05T17:56:45.459067Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","added-peer-id":"5caa70ef1dd6dc04","added-peer-peer-urls":["https://199.204.45.116:2380"]} {"level":"info","ts":"2026-06-05T17:56:45.460955Z","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-06-05T17:56:45.461055Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.116:2380"} {"level":"info","ts":"2026-06-05T17:56:45.461111Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.116:2380"} {"level":"info","ts":"2026-06-05T17:56:45.461202Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5caa70ef1dd6dc04","initial-advertise-peer-urls":["https://199.204.45.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-05T17:56:45.461248Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-05T17:56:46.340273Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 is starting a new election at term 1"} {"level":"info","ts":"2026-06-05T17:56:46.340342Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-05T17:56:46.340365Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgPreVoteResp from 5caa70ef1dd6dc04 at term 1"} {"level":"info","ts":"2026-06-05T17:56:46.340384Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became candidate at term 2"} {"level":"info","ts":"2026-06-05T17:56:46.340395Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgVoteResp from 5caa70ef1dd6dc04 at term 2"} {"level":"info","ts":"2026-06-05T17:56:46.340443Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became leader at term 2"} {"level":"info","ts":"2026-06-05T17:56:46.340461Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5caa70ef1dd6dc04 elected leader 5caa70ef1dd6dc04 at term 2"} {"level":"info","ts":"2026-06-05T17:56:46.418759Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T17:56:46.460209Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-05T17:56:46.460238Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-05T17:56:46.460207Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5caa70ef1dd6dc04","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.116:2379]}","request-path":"/0/members/5caa70ef1dd6dc04/attributes","cluster-id":"45afccab143d2c82","publish-timeout":"7s"} {"level":"info","ts":"2026-06-05T17:56:46.460609Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-05T17:56:46.46063Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-05T17:56:46.463423Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.116:2379"} {"level":"info","ts":"2026-06-05T17:56:46.464407Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-05T17:56:46.494538Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T17:56:46.494637Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T17:56:46.494664Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T17:56:47.963603Z","caller":"traceutil/trace.go:171","msg":"trace[1198791491] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"146.855266ms","start":"2026-06-05T17:56:47.816717Z","end":"2026-06-05T17:56:47.963573Z","steps":["trace[1198791491] 'process raft request' (duration: 146.724301ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:56:47.963618Z","caller":"traceutil/trace.go:171","msg":"trace[601602984] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"155.658122ms","start":"2026-06-05T17:56:47.807888Z","end":"2026-06-05T17:56:47.963546Z","steps":["trace[601602984] 'process raft request' (duration: 155.356513ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:56:47.963905Z","caller":"traceutil/trace.go:171","msg":"trace[1116955140] linearizableReadLoop","detail":"{readStateIndex:7; appliedIndex:5; }","duration":"154.157705ms","start":"2026-06-05T17:56:47.809721Z","end":"2026-06-05T17:56:47.963879Z","steps":["trace[1116955140] 'read index received' (duration: 30.371133ms)","trace[1116955140] 'applied index is now lower than readState.Index' (duration: 123.784192ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T17:56:47.963938Z","caller":"traceutil/trace.go:171","msg":"trace[403121040] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"147.014152ms","start":"2026-06-05T17:56:47.816874Z","end":"2026-06-05T17:56:47.963888Z","steps":["trace[403121040] 'process raft request' (duration: 146.642229ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:56:47.964101Z","caller":"traceutil/trace.go:171","msg":"trace[1123554609] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"147.220047ms","start":"2026-06-05T17:56:47.816858Z","end":"2026-06-05T17:56:47.964078Z","steps":["trace[1123554609] 'process raft request' (duration: 146.622548ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:56:47.96412Z","caller":"traceutil/trace.go:171","msg":"trace[481573298] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"146.96977ms","start":"2026-06-05T17:56:47.817092Z","end":"2026-06-05T17:56:47.964061Z","steps":["trace[481573298] 'process raft request' (duration: 146.507736ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:56:47.964254Z","caller":"traceutil/trace.go:171","msg":"trace[116160339] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"147.072833ms","start":"2026-06-05T17:56:47.817169Z","end":"2026-06-05T17:56:47.964242Z","steps":["trace[116160339] 'process raft request' (duration: 146.470365ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:56:47.964396Z","caller":"traceutil/trace.go:171","msg":"trace[341060617] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"147.190417ms","start":"2026-06-05T17:56:47.817194Z","end":"2026-06-05T17:56:47.964384Z","steps":["trace[341060617] 'process raft request' (duration: 146.479195ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:56:47.964199Z","caller":"traceutil/trace.go:171","msg":"trace[1893792337] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"134.123827ms","start":"2026-06-05T17:56:47.830036Z","end":"2026-06-05T17:56:47.96416Z","steps":["trace[1893792337] 'process raft request' (duration: 133.672503ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:56:47.964596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.984631ms","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-06-05T17:56:47.96476Z","caller":"traceutil/trace.go:171","msg":"trace[1619662402] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"147.184276ms","start":"2026-06-05T17:56:47.81756Z","end":"2026-06-05T17:56:47.964744Z","steps":["trace[1619662402] 'agreement among raft nodes before linearized reading' (duration: 146.933669ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:56:47.964761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.037133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-b2shz\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-06-05T17:56:47.964871Z","caller":"traceutil/trace.go:171","msg":"trace[197554348] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-b2shz; range_end:; response_count:1; response_revision:11; }","duration":"155.155997ms","start":"2026-06-05T17:56:47.809672Z","end":"2026-06-05T17:56:47.964828Z","steps":["trace[197554348] 'agreement among raft nodes before linearized reading' (duration: 154.549618ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:56:47.964812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.803642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-05T17:56:47.964888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.075886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.116\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-05T17:56:47.965074Z","caller":"traceutil/trace.go:171","msg":"trace[319069926] range","detail":"{range_begin:/registry/masterleases/199.204.45.116; range_end:; response_count:0; response_revision:11; }","duration":"149.275513ms","start":"2026-06-05T17:56:47.815775Z","end":"2026-06-05T17:56:47.96505Z","steps":["trace[319069926] 'agreement among raft nodes before linearized reading' (duration: 148.461016ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:56:47.964977Z","caller":"traceutil/trace.go:171","msg":"trace[1589046807] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"144.979848ms","start":"2026-06-05T17:56:47.819978Z","end":"2026-06-05T17:56:47.964957Z","steps":["trace[1589046807] 'agreement among raft nodes before linearized reading' (duration: 144.328328ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:56:47.965127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.778977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-05T17:56:47.96542Z","caller":"traceutil/trace.go:171","msg":"trace[1298113650] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"149.106737ms","start":"2026-06-05T17:56:47.816292Z","end":"2026-06-05T17:56:47.965398Z","steps":["trace[1298113650] 'agreement among raft nodes before linearized reading' (duration: 148.784167ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:56:48.09004Z","caller":"traceutil/trace.go:171","msg":"trace[343098610] transaction","detail":"{read_only:false; number_of_response:0; response_revision:12; }","duration":"119.520518ms","start":"2026-06-05T17:56:47.970495Z","end":"2026-06-05T17:56:48.090016Z","steps":["trace[343098610] 'process raft request' (duration: 112.660824ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:56:48.090334Z","caller":"traceutil/trace.go:171","msg":"trace[1019468115] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"119.305302ms","start":"2026-06-05T17:56:47.970988Z","end":"2026-06-05T17:56:48.090293Z","steps":["trace[1019468115] 'process raft request' (duration: 119.085325ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:56:48.090593Z","caller":"traceutil/trace.go:171","msg":"trace[1424767887] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"119.843048ms","start":"2026-06-05T17:56:47.970736Z","end":"2026-06-05T17:56:48.09058Z","steps":["trace[1424767887] 'process raft request' (duration: 119.27946ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:56:48.090913Z","caller":"traceutil/trace.go:171","msg":"trace[1297926559] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"120.237899ms","start":"2026-06-05T17:56:47.970664Z","end":"2026-06-05T17:56:48.090902Z","steps":["trace[1297926559] 'process raft request' (duration: 119.264989ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:56:48.09112Z","caller":"traceutil/trace.go:171","msg":"trace[2062143963] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"120.306402ms","start":"2026-06-05T17:56:47.970795Z","end":"2026-06-05T17:56:48.091101Z","steps":["trace[2062143963] 'process raft request' (duration: 119.247939ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:56:48.091757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.938542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-05T17:56:48.091809Z","caller":"traceutil/trace.go:171","msg":"trace[1814096118] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20; }","duration":"121.047416ms","start":"2026-06-05T17:56:47.970749Z","end":"2026-06-05T17:56:48.091796Z","steps":["trace[1814096118] 'agreement among raft nodes before linearized reading' (duration: 120.943283ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:56:48.092105Z","caller":"traceutil/trace.go:171","msg":"trace[937185042] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"120.078435ms","start":"2026-06-05T17:56:47.972017Z","end":"2026-06-05T17:56:48.092095Z","steps":["trace[937185042] 'process raft request' (duration: 118.123454ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:56:48.092228Z","caller":"traceutil/trace.go:171","msg":"trace[1916812622] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"120.298542ms","start":"2026-06-05T17:56:47.971922Z","end":"2026-06-05T17:56:48.09222Z","steps":["trace[1916812622] 'process raft request' (duration: 118.187257ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:56:48.090513Z","caller":"traceutil/trace.go:171","msg":"trace[320772514] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"113.972224ms","start":"2026-06-05T17:56:47.976526Z","end":"2026-06-05T17:56:48.090499Z","steps":["trace[320772514] 'process raft request' (duration: 113.638403ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:56:49.032969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.346938ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-06-05T17:56:49.033159Z","caller":"traceutil/trace.go:171","msg":"trace[1758611130] linearizableReadLoop","detail":"{readStateIndex:124; appliedIndex:123; }","duration":"137.945016ms","start":"2026-06-05T17:56:48.895193Z","end":"2026-06-05T17:56:49.033138Z","steps":["trace[1758611130] 'read index received' (duration: 34.606658ms)","trace[1758611130] 'applied index is now lower than readState.Index' (duration: 103.336778ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T17:56:49.033158Z","caller":"traceutil/trace.go:171","msg":"trace[1731994827] transaction","detail":"{read_only:false; response_revision:119; number_of_response:1; }","duration":"173.020518ms","start":"2026-06-05T17:56:48.860116Z","end":"2026-06-05T17:56:49.033136Z","steps":["trace[1731994827] 'process raft request' (duration: 69.755842ms)","trace[1731994827] 'compare' (duration: 102.236735ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T17:56:49.033269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.071869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-05T17:56:49.033564Z","caller":"traceutil/trace.go:171","msg":"trace[849687923] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:119; }","duration":"138.411031ms","start":"2026-06-05T17:56:48.895135Z","end":"2026-06-05T17:56:49.033546Z","steps":["trace[849687923] 'agreement among raft nodes before linearized reading' (duration: 138.06835ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:56:53.556049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.122539ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-05T17:56:53.556174Z","caller":"traceutil/trace.go:171","msg":"trace[1536301002] transaction","detail":"{read_only:false; response_revision:332; number_of_response:1; }","duration":"132.467937ms","start":"2026-06-05T17:56:53.423682Z","end":"2026-06-05T17:56:53.55615Z","steps":["trace[1536301002] 'process raft request' (duration: 29.165653ms)","trace[1536301002] 'compare' (duration: 102.975754ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T17:56:53.757407Z","caller":"traceutil/trace.go:171","msg":"trace[675801044] transaction","detail":"{read_only:false; response_revision:333; number_of_response:1; }","duration":"184.553056ms","start":"2026-06-05T17:56:53.572822Z","end":"2026-06-05T17:56:53.757375Z","steps":["trace[675801044] 'process raft request' (duration: 105.993564ms)","trace[675801044] 'compare' (duration: 78.442579ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T17:56:53.969454Z","caller":"traceutil/trace.go:171","msg":"trace[412492911] transaction","detail":"{read_only:false; response_revision:334; number_of_response:1; }","duration":"203.346169ms","start":"2026-06-05T17:56:53.766079Z","end":"2026-06-05T17:56:53.969426Z","steps":["trace[412492911] 'process raft request' (duration: 156.899349ms)","trace[412492911] 'compare' (duration: 46.237604ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T17:56:54.183588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.97254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-06-05T17:56:54.183705Z","caller":"traceutil/trace.go:171","msg":"trace[625005077] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:334; }","duration":"109.114844ms","start":"2026-06-05T17:56:54.074553Z","end":"2026-06-05T17:56:54.183668Z","steps":["trace[625005077] 'range keys from in-memory index tree' (duration: 108.861817ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:56:54.383273Z","caller":"traceutil/trace.go:171","msg":"trace[310263914] transaction","detail":"{read_only:false; response_revision:339; number_of_response:1; }","duration":"103.529457ms","start":"2026-06-05T17:56:54.279704Z","end":"2026-06-05T17:56:54.383233Z","steps":["trace[310263914] 'process raft request' (duration: 19.978054ms)","trace[310263914] 'compare' (duration: 83.351967ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T17:56:55.5606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.499562ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-05T17:56:55.560866Z","caller":"traceutil/trace.go:171","msg":"trace[1947006444] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"325.936544ms","start":"2026-06-05T17:56:55.234874Z","end":"2026-06-05T17:56:55.560811Z","steps":["trace[1947006444] 'process raft request' (duration: 78.136274ms)","trace[1947006444] 'compare' (duration: 247.286015ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T17:56:55.561005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:56:55.234848Z","time spent":"326.11203ms","remote":"127.0.0.1:42784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":649,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T17:56:55.815854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.268802ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T17:56:55.816124Z","caller":"traceutil/trace.go:171","msg":"trace[734374002] linearizableReadLoop","detail":"{readStateIndex:375; appliedIndex:372; }","duration":"542.275548ms","start":"2026-06-05T17:56:55.273831Z","end":"2026-06-05T17:56:55.816107Z","steps":["trace[734374002] 'read index received' (duration: 39.198777ms)","trace[734374002] 'applied index is now lower than readState.Index' (duration: 503.075121ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T17:56:55.816221Z","caller":"traceutil/trace.go:171","msg":"trace[1992095696] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"579.535266ms","start":"2026-06-05T17:56:55.236655Z","end":"2026-06-05T17:56:55.81619Z","steps":["trace[1992095696] 'process raft request' (duration: 579.30779ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:56:55.816151Z","caller":"traceutil/trace.go:171","msg":"trace[1882573451] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"580.720072ms","start":"2026-06-05T17:56:55.235391Z","end":"2026-06-05T17:56:55.816111Z","steps":["trace[1882573451] 'process raft request' (duration: 447.944085ms)","trace[1882573451] 'compare' (duration: 132.129108ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T17:56:55.816395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.031575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-06-05T17:56:55.816423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:56:55.236647Z","time spent":"579.671061ms","remote":"127.0.0.1:42908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4306,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T17:56:55.816408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.431172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-06-05T17:56:55.816466Z","caller":"traceutil/trace.go:171","msg":"trace[434432698] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:362; }","duration":"492.1824ms","start":"2026-06-05T17:56:55.324268Z","end":"2026-06-05T17:56:55.816451Z","steps":["trace[434432698] 'agreement among raft nodes before linearized reading' (duration: 492.027335ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:56:55.816503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:56:55.324233Z","time spent":"492.260802ms","remote":"127.0.0.1:42920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":229,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"info","ts":"2026-06-05T17:56:55.81652Z","caller":"traceutil/trace.go:171","msg":"trace[2061574979] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:362; }","duration":"442.638638ms","start":"2026-06-05T17:56:55.373834Z","end":"2026-06-05T17:56:55.816472Z","steps":["trace[2061574979] 'agreement among raft nodes before linearized reading' (duration: 442.498984ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:56:55.816628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:56:55.235384Z","time spent":"581.037491ms","remote":"127.0.0.1:42914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4781,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T17:56:55.816679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:56:55.373807Z","time spent":"442.797913ms","remote":"127.0.0.1:42920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":229,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" "} {"level":"warn","ts":"2026-06-05T17:56:55.818473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.188634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-06-05T17:56:55.818556Z","caller":"traceutil/trace.go:171","msg":"trace[1681071452] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:362; }","duration":"544.799401ms","start":"2026-06-05T17:56:55.273738Z","end":"2026-06-05T17:56:55.818538Z","steps":["trace[1681071452] 'agreement among raft nodes before linearized reading' (duration: 542.497444ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:56:55.81895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:56:55.273704Z","time spent":"545.224354ms","remote":"127.0.0.1:42920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":215,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" "} {"level":"warn","ts":"2026-06-05T17:56:56.174431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.186621ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-05T17:56:56.17462Z","caller":"traceutil/trace.go:171","msg":"trace[356847747] linearizableReadLoop","detail":"{readStateIndex:382; appliedIndex:380; }","duration":"270.651028ms","start":"2026-06-05T17:56:55.903953Z","end":"2026-06-05T17:56:56.174604Z","steps":["trace[356847747] 'read index received' (duration: 138.261381ms)","trace[356847747] 'applied index is now lower than readState.Index' (duration: 132.388637ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T17:56:56.174701Z","caller":"traceutil/trace.go:171","msg":"trace[211286080] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"277.107908ms","start":"2026-06-05T17:56:55.89757Z","end":"2026-06-05T17:56:56.174678Z","steps":["trace[211286080] 'process raft request' (duration: 276.965654ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:56:56.17469Z","caller":"traceutil/trace.go:171","msg":"trace[1096073740] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"278.191569ms","start":"2026-06-05T17:56:55.896419Z","end":"2026-06-05T17:56:56.17461Z","steps":["trace[1096073740] 'process raft request' (duration: 145.765191ms)","trace[1096073740] 'compare' (duration: 132.046096ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T17:56:56.174827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.845083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-06-05T17:56:56.174919Z","caller":"traceutil/trace.go:171","msg":"trace[21026178] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:369; }","duration":"270.973406ms","start":"2026-06-05T17:56:55.903928Z","end":"2026-06-05T17:56:56.174902Z","steps":["trace[21026178] 'agreement among raft nodes before linearized reading' (duration: 270.7602ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:56:56.327888Z","caller":"traceutil/trace.go:171","msg":"trace[230924786] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"423.443321ms","start":"2026-06-05T17:56:55.90443Z","end":"2026-06-05T17:56:56.327873Z","steps":["trace[230924786] 'process raft request' (duration: 423.360989ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:56:56.328018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:56:55.904423Z","time spent":"423.530364ms","remote":"127.0.0.1:42784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":669,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T17:56:56.327886Z","caller":"traceutil/trace.go:171","msg":"trace[370397433] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"423.650677ms","start":"2026-06-05T17:56:55.904195Z","end":"2026-06-05T17:56:56.327846Z","steps":["trace[370397433] 'process raft request' (duration: 411.507991ms)","trace[370397433] 'compare' (duration: 11.943531ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T17:56:56.328204Z","caller":"traceutil/trace.go:171","msg":"trace[307035740] linearizableReadLoop","detail":"{readStateIndex:386; appliedIndex:382; }","duration":"146.194481ms","start":"2026-06-05T17:56:56.181999Z","end":"2026-06-05T17:56:56.328194Z","steps":["trace[307035740] 'read index received' (duration: 133.749037ms)","trace[307035740] 'applied index is now lower than readState.Index' (duration: 12.444874ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T17:56:56.328233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:56:55.904186Z","time spent":"424.010787ms","remote":"127.0.0.1:42914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3424,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T17:56:56.328443Z","caller":"traceutil/trace.go:171","msg":"trace[1160523556] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"423.195484ms","start":"2026-06-05T17:56:55.905238Z","end":"2026-06-05T17:56:56.328433Z","steps":["trace[1160523556] 'process raft request' (duration: 422.607897ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:56:56.328517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:56:55.905231Z","time spent":"423.242266ms","remote":"127.0.0.1:59446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2886,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T17:56:56.328558Z","caller":"traceutil/trace.go:171","msg":"trace[145315163] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"147.444358ms","start":"2026-06-05T17:56:56.181104Z","end":"2026-06-05T17:56:56.328549Z","steps":["trace[145315163] 'process raft request' (duration: 147.050196ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:56:56.328665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.659555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:3706"} {"level":"info","ts":"2026-06-05T17:56:56.328714Z","caller":"traceutil/trace.go:171","msg":"trace[1267313988] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:373; }","duration":"146.735757ms","start":"2026-06-05T17:56:56.181969Z","end":"2026-06-05T17:56:56.328705Z","steps":["trace[1267313988] 'agreement among raft nodes before linearized reading' (duration: 146.663535ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:56:56.530808Z","caller":"traceutil/trace.go:171","msg":"trace[787397382] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"188.104299ms","start":"2026-06-05T17:56:56.342674Z","end":"2026-06-05T17:56:56.530778Z","steps":["trace[787397382] 'process raft request' (duration: 185.388279ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:56:56.554103Z","caller":"traceutil/trace.go:171","msg":"trace[2118641195] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"168.819443ms","start":"2026-06-05T17:56:56.385252Z","end":"2026-06-05T17:56:56.554072Z","steps":["trace[2118641195] 'process raft request' (duration: 168.71046ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:56:56.554222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.143535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4017"} {"level":"info","ts":"2026-06-05T17:56:56.554271Z","caller":"traceutil/trace.go:171","msg":"trace[1927944779] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:386; }","duration":"167.231107ms","start":"2026-06-05T17:56:56.38703Z","end":"2026-06-05T17:56:56.554261Z","steps":["trace[1927944779] 'agreement among raft nodes before linearized reading' (duration: 167.126084ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:56:56.55412Z","caller":"traceutil/trace.go:171","msg":"trace[1999473698] linearizableReadLoop","detail":"{readStateIndex:398; appliedIndex:394; }","duration":"167.032331ms","start":"2026-06-05T17:56:56.38707Z","end":"2026-06-05T17:56:56.554103Z","steps":["trace[1999473698] 'read index received' (duration: 141.004549ms)","trace[1999473698] 'applied index is now lower than readState.Index' (duration: 26.026872ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T17:56:56.554561Z","caller":"traceutil/trace.go:171","msg":"trace[611351695] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"164.919179ms","start":"2026-06-05T17:56:56.389621Z","end":"2026-06-05T17:56:56.55454Z","steps":["trace[611351695] 'process raft request' (duration: 164.431155ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:56:56.554589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.523975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-06-05T17:56:56.554635Z","caller":"traceutil/trace.go:171","msg":"trace[1496471971] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:386; }","duration":"112.600308ms","start":"2026-06-05T17:56:56.442021Z","end":"2026-06-05T17:56:56.554621Z","steps":["trace[1496471971] 'agreement among raft nodes before linearized reading' (duration: 112.511845ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:56:56.554989Z","caller":"traceutil/trace.go:171","msg":"trace[197379920] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"170.40116ms","start":"2026-06-05T17:56:56.384099Z","end":"2026-06-05T17:56:56.5545Z","steps":["trace[197379920] 'process raft request' (duration: 169.769762ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:56:56.555085Z","caller":"traceutil/trace.go:171","msg":"trace[1673736803] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"169.149633ms","start":"2026-06-05T17:56:56.385911Z","end":"2026-06-05T17:56:56.55506Z","steps":["trace[1673736803] 'process raft request' (duration: 168.090942ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:56:58.411055Z","caller":"traceutil/trace.go:171","msg":"trace[806365077] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"158.881716ms","start":"2026-06-05T17:56:58.252137Z","end":"2026-06-05T17:56:58.411019Z","steps":["trace[806365077] 'process raft request' (duration: 144.311936ms)","trace[806365077] 'compare' (duration: 14.275202ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T17:57:00.533621Z","caller":"traceutil/trace.go:171","msg":"trace[388888434] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"102.205737ms","start":"2026-06-05T17:57:00.43139Z","end":"2026-06-05T17:57:00.533596Z","steps":["trace[388888434] 'process raft request' (duration: 102.013222ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:57:04.7949Z","caller":"traceutil/trace.go:171","msg":"trace[1985646172] linearizableReadLoop","detail":"{readStateIndex:435; appliedIndex:434; }","duration":"242.781166ms","start":"2026-06-05T17:57:04.5521Z","end":"2026-06-05T17:57:04.794881Z","steps":["trace[1985646172] 'read index received' (duration: 242.605981ms)","trace[1985646172] 'applied index is now lower than readState.Index' (duration: 174.195µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T17:57:04.795021Z","caller":"traceutil/trace.go:171","msg":"trace[1372886317] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"247.31248ms","start":"2026-06-05T17:57:04.547658Z","end":"2026-06-05T17:57:04.79497Z","steps":["trace[1372886317] 'process raft request' (duration: 247.105814ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:04.795076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.96553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-05T17:57:04.795104Z","caller":"traceutil/trace.go:171","msg":"trace[768378454] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:420; }","duration":"243.033812ms","start":"2026-06-05T17:57:04.552062Z","end":"2026-06-05T17:57:04.795095Z","steps":["trace[768378454] 'agreement among raft nodes before linearized reading' (duration: 242.96123ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:04.795127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.993341ms","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-06-05T17:57:04.795494Z","caller":"traceutil/trace.go:171","msg":"trace[1942377892] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:420; }","duration":"243.267569ms","start":"2026-06-05T17:57:04.552085Z","end":"2026-06-05T17:57:04.795353Z","steps":["trace[1942377892] 'agreement among raft nodes before linearized reading' (duration: 243.013611ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:57:04.901888Z","caller":"traceutil/trace.go:171","msg":"trace[645709433] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"102.507136ms","start":"2026-06-05T17:57:04.799353Z","end":"2026-06-05T17:57:04.90186Z","steps":["trace[645709433] 'process raft request' (duration: 96.104869ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:57:04.902155Z","caller":"traceutil/trace.go:171","msg":"trace[1187447998] transaction","detail":"{read_only:false; response_revision:422; number_of_response:1; }","duration":"102.566347ms","start":"2026-06-05T17:57:04.799564Z","end":"2026-06-05T17:57:04.90213Z","steps":["trace[1187447998] 'process raft request' (duration: 102.212788ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:57:04.90235Z","caller":"traceutil/trace.go:171","msg":"trace[1975194350] transaction","detail":"{read_only:false; response_revision:423; number_of_response:1; }","duration":"102.528636ms","start":"2026-06-05T17:57:04.79979Z","end":"2026-06-05T17:57:04.902319Z","steps":["trace[1975194350] 'process raft request' (duration: 102.248849ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:57:26.786665Z","caller":"traceutil/trace.go:171","msg":"trace[1381730873] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"227.036908ms","start":"2026-06-05T17:57:26.559607Z","end":"2026-06-05T17:57:26.786644Z","steps":["trace[1381730873] 'process raft request' (duration: 226.177907ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:57:26.794824Z","caller":"traceutil/trace.go:171","msg":"trace[1007261347] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"138.910691ms","start":"2026-06-05T17:57:26.655885Z","end":"2026-06-05T17:57:26.794795Z","steps":["trace[1007261347] 'process raft request' (duration: 137.968379ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:57:26.795203Z","caller":"traceutil/trace.go:171","msg":"trace[1554549486] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"128.000348ms","start":"2026-06-05T17:57:26.667009Z","end":"2026-06-05T17:57:26.79501Z","steps":["trace[1554549486] 'process raft request' (duration: 127.476236ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:57:27.466989Z","caller":"traceutil/trace.go:171","msg":"trace[843108867] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"352.55665ms","start":"2026-06-05T17:57:27.114414Z","end":"2026-06-05T17:57:27.466971Z","steps":["trace[843108867] 'process raft request' (duration: 346.418083ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:27.467106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:27.114391Z","time spent":"352.651262ms","remote":"127.0.0.1:42770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10362,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T17:57:27.479184Z","caller":"traceutil/trace.go:171","msg":"trace[156923785] linearizableReadLoop","detail":"{readStateIndex:661; appliedIndex:659; }","duration":"323.153925ms","start":"2026-06-05T17:57:27.156015Z","end":"2026-06-05T17:57:27.479169Z","steps":["trace[156923785] 'read index received' (duration: 304.822475ms)","trace[156923785] 'applied index is now lower than readState.Index' (duration: 18.33076ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T17:57:27.479243Z","caller":"traceutil/trace.go:171","msg":"trace[1483280941] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"352.720244ms","start":"2026-06-05T17:57:27.1265Z","end":"2026-06-05T17:57:27.479221Z","steps":["trace[1483280941] 'process raft request' (duration: 352.563441ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:57:27.479283Z","caller":"traceutil/trace.go:171","msg":"trace[979211787] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"212.619582ms","start":"2026-06-05T17:57:27.266647Z","end":"2026-06-05T17:57:27.479266Z","steps":["trace[979211787] 'process raft request' (duration: 212.50131ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:27.479382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.35083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:7708"} {"level":"warn","ts":"2026-06-05T17:57:27.479385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:27.126479Z","time spent":"352.833397ms","remote":"127.0.0.1:42770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4059,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T17:57:27.479411Z","caller":"traceutil/trace.go:171","msg":"trace[1667971901] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:637; }","duration":"323.424711ms","start":"2026-06-05T17:57:27.155978Z","end":"2026-06-05T17:57:27.479403Z","steps":["trace[1667971901] 'agreement among raft nodes before linearized reading' (duration: 323.251218ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:27.479462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:27.15596Z","time spent":"323.491293ms","remote":"127.0.0.1:42770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":1,"response size":7730,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" "} {"level":"warn","ts":"2026-06-05T17:57:31.374231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.712728ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T17:57:31.374418Z","caller":"traceutil/trace.go:171","msg":"trace[1964719980] linearizableReadLoop","detail":"{readStateIndex:700; appliedIndex:699; }","duration":"318.131211ms","start":"2026-06-05T17:57:31.056262Z","end":"2026-06-05T17:57:31.374394Z","steps":["trace[1964719980] 'read index received' (duration: 37.968451ms)","trace[1964719980] 'applied index is now lower than readState.Index' (duration: 280.16109ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T17:57:31.374607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.337906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-06-05T17:57:31.374578Z","caller":"traceutil/trace.go:171","msg":"trace[1430326771] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"391.421415ms","start":"2026-06-05T17:57:30.983082Z","end":"2026-06-05T17:57:31.374503Z","steps":["trace[1430326771] 'process raft request' (duration: 111.306787ms)","trace[1430326771] 'compare' (duration: 279.318689ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T17:57:31.37466Z","caller":"traceutil/trace.go:171","msg":"trace[877880289] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:674; }","duration":"318.424608ms","start":"2026-06-05T17:57:31.056222Z","end":"2026-06-05T17:57:31.374647Z","steps":["trace[877880289] 'agreement among raft nodes before linearized reading' (duration: 318.262914ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:31.374705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:31.056202Z","time spent":"318.492059ms","remote":"127.0.0.1:59240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-05T17:57:31.374852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:30.983065Z","time spent":"391.646499ms","remote":"127.0.0.1:42802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036197,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T17:57:31.457538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.490793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T17:57:31.457614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.442086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-05T17:57:31.457693Z","caller":"traceutil/trace.go:171","msg":"trace[1271319950] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:675; }","duration":"398.56267ms","start":"2026-06-05T17:57:31.059112Z","end":"2026-06-05T17:57:31.457675Z","steps":["trace[1271319950] 'agreement among raft nodes before linearized reading' (duration: 398.279513ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:31.457738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.561715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T17:57:31.45773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.700564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T17:57:31.457779Z","caller":"traceutil/trace.go:171","msg":"trace[2000749098] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:675; }","duration":"158.627465ms","start":"2026-06-05T17:57:31.299138Z","end":"2026-06-05T17:57:31.457766Z","steps":["trace[2000749098] 'agreement among raft nodes before linearized reading' (duration: 158.583694ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:57:31.457806Z","caller":"traceutil/trace.go:171","msg":"trace[1339891323] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:675; }","duration":"269.802837ms","start":"2026-06-05T17:57:31.18798Z","end":"2026-06-05T17:57:31.457783Z","steps":["trace[1339891323] 'agreement among raft nodes before linearized reading' (duration: 269.644642ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:57:31.457646Z","caller":"traceutil/trace.go:171","msg":"trace[939439942] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:675; }","duration":"187.675077ms","start":"2026-06-05T17:57:31.269941Z","end":"2026-06-05T17:57:31.457617Z","steps":["trace[939439942] 'agreement among raft nodes before linearized reading' (duration: 187.482033ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:31.4578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:31.059096Z","time spent":"398.692053ms","remote":"127.0.0.1:59240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-05T17:57:31.457997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.869994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T17:57:31.458026Z","caller":"traceutil/trace.go:171","msg":"trace[2029398703] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:675; }","duration":"159.913135ms","start":"2026-06-05T17:57:31.298106Z","end":"2026-06-05T17:57:31.458019Z","steps":["trace[2029398703] 'agreement among raft nodes before linearized reading' (duration: 159.869474ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:31.457994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.290516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T17:57:31.458149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.260852ms","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:5"} {"level":"warn","ts":"2026-06-05T17:57:31.458203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.369977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T17:57:31.458204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.963049ms","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-06-05T17:57:31.458213Z","caller":"traceutil/trace.go:171","msg":"trace[781981611] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:675; }","duration":"188.346943ms","start":"2026-06-05T17:57:31.269851Z","end":"2026-06-05T17:57:31.458198Z","steps":["trace[781981611] 'agreement among raft nodes before linearized reading' (duration: 188.259871ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:57:31.458226Z","caller":"traceutil/trace.go:171","msg":"trace[35245025] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:675; }","duration":"126.392957ms","start":"2026-06-05T17:57:31.331826Z","end":"2026-06-05T17:57:31.458219Z","steps":["trace[35245025] 'agreement among raft nodes before linearized reading' (duration: 126.363737ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:31.458223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.563769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T17:57:31.458248Z","caller":"traceutil/trace.go:171","msg":"trace[1575543993] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:675; }","duration":"399.040231ms","start":"2026-06-05T17:57:31.059197Z","end":"2026-06-05T17:57:31.458237Z","steps":["trace[1575543993] 'agreement among raft nodes before linearized reading' (duration: 398.927738ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:31.458242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.874916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T17:57:31.45828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:31.059177Z","time spent":"399.096163ms","remote":"127.0.0.1:59240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-05T17:57:31.458282Z","caller":"traceutil/trace.go:171","msg":"trace[1552826317] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:675; }","duration":"283.64051ms","start":"2026-06-05T17:57:31.174619Z","end":"2026-06-05T17:57:31.45826Z","steps":["trace[1552826317] 'agreement among raft nodes before linearized reading' (duration: 283.567519ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:57:31.458383Z","caller":"traceutil/trace.go:171","msg":"trace[1085890477] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"195.40273ms","start":"2026-06-05T17:57:31.26297Z","end":"2026-06-05T17:57:31.458373Z","steps":["trace[1085890477] 'process raft request' (duration: 194.184571ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:31.458391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.884468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T17:57:31.458438Z","caller":"traceutil/trace.go:171","msg":"trace[543646742] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:675; }","duration":"269.94742ms","start":"2026-06-05T17:57:31.188478Z","end":"2026-06-05T17:57:31.458425Z","steps":["trace[543646742] 'agreement among raft nodes before linearized reading' (duration: 269.877637ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:31.458478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.342949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T17:57:31.458502Z","caller":"traceutil/trace.go:171","msg":"trace[279642222] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:675; }","duration":"270.376151ms","start":"2026-06-05T17:57:31.18812Z","end":"2026-06-05T17:57:31.458496Z","steps":["trace[279642222] 'agreement among raft nodes before linearized reading' (duration: 270.33852ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:57:31.458343Z","caller":"traceutil/trace.go:171","msg":"trace[226333283] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:675; }","duration":"126.01588ms","start":"2026-06-05T17:57:31.332308Z","end":"2026-06-05T17:57:31.458324Z","steps":["trace[226333283] 'agreement among raft nodes before linearized reading' (duration: 125.804905ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:31.458151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.189717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T17:57:31.458601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.284091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T17:57:31.458632Z","caller":"traceutil/trace.go:171","msg":"trace[1457622097] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:675; }","duration":"285.706109ms","start":"2026-06-05T17:57:31.172907Z","end":"2026-06-05T17:57:31.458613Z","steps":["trace[1457622097] 'agreement among raft nodes before linearized reading' (duration: 285.165486ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:31.457682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.337501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T17:57:31.458659Z","caller":"traceutil/trace.go:171","msg":"trace[1327806624] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:675; }","duration":"188.358314ms","start":"2026-06-05T17:57:31.270287Z","end":"2026-06-05T17:57:31.458645Z","steps":["trace[1327806624] 'agreement among raft nodes before linearized reading' (duration: 188.265412ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:31.458167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.431246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T17:57:31.458691Z","caller":"traceutil/trace.go:171","msg":"trace[523343960] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:675; }","duration":"160.401737ms","start":"2026-06-05T17:57:31.298281Z","end":"2026-06-05T17:57:31.458683Z","steps":["trace[523343960] 'agreement among raft nodes before linearized reading' (duration: 159.330921ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:57:31.458704Z","caller":"traceutil/trace.go:171","msg":"trace[1373813709] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:675; }","duration":"284.00458ms","start":"2026-06-05T17:57:31.174691Z","end":"2026-06-05T17:57:31.458696Z","steps":["trace[1373813709] 'agreement among raft nodes before linearized reading' (duration: 283.457687ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:57:31.45876Z","caller":"traceutil/trace.go:171","msg":"trace[1801416102] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:675; }","duration":"126.740026ms","start":"2026-06-05T17:57:31.331655Z","end":"2026-06-05T17:57:31.458395Z","steps":["trace[1801416102] 'agreement among raft nodes before linearized reading' (duration: 125.899676ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:31.930724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.444131ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T17:57:31.930995Z","caller":"traceutil/trace.go:171","msg":"trace[823015835] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"552.25488ms","start":"2026-06-05T17:57:31.3787Z","end":"2026-06-05T17:57:31.930955Z","steps":["trace[823015835] 'process raft request' (duration: 321.47198ms)","trace[823015835] 'compare' (duration: 230.271377ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T17:57:31.93112Z","caller":"traceutil/trace.go:171","msg":"trace[1850920198] linearizableReadLoop","detail":"{readStateIndex:706; appliedIndex:701; }","duration":"262.2743ms","start":"2026-06-05T17:57:31.668825Z","end":"2026-06-05T17:57:31.9311Z","steps":["trace[1850920198] 'read index received' (duration: 31.50221ms)","trace[1850920198] 'applied index is now lower than readState.Index' (duration: 230.77096ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T17:57:31.931162Z","caller":"traceutil/trace.go:171","msg":"trace[219058333] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"502.06546ms","start":"2026-06-05T17:57:31.429069Z","end":"2026-06-05T17:57:31.931134Z","steps":["trace[219058333] 'process raft request' (duration: 501.787753ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:31.931897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:31.42905Z","time spent":"502.813618ms","remote":"127.0.0.1:59298","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1044,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T17:57:31.931276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.442474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T17:57:31.931981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:31.378672Z","time spent":"552.971406ms","remote":"127.0.0.1:59240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T17:57:31.932044Z","caller":"traceutil/trace.go:171","msg":"trace[1908222597] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:680; }","duration":"263.242502ms","start":"2026-06-05T17:57:31.66879Z","end":"2026-06-05T17:57:31.932033Z","steps":["trace[1908222597] 'agreement among raft nodes before linearized reading' (duration: 262.361311ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:31.93209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.135679ms","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:5"} {"level":"info","ts":"2026-06-05T17:57:31.932152Z","caller":"traceutil/trace.go:171","msg":"trace[535859057] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:680; }","duration":"263.222402ms","start":"2026-06-05T17:57:31.668915Z","end":"2026-06-05T17:57:31.932138Z","steps":["trace[535859057] 'agreement among raft nodes before linearized reading' (duration: 263.103729ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:57:31.931337Z","caller":"traceutil/trace.go:171","msg":"trace[494483945] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"456.703075ms","start":"2026-06-05T17:57:31.474622Z","end":"2026-06-05T17:57:31.931325Z","steps":["trace[494483945] 'process raft request' (duration: 456.300705ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:31.932252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:31.474603Z","time spent":"457.619726ms","remote":"127.0.0.1:59240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T17:57:31.931368Z","caller":"traceutil/trace.go:171","msg":"trace[1230755674] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"456.728636ms","start":"2026-06-05T17:57:31.474632Z","end":"2026-06-05T17:57:31.931361Z","steps":["trace[1230755674] 'process raft request' (duration: 456.339357ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:31.932439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:31.474614Z","time spent":"457.797571ms","remote":"127.0.0.1:59240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T17:57:31.931405Z","caller":"traceutil/trace.go:171","msg":"trace[1235213625] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"267.02674ms","start":"2026-06-05T17:57:31.664365Z","end":"2026-06-05T17:57:31.931392Z","steps":["trace[1235213625] 'process raft request' (duration: 266.646122ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:31.932716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.16381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T17:57:31.932756Z","caller":"traceutil/trace.go:171","msg":"trace[1440221801] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:680; }","duration":"263.233581ms","start":"2026-06-05T17:57:31.669512Z","end":"2026-06-05T17:57:31.932746Z","steps":["trace[1440221801] 'agreement among raft nodes before linearized reading' (duration: 263.17383ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:31.932388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.983529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T17:57:31.932912Z","caller":"traceutil/trace.go:171","msg":"trace[235459691] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:680; }","duration":"149.50911ms","start":"2026-06-05T17:57:31.783383Z","end":"2026-06-05T17:57:31.932892Z","steps":["trace[235459691] 'agreement among raft nodes before linearized reading' (duration: 148.967399ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:57:32.295491Z","caller":"traceutil/trace.go:171","msg":"trace[1187757710] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"114.69891ms","start":"2026-06-05T17:57:32.180768Z","end":"2026-06-05T17:57:32.295467Z","steps":["trace[1187757710] 'process raft request' (duration: 114.544286ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:35.191034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.759168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T17:57:35.191175Z","caller":"traceutil/trace.go:171","msg":"trace[455993191] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:702; }","duration":"405.939673ms","start":"2026-06-05T17:57:34.785217Z","end":"2026-06-05T17:57:35.191157Z","steps":["trace[455993191] 'range keys from in-memory index tree' (duration: 405.689287ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:35.191219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:34.785201Z","time spent":"406.007295ms","remote":"127.0.0.1:42730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-05T17:57:35.191452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.602877ms","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-06-05T17:57:35.191536Z","caller":"traceutil/trace.go:171","msg":"trace[86293669] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:702; }","duration":"210.73571ms","start":"2026-06-05T17:57:34.980782Z","end":"2026-06-05T17:57:35.191517Z","steps":["trace[86293669] 'range keys from in-memory index tree' (duration: 210.441624ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:57:35.711475Z","caller":"traceutil/trace.go:171","msg":"trace[1513136060] linearizableReadLoop","detail":"{readStateIndex:730; appliedIndex:728; }","duration":"429.824157ms","start":"2026-06-05T17:57:35.281612Z","end":"2026-06-05T17:57:35.711437Z","steps":["trace[1513136060] 'read index received' (duration: 357.189396ms)","trace[1513136060] 'applied index is now lower than readState.Index' (duration: 72.633161ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T17:57:35.711573Z","caller":"traceutil/trace.go:171","msg":"trace[845642081] transaction","detail":"{read_only:false; response_revision:703; number_of_response:1; }","duration":"516.007799ms","start":"2026-06-05T17:57:35.195554Z","end":"2026-06-05T17:57:35.711562Z","steps":["trace[845642081] 'process raft request' (duration: 515.66602ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:35.711688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:35.195529Z","time spent":"516.070731ms","remote":"127.0.0.1:59240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T17:57:35.730025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.433815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-vc6rc\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-05T17:57:35.730109Z","caller":"traceutil/trace.go:171","msg":"trace[836388613] range","detail":"{range_begin:/registry/pods/kube-system/cilium-vc6rc; range_end:; response_count:1; response_revision:703; }","duration":"448.562218ms","start":"2026-06-05T17:57:35.281523Z","end":"2026-06-05T17:57:35.730085Z","steps":["trace[836388613] 'agreement among raft nodes before linearized reading' (duration: 430.013512ms)","trace[836388613] 'range keys from in-memory index tree' (duration: 18.300871ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T17:57:35.730151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:35.281501Z","time spent":"448.638681ms","remote":"127.0.0.1:42914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-vc6rc\" "} {"level":"info","ts":"2026-06-05T17:57:35.869311Z","caller":"traceutil/trace.go:171","msg":"trace[1724754343] transaction","detail":"{read_only:false; response_revision:704; number_of_response:1; }","duration":"123.410728ms","start":"2026-06-05T17:57:35.745861Z","end":"2026-06-05T17:57:35.869272Z","steps":["trace[1724754343] 'process raft request' (duration: 122.946937ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:36.198228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.531477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-06-05T17:57:36.198259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.132291ms","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-06-05T17:57:36.198312Z","caller":"traceutil/trace.go:171","msg":"trace[40790894] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:704; }","duration":"252.648989ms","start":"2026-06-05T17:57:35.945645Z","end":"2026-06-05T17:57:36.198294Z","steps":["trace[40790894] 'range keys from in-memory index tree' (duration: 252.377754ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:57:36.19834Z","caller":"traceutil/trace.go:171","msg":"trace[927650479] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:704; }","duration":"253.238083ms","start":"2026-06-05T17:57:35.945079Z","end":"2026-06-05T17:57:36.198317Z","steps":["trace[927650479] 'range keys from in-memory index tree' (duration: 252.981028ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:36.198507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.966576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-05T17:57:36.198596Z","caller":"traceutil/trace.go:171","msg":"trace[1794405877] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:704; }","duration":"253.080898ms","start":"2026-06-05T17:57:35.945492Z","end":"2026-06-05T17:57:36.198573Z","steps":["trace[1794405877] 'range keys from in-memory index tree' (duration: 252.838893ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:38.398764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.801621ms","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-06-05T17:57:38.398806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.613658209s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T17:57:38.398832Z","caller":"traceutil/trace.go:171","msg":"trace[1712786668] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:708; }","duration":"1.61368486s","start":"2026-06-05T17:57:36.785139Z","end":"2026-06-05T17:57:38.398824Z","steps":["trace[1712786668] 'range keys from in-memory index tree' (duration: 1.613604408s)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:57:38.398831Z","caller":"traceutil/trace.go:171","msg":"trace[251714783] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:708; }","duration":"185.876812ms","start":"2026-06-05T17:57:38.212939Z","end":"2026-06-05T17:57:38.398816Z","steps":["trace[251714783] 'range keys from in-memory index tree' (duration: 185.658587ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:38.398851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:36.785095Z","time spent":"1.613751241s","remote":"127.0.0.1:42728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-05T17:57:38.398922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.598178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-05T17:57:38.399012Z","caller":"traceutil/trace.go:171","msg":"trace[1539961310] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:708; }","duration":"122.70114ms","start":"2026-06-05T17:57:38.276298Z","end":"2026-06-05T17:57:38.398999Z","steps":["trace[1539961310] 'range keys from in-memory index tree' (duration: 122.414205ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:38.399085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.743142ms","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-06-05T17:57:38.399127Z","caller":"traceutil/trace.go:171","msg":"trace[534706230] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:708; }","duration":"122.819704ms","start":"2026-06-05T17:57:38.276295Z","end":"2026-06-05T17:57:38.399115Z","steps":["trace[534706230] 'range keys from in-memory index tree' (duration: 122.617479ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:38.399228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"683.919171ms","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-06-05T17:57:38.399302Z","caller":"traceutil/trace.go:171","msg":"trace[1068928227] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:708; }","duration":"684.118555ms","start":"2026-06-05T17:57:37.715165Z","end":"2026-06-05T17:57:38.399284Z","steps":["trace[1068928227] 'range keys from in-memory index tree' (duration: 683.550702ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:38.400174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:37.715145Z","time spent":"685.014895ms","remote":"127.0.0.1:59240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-05T17:57:38.548057Z","caller":"traceutil/trace.go:171","msg":"trace[1289410383] transaction","detail":"{read_only:false; response_revision:712; number_of_response:1; }","duration":"143.429621ms","start":"2026-06-05T17:57:38.404608Z","end":"2026-06-05T17:57:38.548038Z","steps":["trace[1289410383] 'process raft request' (duration: 143.39003ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:57:38.548086Z","caller":"traceutil/trace.go:171","msg":"trace[588395130] transaction","detail":"{read_only:false; response_revision:710; number_of_response:1; }","duration":"144.179948ms","start":"2026-06-05T17:57:38.403879Z","end":"2026-06-05T17:57:38.548059Z","steps":["trace[588395130] 'process raft request' (duration: 143.982894ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:57:38.548132Z","caller":"traceutil/trace.go:171","msg":"trace[2030205802] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"143.792278ms","start":"2026-06-05T17:57:38.404292Z","end":"2026-06-05T17:57:38.548084Z","steps":["trace[2030205802] 'process raft request' (duration: 143.669706ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:57:38.548274Z","caller":"traceutil/trace.go:171","msg":"trace[1922746297] linearizableReadLoop","detail":"{readStateIndex:740; appliedIndex:735; }","duration":"138.52697ms","start":"2026-06-05T17:57:38.409727Z","end":"2026-06-05T17:57:38.548254Z","steps":["trace[1922746297] 'read index received' (duration: 76.016262ms)","trace[1922746297] 'applied index is now lower than readState.Index' (duration: 62.509178ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T17:57:38.548344Z","caller":"traceutil/trace.go:171","msg":"trace[1942091208] transaction","detail":"{read_only:false; response_revision:713; number_of_response:1; }","duration":"143.036433ms","start":"2026-06-05T17:57:38.405297Z","end":"2026-06-05T17:57:38.548334Z","steps":["trace[1942091208] 'process raft request' (duration: 142.720115ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:38.54843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.683253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T17:57:38.548728Z","caller":"traceutil/trace.go:171","msg":"trace[259307758] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:713; }","duration":"139.008531ms","start":"2026-06-05T17:57:38.4097Z","end":"2026-06-05T17:57:38.548709Z","steps":["trace[259307758] 'agreement among raft nodes before linearized reading' (duration: 138.664533ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:55.287974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.800554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T17:57:55.288019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.833888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T17:57:55.288025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.414581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T17:57:55.288069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"556.496199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T17:57:55.288081Z","caller":"traceutil/trace.go:171","msg":"trace[2120515648] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:824; }","duration":"556.543639ms","start":"2026-06-05T17:57:54.731533Z","end":"2026-06-05T17:57:55.288077Z","steps":["trace[2120515648] 'range keys from in-memory index tree' (duration: 556.394027ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:55.288084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.418036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T17:57:55.288089Z","caller":"traceutil/trace.go:171","msg":"trace[632172803] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:824; }","duration":"467.495212ms","start":"2026-06-05T17:57:54.820583Z","end":"2026-06-05T17:57:55.288078Z","steps":["trace[632172803] 'count revisions from in-memory index tree' (duration: 467.36659ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:57:55.288103Z","caller":"traceutil/trace.go:171","msg":"trace[1190263004] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:824; }","duration":"343.467587ms","start":"2026-06-05T17:57:54.94463Z","end":"2026-06-05T17:57:55.288097Z","steps":["trace[1190263004] 'count revisions from in-memory index tree' (duration: 343.358625ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:55.288106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:54.731512Z","time spent":"556.589062ms","remote":"127.0.0.1:59302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 "} {"level":"warn","ts":"2026-06-05T17:57:55.288115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:54.820574Z","time spent":"467.532114ms","remote":"127.0.0.1:59326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-05T17:57:55.288128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:54.94461Z","time spent":"343.511289ms","remote":"127.0.0.1:59338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-06-05T17:57:55.288196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"900.691718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-j6fsn\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-06-05T17:57:55.288276Z","caller":"traceutil/trace.go:171","msg":"trace[487414915] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-j6fsn; range_end:; response_count:1; response_revision:824; }","duration":"900.805231ms","start":"2026-06-05T17:57:54.387458Z","end":"2026-06-05T17:57:55.288264Z","steps":["trace[487414915] 'range keys from in-memory index tree' (duration: 900.3462ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:55.288337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:54.38744Z","time spent":"900.890452ms","remote":"127.0.0.1:42914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-j6fsn\" "} {"level":"warn","ts":"2026-06-05T17:57:55.288375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.248793288s","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-06-05T17:57:55.288403Z","caller":"traceutil/trace.go:171","msg":"trace[613330322] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:824; }","duration":"1.248859139s","start":"2026-06-05T17:57:54.039538Z","end":"2026-06-05T17:57:55.288397Z","steps":["trace[613330322] 'count revisions from in-memory index tree' (duration: 1.248711707s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:55.288428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:54.039514Z","time spent":"1.248907411s","remote":"127.0.0.1:42914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":12,"response size":29,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"warn","ts":"2026-06-05T17:57:55.287976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.360805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T17:57:55.288526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.288755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T17:57:55.288548Z","caller":"traceutil/trace.go:171","msg":"trace[68342434] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:824; }","duration":"510.357096ms","start":"2026-06-05T17:57:54.778185Z","end":"2026-06-05T17:57:55.288543Z","steps":["trace[68342434] 'range keys from in-memory index tree' (duration: 510.167763ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:55.288566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:54.778162Z","time spent":"510.396807ms","remote":"127.0.0.1:59316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"info","ts":"2026-06-05T17:57:55.288578Z","caller":"traceutil/trace.go:171","msg":"trace[1168128098] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:824; }","duration":"343.944107ms","start":"2026-06-05T17:57:54.944594Z","end":"2026-06-05T17:57:55.288538Z","steps":["trace[1168128098] 'range keys from in-memory index tree' (duration: 343.269752ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:55.288629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:54.944576Z","time spent":"344.043049ms","remote":"127.0.0.1:59338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-06-05T17:57:55.288696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"645.838793ms","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-06-05T17:57:55.288725Z","caller":"traceutil/trace.go:171","msg":"trace[909495539] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:824; }","duration":"645.895935ms","start":"2026-06-05T17:57:54.642823Z","end":"2026-06-05T17:57:55.288718Z","steps":["trace[909495539] 'range keys from in-memory index tree' (duration: 645.743991ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:55.288747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:54.642807Z","time spent":"645.934105ms","remote":"127.0.0.1:59240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-05T17:57:55.288796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.859177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-05T17:57:55.28884Z","caller":"traceutil/trace.go:171","msg":"trace[1358482038] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:824; }","duration":"639.93102ms","start":"2026-06-05T17:57:54.648883Z","end":"2026-06-05T17:57:55.288814Z","steps":["trace[1358482038] 'range keys from in-memory index tree' (duration: 639.711724ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:55.28886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:54.648858Z","time spent":"639.997221ms","remote":"127.0.0.1:59240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-05T17:57:55.288861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"786.575641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-05T17:57:55.288854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.017469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T17:57:55.288031Z","caller":"traceutil/trace.go:171","msg":"trace[730510977] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:824; }","duration":"509.903527ms","start":"2026-06-05T17:57:54.778116Z","end":"2026-06-05T17:57:55.288019Z","steps":["trace[730510977] 'count revisions from in-memory index tree' (duration: 509.752933ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:55.288926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"665.595451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-05T17:57:55.28893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"636.647971ms","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-06-05T17:57:55.288953Z","caller":"traceutil/trace.go:171","msg":"trace[542236722] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:824; }","duration":"665.658361ms","start":"2026-06-05T17:57:54.623289Z","end":"2026-06-05T17:57:55.288948Z","steps":["trace[542236722] 'range keys from in-memory index tree' (duration: 665.452827ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:57:55.288957Z","caller":"traceutil/trace.go:171","msg":"trace[1208000154] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:824; }","duration":"636.690811ms","start":"2026-06-05T17:57:54.65226Z","end":"2026-06-05T17:57:55.288951Z","steps":["trace[1208000154] 'range keys from in-memory index tree' (duration: 636.564889ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:55.288979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:54.623269Z","time spent":"665.703763ms","remote":"127.0.0.1:59240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-05T17:57:55.288961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:54.7781Z","time spent":"510.835847ms","remote":"127.0.0.1:59316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-05T17:57:55.289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:54.652248Z","time spent":"636.745222ms","remote":"127.0.0.1:59240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-05T17:57:55.288054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.113141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T17:57:55.289043Z","caller":"traceutil/trace.go:171","msg":"trace[529660701] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:824; }","duration":"558.140284ms","start":"2026-06-05T17:57:54.730897Z","end":"2026-06-05T17:57:55.289037Z","steps":["trace[529660701] 'count revisions from in-memory index tree' (duration: 557.03294ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:55.289067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:54.730877Z","time spent":"558.183444ms","remote":"127.0.0.1:59302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"info","ts":"2026-06-05T17:57:55.288054Z","caller":"traceutil/trace.go:171","msg":"trace[1607400512] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:824; }","duration":"466.894199ms","start":"2026-06-05T17:57:54.821142Z","end":"2026-06-05T17:57:55.288036Z","steps":["trace[1607400512] 'range keys from in-memory index tree' (duration: 466.771597ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:55.288336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.784819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T17:57:55.289133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:54.82112Z","time spent":"468.005955ms","remote":"127.0.0.1:59326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"info","ts":"2026-06-05T17:57:55.289143Z","caller":"traceutil/trace.go:171","msg":"trace[583984796] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:824; }","duration":"468.605876ms","start":"2026-06-05T17:57:54.820527Z","end":"2026-06-05T17:57:55.289133Z","steps":["trace[583984796] 'range keys from in-memory index tree' (duration: 467.752298ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:55.289175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:54.82052Z","time spent":"468.645496ms","remote":"127.0.0.1:59326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"info","ts":"2026-06-05T17:57:55.288881Z","caller":"traceutil/trace.go:171","msg":"trace[79826880] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:824; }","duration":"786.645783ms","start":"2026-06-05T17:57:54.502229Z","end":"2026-06-05T17:57:55.288875Z","steps":["trace[79826880] 'count revisions from in-memory index tree' (duration: 786.456219ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:55.289201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"641.781238ms","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-06-05T17:57:55.288911Z","caller":"traceutil/trace.go:171","msg":"trace[51763849] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:824; }","duration":"509.113461ms","start":"2026-06-05T17:57:54.779784Z","end":"2026-06-05T17:57:55.288897Z","steps":["trace[51763849] 'range keys from in-memory index tree' (duration: 508.967227ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:55.289245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:54.779773Z","time spent":"509.465868ms","remote":"127.0.0.1:59316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"info","ts":"2026-06-05T17:57:55.289256Z","caller":"traceutil/trace.go:171","msg":"trace[1239149488] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:824; }","duration":"641.83223ms","start":"2026-06-05T17:57:54.647395Z","end":"2026-06-05T17:57:55.289227Z","steps":["trace[1239149488] 'range keys from in-memory index tree' (duration: 641.605465ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:55.289288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:54.502208Z","time spent":"787.014231ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":29,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-06-05T17:57:55.289304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:54.647385Z","time spent":"641.891941ms","remote":"127.0.0.1:59240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-05T17:57:55.289543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.062681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T17:57:55.291078Z","caller":"traceutil/trace.go:171","msg":"trace[997965883] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:824; }","duration":"558.753177ms","start":"2026-06-05T17:57:54.730828Z","end":"2026-06-05T17:57:55.289582Z","steps":["trace[997965883] 'range keys from in-memory index tree' (duration: 556.99985ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:55.291143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:57:54.730813Z","time spent":"560.32098ms","remote":"127.0.0.1:59302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 "} {"level":"info","ts":"2026-06-05T17:57:55.321168Z","caller":"traceutil/trace.go:171","msg":"trace[621218239] linearizableReadLoop","detail":"{readStateIndex:857; appliedIndex:856; }","duration":"262.218608ms","start":"2026-06-05T17:57:55.058923Z","end":"2026-06-05T17:57:55.321141Z","steps":["trace[621218239] 'read index received' (duration: 248.239414ms)","trace[621218239] 'applied index is now lower than readState.Index' (duration: 13.977484ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T17:57:55.321286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.33423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T17:57:55.32134Z","caller":"traceutil/trace.go:171","msg":"trace[875504733] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:824; }","duration":"262.438481ms","start":"2026-06-05T17:57:55.058887Z","end":"2026-06-05T17:57:55.321326Z","steps":["trace[875504733] 'agreement among raft nodes before linearized reading' (duration: 262.322969ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:55.32498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.483935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T17:57:55.325006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.050338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T17:57:55.325026Z","caller":"traceutil/trace.go:171","msg":"trace[254509389] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:830; }","duration":"204.570827ms","start":"2026-06-05T17:57:55.120448Z","end":"2026-06-05T17:57:55.325018Z","steps":["trace[254509389] 'agreement among raft nodes before linearized reading' (duration: 204.496095ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:57:55.32504Z","caller":"traceutil/trace.go:171","msg":"trace[243639082] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:830; }","duration":"266.143ms","start":"2026-06-05T17:57:55.058886Z","end":"2026-06-05T17:57:55.325029Z","steps":["trace[243639082] 'agreement among raft nodes before linearized reading' (duration: 266.050808ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:55.325153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.354545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T17:57:55.325176Z","caller":"traceutil/trace.go:171","msg":"trace[1921144572] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:830; }","duration":"178.398046ms","start":"2026-06-05T17:57:55.146772Z","end":"2026-06-05T17:57:55.32517Z","steps":["trace[1921144572] 'agreement among raft nodes before linearized reading' (duration: 178.351405ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:55.325193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.421377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T17:57:55.325241Z","caller":"traceutil/trace.go:171","msg":"trace[1944026195] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:830; }","duration":"178.497619ms","start":"2026-06-05T17:57:55.146732Z","end":"2026-06-05T17:57:55.32523Z","steps":["trace[1944026195] 'agreement among raft nodes before linearized reading' (duration: 178.427806ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:55.325444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.961505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T17:57:55.325472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.604293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T17:57:55.325477Z","caller":"traceutil/trace.go:171","msg":"trace[387761684] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:830; }","duration":"205.019636ms","start":"2026-06-05T17:57:55.120448Z","end":"2026-06-05T17:57:55.325467Z","steps":["trace[387761684] 'agreement among raft nodes before linearized reading' (duration: 204.971655ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:57:55.325491Z","caller":"traceutil/trace.go:171","msg":"trace[855029605] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:830; }","duration":"240.651595ms","start":"2026-06-05T17:57:55.084834Z","end":"2026-06-05T17:57:55.325485Z","steps":["trace[855029605] 'agreement among raft nodes before linearized reading' (duration: 240.616234ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:55.325536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.046121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T17:57:55.325578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.616823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T17:57:55.325576Z","caller":"traceutil/trace.go:171","msg":"trace[1976075473] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:830; }","duration":"240.101432ms","start":"2026-06-05T17:57:55.085465Z","end":"2026-06-05T17:57:55.325567Z","steps":["trace[1976075473] 'agreement among raft nodes before linearized reading' (duration: 240.046481ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:57:55.325594Z","caller":"traceutil/trace.go:171","msg":"trace[450123779] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:830; }","duration":"240.671435ms","start":"2026-06-05T17:57:55.084917Z","end":"2026-06-05T17:57:55.325589Z","steps":["trace[450123779] 'agreement among raft nodes before linearized reading' (duration: 240.645014ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:55.325737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.289444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T17:57:55.325794Z","caller":"traceutil/trace.go:171","msg":"trace[1496451605] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:830; }","duration":"178.360095ms","start":"2026-06-05T17:57:55.147418Z","end":"2026-06-05T17:57:55.325778Z","steps":["trace[1496451605] 'agreement among raft nodes before linearized reading' (duration: 177.558059ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:57:55.327789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.448188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T17:57:55.327956Z","caller":"traceutil/trace.go:171","msg":"trace[1425867770] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:830; }","duration":"268.686342ms","start":"2026-06-05T17:57:55.05922Z","end":"2026-06-05T17:57:55.327906Z","steps":["trace[1425867770] 'agreement among raft nodes before linearized reading' (duration: 266.470906ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:58:09.518593Z","caller":"traceutil/trace.go:171","msg":"trace[749052230] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"128.824598ms","start":"2026-06-05T17:58:09.389736Z","end":"2026-06-05T17:58:09.518561Z","steps":["trace[749052230] 'process raft request' (duration: 115.35698ms)","trace[749052230] 'compare' (duration: 13.238223ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T17:58:09.51878Z","caller":"traceutil/trace.go:171","msg":"trace[2133943029] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"127.565722ms","start":"2026-06-05T17:58:09.391196Z","end":"2026-06-05T17:58:09.518762Z","steps":["trace[2133943029] 'process raft request' (duration: 127.298537ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:58:09.519089Z","caller":"traceutil/trace.go:171","msg":"trace[677586570] linearizableReadLoop","detail":"{readStateIndex:1027; appliedIndex:1024; }","duration":"124.089743ms","start":"2026-06-05T17:58:09.394982Z","end":"2026-06-05T17:58:09.519071Z","steps":["trace[677586570] 'read index received' (duration: 62.969015ms)","trace[677586570] 'applied index is now lower than readState.Index' (duration: 61.118918ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T17:58:09.519344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.338608ms","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-06-05T17:58:09.519411Z","caller":"traceutil/trace.go:171","msg":"trace[1265423392] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:994; }","duration":"124.44956ms","start":"2026-06-05T17:58:09.394944Z","end":"2026-06-05T17:58:09.519394Z","steps":["trace[1265423392] 'agreement among raft nodes before linearized reading' (duration: 124.206796ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:58:09.519653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.9122ms","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-06-05T17:58:09.519791Z","caller":"traceutil/trace.go:171","msg":"trace[1223801907] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:994; }","duration":"121.116004ms","start":"2026-06-05T17:58:09.398595Z","end":"2026-06-05T17:58:09.519711Z","steps":["trace[1223801907] 'agreement among raft nodes before linearized reading' (duration: 120.763176ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:58:09.889042Z","caller":"traceutil/trace.go:171","msg":"trace[937906246] linearizableReadLoop","detail":"{readStateIndex:1034; appliedIndex:1033; }","duration":"188.718651ms","start":"2026-06-05T17:58:09.700289Z","end":"2026-06-05T17:58:09.889008Z","steps":["trace[937906246] 'read index received' (duration: 187.912755ms)","trace[937906246] 'applied index is now lower than readState.Index' (duration: 804.726µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T17:58:09.889199Z","caller":"traceutil/trace.go:171","msg":"trace[207229512] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"193.015288ms","start":"2026-06-05T17:58:09.696169Z","end":"2026-06-05T17:58:09.889184Z","steps":["trace[207229512] 'process raft request' (duration: 192.069388ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:58:09.889425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.12509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.116\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-05T17:58:09.889486Z","caller":"traceutil/trace.go:171","msg":"trace[1336013798] range","detail":"{range_begin:/registry/masterleases/199.204.45.116; range_end:; response_count:1; response_revision:999; }","duration":"189.221792ms","start":"2026-06-05T17:58:09.700248Z","end":"2026-06-05T17:58:09.88947Z","steps":["trace[1336013798] 'agreement among raft nodes before linearized reading' (duration: 189.037198ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:58:09.889456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.826979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T17:58:09.889586Z","caller":"traceutil/trace.go:171","msg":"trace[898504781] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:999; }","duration":"105.041804ms","start":"2026-06-05T17:58:09.784531Z","end":"2026-06-05T17:58:09.889572Z","steps":["trace[898504781] 'agreement among raft nodes before linearized reading' (duration: 104.770299ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:58:10.115921Z","caller":"traceutil/trace.go:171","msg":"trace[1462209850] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"222.15026ms","start":"2026-06-05T17:58:09.893741Z","end":"2026-06-05T17:58:10.115891Z","steps":["trace[1462209850] 'process raft request' (duration: 168.665968ms)","trace[1462209850] 'compare' (duration: 53.259957ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T17:58:10.118694Z","caller":"traceutil/trace.go:171","msg":"trace[1893028841] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"205.034469ms","start":"2026-06-05T17:58:09.913641Z","end":"2026-06-05T17:58:10.118675Z","steps":["trace[1893028841] 'process raft request' (duration: 204.943317ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:58:21.640876Z","caller":"traceutil/trace.go:171","msg":"trace[1033785376] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"128.164989ms","start":"2026-06-05T17:58:21.512692Z","end":"2026-06-05T17:58:21.640857Z","steps":["trace[1033785376] 'process raft request' (duration: 128.041297ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:58:21.812999Z","caller":"traceutil/trace.go:171","msg":"trace[1194186840] transaction","detail":"{read_only:false; response_revision:1039; number_of_response:1; }","duration":"146.026652ms","start":"2026-06-05T17:58:21.666955Z","end":"2026-06-05T17:58:21.812982Z","steps":["trace[1194186840] 'process raft request' (duration: 118.513644ms)","trace[1194186840] 'compare' (duration: 27.382505ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T17:58:21.813181Z","caller":"traceutil/trace.go:171","msg":"trace[588851449] linearizableReadLoop","detail":"{readStateIndex:1078; appliedIndex:1075; }","duration":"137.296895ms","start":"2026-06-05T17:58:21.675862Z","end":"2026-06-05T17:58:21.813159Z","steps":["trace[588851449] 'read index received' (duration: 16.849734ms)","trace[588851449] 'applied index is now lower than readState.Index' (duration: 120.445601ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T17:58:21.813326Z","caller":"traceutil/trace.go:171","msg":"trace[751021986] transaction","detail":"{read_only:false; response_revision:1040; number_of_response:1; }","duration":"146.150515ms","start":"2026-06-05T17:58:21.667169Z","end":"2026-06-05T17:58:21.81332Z","steps":["trace[751021986] 'process raft request' (duration: 145.787657ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:58:21.813421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.55163ms","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-06-05T17:58:21.81345Z","caller":"traceutil/trace.go:171","msg":"trace[1265657285] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1040; }","duration":"137.648182ms","start":"2026-06-05T17:58:21.675795Z","end":"2026-06-05T17:58:21.813443Z","steps":["trace[1265657285] 'agreement among raft nodes before linearized reading' (duration: 137.449528ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:58:22.414121Z","caller":"traceutil/trace.go:171","msg":"trace[1430340202] transaction","detail":"{read_only:false; response_revision:1042; number_of_response:1; }","duration":"138.50225ms","start":"2026-06-05T17:58:22.275595Z","end":"2026-06-05T17:58:22.414097Z","steps":["trace[1430340202] 'process raft request' (duration: 138.319756ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:58:29.790816Z","caller":"traceutil/trace.go:171","msg":"trace[1356029729] transaction","detail":"{read_only:false; response_revision:1066; number_of_response:1; }","duration":"101.246819ms","start":"2026-06-05T17:58:29.689552Z","end":"2026-06-05T17:58:29.790799Z","steps":["trace[1356029729] 'process raft request' (duration: 101.145078ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:58:29.829025Z","caller":"traceutil/trace.go:171","msg":"trace[1767332846] linearizableReadLoop","detail":"{readStateIndex:1106; appliedIndex:1104; }","duration":"128.308747ms","start":"2026-06-05T17:58:29.700696Z","end":"2026-06-05T17:58:29.829005Z","steps":["trace[1767332846] 'read index received' (duration: 90.007809ms)","trace[1767332846] 'applied index is now lower than readState.Index' (duration: 38.300077ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T17:58:29.829119Z","caller":"traceutil/trace.go:171","msg":"trace[918945145] transaction","detail":"{read_only:false; response_revision:1067; number_of_response:1; }","duration":"135.375769ms","start":"2026-06-05T17:58:29.693708Z","end":"2026-06-05T17:58:29.829083Z","steps":["trace[918945145] 'process raft request' (duration: 135.187396ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:58:29.829251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.659204ms","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-06-05T17:58:29.829318Z","caller":"traceutil/trace.go:171","msg":"trace[334258768] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1067; }","duration":"104.752966ms","start":"2026-06-05T17:58:29.72455Z","end":"2026-06-05T17:58:29.829303Z","steps":["trace[334258768] 'agreement among raft nodes before linearized reading' (duration: 104.578512ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:58:29.82962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.910968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.116\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-05T17:58:29.829724Z","caller":"traceutil/trace.go:171","msg":"trace[1335929321] range","detail":"{range_begin:/registry/masterleases/199.204.45.116; range_end:; response_count:1; response_revision:1067; }","duration":"129.034001ms","start":"2026-06-05T17:58:29.700674Z","end":"2026-06-05T17:58:29.829708Z","steps":["trace[1335929321] 'agreement among raft nodes before linearized reading' (duration: 128.784496ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:58:36.102633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.044177ms","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-06-05T17:58:36.103142Z","caller":"traceutil/trace.go:171","msg":"trace[1026956632] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1087; }","duration":"235.678799ms","start":"2026-06-05T17:58:35.867445Z","end":"2026-06-05T17:58:36.103123Z","steps":["trace[1026956632] 'range keys from in-memory index tree' (duration: 234.865414ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:58:36.102823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.557134ms","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-06-05T17:58:36.103414Z","caller":"traceutil/trace.go:171","msg":"trace[863794861] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1087; }","duration":"205.192747ms","start":"2026-06-05T17:58:35.898204Z","end":"2026-06-05T17:58:36.103396Z","steps":["trace[863794861] 'range keys from in-memory index tree' (duration: 204.435693ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:58:36.102898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.93908ms","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-06-05T17:58:36.103577Z","caller":"traceutil/trace.go:171","msg":"trace[1294644174] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1087; }","duration":"127.633153ms","start":"2026-06-05T17:58:35.975919Z","end":"2026-06-05T17:58:36.103553Z","steps":["trace[1294644174] 'range keys from in-memory index tree' (duration: 126.849848ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:58:36.102897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.106742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-05T17:58:36.103704Z","caller":"traceutil/trace.go:171","msg":"trace[699332938] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1087; }","duration":"253.947427ms","start":"2026-06-05T17:58:35.849749Z","end":"2026-06-05T17:58:36.103696Z","steps":["trace[699332938] 'range keys from in-memory index tree' (duration: 252.980029ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:58:36.10295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.958358ms","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-06-05T17:58:36.103776Z","caller":"traceutil/trace.go:171","msg":"trace[1869435450] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1087; }","duration":"247.799114ms","start":"2026-06-05T17:58:35.855972Z","end":"2026-06-05T17:58:36.103771Z","steps":["trace[1869435450] 'range keys from in-memory index tree' (duration: 246.902047ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:58:36.379815Z","caller":"traceutil/trace.go:171","msg":"trace[983969182] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"268.393186ms","start":"2026-06-05T17:58:36.111395Z","end":"2026-06-05T17:58:36.379788Z","steps":["trace[983969182] 'process raft request' (duration: 268.157962ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:58:36.534597Z","caller":"traceutil/trace.go:171","msg":"trace[129378405] transaction","detail":"{read_only:false; response_revision:1089; number_of_response:1; }","duration":"423.135108ms","start":"2026-06-05T17:58:36.111441Z","end":"2026-06-05T17:58:36.534576Z","steps":["trace[129378405] 'process raft request' (duration: 351.235064ms)","trace[129378405] 'compare' (duration: 71.64729ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T17:58:36.534707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:58:36.111424Z","time spent":"423.22315ms","remote":"127.0.0.1:59240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T17:58:36.534904Z","caller":"traceutil/trace.go:171","msg":"trace[1457892610] transaction","detail":"{read_only:false; response_revision:1092; number_of_response:1; }","duration":"400.475261ms","start":"2026-06-05T17:58:36.134404Z","end":"2026-06-05T17:58:36.534879Z","steps":["trace[1457892610] 'process raft request' (duration: 400.43017ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:58:36.535057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:58:36.134372Z","time spent":"400.595483ms","remote":"127.0.0.1:59240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T17:58:36.535125Z","caller":"traceutil/trace.go:171","msg":"trace[411284176] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"400.781236ms","start":"2026-06-05T17:58:36.134322Z","end":"2026-06-05T17:58:36.535103Z","steps":["trace[411284176] 'process raft request' (duration: 400.383529ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:58:36.535255Z","caller":"traceutil/trace.go:171","msg":"trace[1968703957] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"423.736089ms","start":"2026-06-05T17:58:36.111493Z","end":"2026-06-05T17:58:36.535229Z","steps":["trace[1968703957] 'process raft request' (duration: 423.037826ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:58:36.535255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:58:36.134307Z","time spent":"400.899878ms","remote":"127.0.0.1:59240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T17:58:36.535402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:58:36.111488Z","time spent":"423.833722ms","remote":"127.0.0.1:59240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T17:58:38.564395Z","caller":"traceutil/trace.go:171","msg":"trace[528656097] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"175.681953ms","start":"2026-06-05T17:58:38.388697Z","end":"2026-06-05T17:58:38.564379Z","steps":["trace[528656097] 'process raft request' (duration: 175.576861ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:58:38.564573Z","caller":"traceutil/trace.go:171","msg":"trace[656109337] linearizableReadLoop","detail":"{readStateIndex:1135; appliedIndex:1135; }","duration":"166.835689ms","start":"2026-06-05T17:58:38.397712Z","end":"2026-06-05T17:58:38.564548Z","steps":["trace[656109337] 'read index received' (duration: 166.828519ms)","trace[656109337] 'applied index is now lower than readState.Index' (duration: 5.38µs)"],"step_count":2} {"level":"warn","ts":"2026-06-05T17:58:38.565001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.221707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-05T17:58:38.565311Z","caller":"traceutil/trace.go:171","msg":"trace[2023235133] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1094; }","duration":"167.417811ms","start":"2026-06-05T17:58:38.397686Z","end":"2026-06-05T17:58:38.565104Z","steps":["trace[2023235133] 'agreement among raft nodes before linearized reading' (duration: 167.223438ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:58:50.766017Z","caller":"traceutil/trace.go:171","msg":"trace[635289067] linearizableReadLoop","detail":"{readStateIndex:1179; appliedIndex:1178; }","duration":"131.625803ms","start":"2026-06-05T17:58:50.634372Z","end":"2026-06-05T17:58:50.765998Z","steps":["trace[635289067] 'read index received' (duration: 131.409609ms)","trace[635289067] 'applied index is now lower than readState.Index' (duration: 215.424µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T17:58:50.766152Z","caller":"traceutil/trace.go:171","msg":"trace[1326576207] transaction","detail":"{read_only:false; response_revision:1135; number_of_response:1; }","duration":"134.225859ms","start":"2026-06-05T17:58:50.63189Z","end":"2026-06-05T17:58:50.766116Z","steps":["trace[1326576207] 'process raft request' (duration: 133.966924ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:58:50.766293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.889717ms","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-06-05T17:58:50.766354Z","caller":"traceutil/trace.go:171","msg":"trace[998583885] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1135; }","duration":"131.98302ms","start":"2026-06-05T17:58:50.634356Z","end":"2026-06-05T17:58:50.766339Z","steps":["trace[998583885] 'agreement among raft nodes before linearized reading' (duration: 131.766456ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:58:54.001777Z","caller":"traceutil/trace.go:171","msg":"trace[1790614957] transaction","detail":"{read_only:false; response_revision:1146; number_of_response:1; }","duration":"125.875545ms","start":"2026-06-05T17:58:53.875881Z","end":"2026-06-05T17:58:54.001757Z","steps":["trace[1790614957] 'process raft request' (duration: 125.730433ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:58:58.180441Z","caller":"traceutil/trace.go:171","msg":"trace[2049360263] transaction","detail":"{read_only:false; response_revision:1159; number_of_response:1; }","duration":"135.627787ms","start":"2026-06-05T17:58:58.044796Z","end":"2026-06-05T17:58:58.180424Z","steps":["trace[2049360263] 'process raft request' (duration: 135.522945ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:59:07.087868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.324832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-05T17:59:07.087955Z","caller":"traceutil/trace.go:171","msg":"trace[621087755] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1187; }","duration":"137.443605ms","start":"2026-06-05T17:59:06.950491Z","end":"2026-06-05T17:59:07.087935Z","steps":["trace[621087755] 'range keys from in-memory index tree' (duration: 137.107239ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:59:07.08807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.541116ms","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-06-05T17:59:07.088143Z","caller":"traceutil/trace.go:171","msg":"trace[1956341241] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1187; }","duration":"137.639078ms","start":"2026-06-05T17:59:06.950486Z","end":"2026-06-05T17:59:07.088126Z","steps":["trace[1956341241] 'range keys from in-memory index tree' (duration: 137.352564ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:59:07.088486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.924425ms","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-06-05T17:59:07.088548Z","caller":"traceutil/trace.go:171","msg":"trace[1870429733] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1187; }","duration":"137.032426ms","start":"2026-06-05T17:59:06.951504Z","end":"2026-06-05T17:59:07.088536Z","steps":["trace[1870429733] 'range keys from in-memory index tree' (duration: 136.792613ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:59:07.088631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.38838ms","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-06-05T17:59:07.088829Z","caller":"traceutil/trace.go:171","msg":"trace[628451508] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1187; }","duration":"142.626115ms","start":"2026-06-05T17:59:06.946188Z","end":"2026-06-05T17:59:07.088814Z","steps":["trace[628451508] 'range keys from in-memory index tree' (duration: 142.259827ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:59:47.149832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.870792ms","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-06-05T17:59:47.149964Z","caller":"traceutil/trace.go:171","msg":"trace[609478484] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1356; }","duration":"131.032654ms","start":"2026-06-05T17:59:47.018903Z","end":"2026-06-05T17:59:47.149936Z","steps":["trace[609478484] 'range keys from in-memory index tree' (duration: 130.620438ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:59:49.284667Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853970967918873292,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-05T17:59:49.644383Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.255202462s","expected-duration":"1s"} {"level":"info","ts":"2026-06-05T17:59:49.644731Z","caller":"traceutil/trace.go:171","msg":"trace[1245414756] linearizableReadLoop","detail":"{readStateIndex:1419; appliedIndex:1418; }","duration":"860.560117ms","start":"2026-06-05T17:59:48.784147Z","end":"2026-06-05T17:59:49.644707Z","steps":["trace[1245414756] 'read index received' (duration: 860.340704ms)","trace[1245414756] 'applied index is now lower than readState.Index' (duration: 218.273µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T17:59:49.644786Z","caller":"traceutil/trace.go:171","msg":"trace[2059329579] transaction","detail":"{read_only:false; response_revision:1362; number_of_response:1; }","duration":"1.25569571s","start":"2026-06-05T17:59:48.389063Z","end":"2026-06-05T17:59:49.644759Z","steps":["trace[2059329579] 'process raft request' (duration: 1.255509227s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:59:49.644875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"860.71388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T17:59:49.644892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:59:48.389036Z","time spent":"1.255783052s","remote":"127.0.0.1:59240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T17:59:49.644929Z","caller":"traceutil/trace.go:171","msg":"trace[380128449] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1362; }","duration":"860.814752ms","start":"2026-06-05T17:59:48.784094Z","end":"2026-06-05T17:59:49.644909Z","steps":["trace[380128449] 'agreement among raft nodes before linearized reading' (duration: 860.730841ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:59:49.644979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.709541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-05T17:59:49.645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:59:48.784076Z","time spent":"860.908353ms","remote":"127.0.0.1:42728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-05T17:59:49.645031Z","caller":"traceutil/trace.go:171","msg":"trace[1168319865] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1362; }","duration":"471.797622ms","start":"2026-06-05T17:59:49.17322Z","end":"2026-06-05T17:59:49.645017Z","steps":["trace[1168319865] 'agreement among raft nodes before linearized reading' (duration: 471.630199ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:59:49.645072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:59:49.173201Z","time spent":"471.860513ms","remote":"127.0.0.1:59240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-05T17:59:49.645085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.980471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-05T17:59:49.645155Z","caller":"traceutil/trace.go:171","msg":"trace[521562844] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1362; }","duration":"222.070493ms","start":"2026-06-05T17:59:49.423065Z","end":"2026-06-05T17:59:49.645136Z","steps":["trace[521562844] 'agreement among raft nodes before linearized reading' (duration: 221.82996ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:59:49.645284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.154045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-06-05T17:59:49.645178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.60344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-05T17:59:49.64539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.937423ms","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-06-05T17:59:49.645415Z","caller":"traceutil/trace.go:171","msg":"trace[146155355] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1362; }","duration":"247.000924ms","start":"2026-06-05T17:59:49.398408Z","end":"2026-06-05T17:59:49.645409Z","steps":["trace[146155355] 'agreement among raft nodes before linearized reading' (duration: 246.941653ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:59:49.645407Z","caller":"traceutil/trace.go:171","msg":"trace[1112171969] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1362; }","duration":"234.803833ms","start":"2026-06-05T17:59:49.410532Z","end":"2026-06-05T17:59:49.645336Z","steps":["trace[1112171969] 'agreement among raft nodes before linearized reading' (duration: 234.446148ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:59:49.64531Z","caller":"traceutil/trace.go:171","msg":"trace[201320838] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1362; }","duration":"222.195485ms","start":"2026-06-05T17:59:49.423107Z","end":"2026-06-05T17:59:49.645302Z","steps":["trace[201320838] 'agreement among raft nodes before linearized reading' (duration: 222.119154ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:59:49.755602Z","caller":"traceutil/trace.go:171","msg":"trace[627341018] transaction","detail":"{read_only:false; response_revision:1363; number_of_response:1; }","duration":"105.899778ms","start":"2026-06-05T17:59:49.649662Z","end":"2026-06-05T17:59:49.755562Z","steps":["trace[627341018] 'process raft request' (duration: 56.076916ms)","trace[627341018] 'compare' (duration: 49.582967ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T17:59:49.756227Z","caller":"traceutil/trace.go:171","msg":"trace[790088362] transaction","detail":"{read_only:false; response_revision:1366; number_of_response:1; }","duration":"105.744915ms","start":"2026-06-05T17:59:49.650455Z","end":"2026-06-05T17:59:49.7562Z","steps":["trace[790088362] 'process raft request' (duration: 105.662212ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:59:49.756392Z","caller":"traceutil/trace.go:171","msg":"trace[540581370] transaction","detail":"{read_only:false; response_revision:1367; number_of_response:1; }","duration":"105.556361ms","start":"2026-06-05T17:59:49.65082Z","end":"2026-06-05T17:59:49.756376Z","steps":["trace[540581370] 'process raft request' (duration: 105.343868ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:59:49.756212Z","caller":"traceutil/trace.go:171","msg":"trace[567666023] transaction","detail":"{read_only:false; response_revision:1364; number_of_response:1; }","duration":"105.941168ms","start":"2026-06-05T17:59:49.650249Z","end":"2026-06-05T17:59:49.756191Z","steps":["trace[567666023] 'process raft request' (duration: 105.245877ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T17:59:49.756254Z","caller":"traceutil/trace.go:171","msg":"trace[1214474323] transaction","detail":"{read_only:false; response_revision:1365; number_of_response:1; }","duration":"105.792105ms","start":"2026-06-05T17:59:49.650415Z","end":"2026-06-05T17:59:49.756207Z","steps":["trace[1214474323] 'process raft request' (duration: 105.360437ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T17:59:50.082099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.952226ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"warn","ts":"2026-06-05T17:59:50.082197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T17:59:49.75731Z","time spent":"324.882918ms","remote":"127.0.0.1:42748","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-05T17:59:50.239709Z","caller":"traceutil/trace.go:171","msg":"trace[2125546602] transaction","detail":"{read_only:false; response_revision:1368; number_of_response:1; }","duration":"156.528079ms","start":"2026-06-05T17:59:50.08311Z","end":"2026-06-05T17:59:50.239638Z","steps":["trace[2125546602] 'process raft request' (duration: 156.318785ms)"],"step_count":1}