{"level":"warn","ts":"2026-04-13T21:01:18.496256Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-13T21:01:18.496363Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.250:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.250:2380","--initial-cluster=instance=https://199.204.45.250:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.250:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.250:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-13T21:01:18.496578Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-13T21:01:18.496594Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.250:2380"]} {"level":"info","ts":"2026-04-13T21:01:18.496638Z","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-04-13T21:01:18.497471Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"]} {"level":"info","ts":"2026-04-13T21:01:18.497564Z","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.250:2380"],"listen-peer-urls":["https://199.204.45.250:2380"],"advertise-client-urls":["https://199.204.45.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.250:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-13T21:01:18.502549Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.77442ms"} {"level":"info","ts":"2026-04-13T21:01:18.509741Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d98d5f2c752cc52d","cluster-id":"c785b4aaf4bd3b11"} {"level":"info","ts":"2026-04-13T21:01:18.509819Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=()"} {"level":"info","ts":"2026-04-13T21:01:18.509851Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became follower at term 0"} {"level":"info","ts":"2026-04-13T21:01:18.509862Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d98d5f2c752cc52d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-13T21:01:18.50988Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became follower at term 1"} {"level":"info","ts":"2026-04-13T21:01:18.50993Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=(15676290522495632685)"} {"level":"warn","ts":"2026-04-13T21:01:18.516792Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-13T21:01:18.518557Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-13T21:01:18.520855Z","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-04-13T21:01:18.523161Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d98d5f2c752cc52d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-13T21:01:18.523698Z","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-04-13T21:01:18.523825Z","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-04-13T21:01:18.523836Z","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-04-13T21:01:18.523699Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d98d5f2c752cc52d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-13T21:01:18.524895Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=(15676290522495632685)"} {"level":"info","ts":"2026-04-13T21:01:18.525739Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c785b4aaf4bd3b11","local-member-id":"d98d5f2c752cc52d","added-peer-id":"d98d5f2c752cc52d","added-peer-peer-urls":["https://199.204.45.250:2380"]} {"level":"info","ts":"2026-04-13T21:01:18.526821Z","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-04-13T21:01:18.526963Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.250:2380"} {"level":"info","ts":"2026-04-13T21:01:18.526988Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.250:2380"} {"level":"info","ts":"2026-04-13T21:01:18.527066Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d98d5f2c752cc52d","initial-advertise-peer-urls":["https://199.204.45.250:2380"],"listen-peer-urls":["https://199.204.45.250:2380"],"advertise-client-urls":["https://199.204.45.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-13T21:01:18.527095Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-13T21:01:18.914905Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d is starting a new election at term 1"} {"level":"info","ts":"2026-04-13T21:01:18.91599Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became pre-candidate at term 1"} {"level":"info","ts":"2026-04-13T21:01:18.916023Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d received MsgPreVoteResp from d98d5f2c752cc52d at term 1"} {"level":"info","ts":"2026-04-13T21:01:18.916041Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became candidate at term 2"} {"level":"info","ts":"2026-04-13T21:01:18.916049Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d received MsgVoteResp from d98d5f2c752cc52d at term 2"} {"level":"info","ts":"2026-04-13T21:01:18.916061Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became leader at term 2"} {"level":"info","ts":"2026-04-13T21:01:18.916072Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d98d5f2c752cc52d elected leader d98d5f2c752cc52d at term 2"} {"level":"info","ts":"2026-04-13T21:01:18.916968Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T21:01:18.91785Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d98d5f2c752cc52d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.250:2379]}","request-path":"/0/members/d98d5f2c752cc52d/attributes","cluster-id":"c785b4aaf4bd3b11","publish-timeout":"7s"} {"level":"info","ts":"2026-04-13T21:01:18.917884Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T21:01:18.918092Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T21:01:18.918523Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-13T21:01:18.918571Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-13T21:01:18.920072Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c785b4aaf4bd3b11","local-member-id":"d98d5f2c752cc52d","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T21:01:18.920187Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T21:01:18.920219Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T21:01:18.92076Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-13T21:01:18.922542Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.250:2379"} {"level":"info","ts":"2026-04-13T21:01:20.392329Z","caller":"traceutil/trace.go:171","msg":"trace[1706806267] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"106.224593ms","start":"2026-04-13T21:01:20.286031Z","end":"2026-04-13T21:01:20.392256Z","steps":["trace[1706806267] 'read index received' (duration: 24.950668ms)","trace[1706806267] 'applied index is now lower than readState.Index' (duration: 81.271895ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:01:20.39239Z","caller":"traceutil/trace.go:171","msg":"trace[1717597108] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"112.351874ms","start":"2026-04-13T21:01:20.280017Z","end":"2026-04-13T21:01:20.392369Z","steps":["trace[1717597108] 'process raft request' (duration: 52.523831ms)","trace[1717597108] 'compare' (duration: 59.326595ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:01:20.392547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.486123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T21:01:20.392631Z","caller":"traceutil/trace.go:171","msg":"trace[443982862] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:4; }","duration":"106.587647ms","start":"2026-04-13T21:01:20.286027Z","end":"2026-04-13T21:01:20.392615Z","steps":["trace[443982862] 'agreement among raft nodes before linearized reading' (duration: 106.40593ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:01:20.486108Z","caller":"traceutil/trace.go:171","msg":"trace[967877921] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"138.878028ms","start":"2026-04-13T21:01:20.3472Z","end":"2026-04-13T21:01:20.486078Z","steps":["trace[967877921] 'process raft request' (duration: 138.752813ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:01:20.486175Z","caller":"traceutil/trace.go:171","msg":"trace[1976912104] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"140.184326ms","start":"2026-04-13T21:01:20.34597Z","end":"2026-04-13T21:01:20.486154Z","steps":["trace[1976912104] 'process raft request' (duration: 139.823773ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:01:20.486223Z","caller":"traceutil/trace.go:171","msg":"trace[1452857403] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"121.137369ms","start":"2026-04-13T21:01:20.365051Z","end":"2026-04-13T21:01:20.486188Z","steps":["trace[1452857403] 'process raft request' (duration: 121.051816ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:01:20.486406Z","caller":"traceutil/trace.go:171","msg":"trace[738852996] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"138.505415ms","start":"2026-04-13T21:01:20.347851Z","end":"2026-04-13T21:01:20.486357Z","steps":["trace[738852996] 'process raft request' (duration: 138.187362ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:01:20.486504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.724803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.250\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T21:01:20.486556Z","caller":"traceutil/trace.go:171","msg":"trace[1636033111] range","detail":"{range_begin:/registry/masterleases/199.204.45.250; range_end:; response_count:0; response_revision:10; }","duration":"143.830767ms","start":"2026-04-13T21:01:20.342709Z","end":"2026-04-13T21:01:20.48654Z","steps":["trace[1636033111] 'agreement among raft nodes before linearized reading' (duration: 143.575038ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:01:20.486571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.104599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-13T21:01:20.486508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.253291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T21:01:20.486744Z","caller":"traceutil/trace.go:171","msg":"trace[225894466] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"138.893989ms","start":"2026-04-13T21:01:20.347841Z","end":"2026-04-13T21:01:20.486735Z","steps":["trace[225894466] 'process raft request' (duration: 138.219264ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:01:20.48675Z","caller":"traceutil/trace.go:171","msg":"trace[1906546885] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"159.536042ms","start":"2026-04-13T21:01:20.3272Z","end":"2026-04-13T21:01:20.486736Z","steps":["trace[1906546885] 'agreement among raft nodes before linearized reading' (duration: 159.125858ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:01:20.486755Z","caller":"traceutil/trace.go:171","msg":"trace[112498366] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"141.312226ms","start":"2026-04-13T21:01:20.345412Z","end":"2026-04-13T21:01:20.486724Z","steps":["trace[112498366] 'agreement among raft nodes before linearized reading' (duration: 140.791906ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:01:20.486885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.881721ms","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-04-13T21:01:20.486935Z","caller":"traceutil/trace.go:171","msg":"trace[927566164] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"140.970674ms","start":"2026-04-13T21:01:20.345951Z","end":"2026-04-13T21:01:20.486922Z","steps":["trace[927566164] 'agreement among raft nodes before linearized reading' (duration: 140.85557ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:01:20.487062Z","caller":"traceutil/trace.go:171","msg":"trace[320938477] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"139.509841ms","start":"2026-04-13T21:01:20.347498Z","end":"2026-04-13T21:01:20.487008Z","steps":["trace[320938477] 'process raft request' (duration: 138.491634ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:01:20.564563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.733075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T21:01:20.564649Z","caller":"traceutil/trace.go:171","msg":"trace[2052358393] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"165.833588ms","start":"2026-04-13T21:01:20.398789Z","end":"2026-04-13T21:01:20.564623Z","steps":["trace[2052358393] 'agreement among raft nodes before linearized reading' (duration: 93.182984ms)","trace[2052358393] 'range keys from in-memory index tree' (duration: 72.557451ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:01:20.564546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.934634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T21:01:20.564855Z","caller":"traceutil/trace.go:171","msg":"trace[90324322] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"143.267267ms","start":"2026-04-13T21:01:20.421563Z","end":"2026-04-13T21:01:20.564831Z","steps":["trace[90324322] 'agreement among raft nodes before linearized reading' (duration: 70.399095ms)","trace[90324322] 'range keys from in-memory index tree' (duration: 72.53351ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:01:20.564721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.108966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"info","ts":"2026-04-13T21:01:20.564977Z","caller":"traceutil/trace.go:171","msg":"trace[876653899] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"169.421048ms","start":"2026-04-13T21:01:20.395519Z","end":"2026-04-13T21:01:20.56494Z","steps":["trace[876653899] 'agreement among raft nodes before linearized reading' (duration: 96.462862ms)","trace[876653899] 'range keys from in-memory index tree' (duration: 72.643323ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:01:20.56469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.998096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T21:01:20.565196Z","caller":"traceutil/trace.go:171","msg":"trace[1851092351] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"143.566248ms","start":"2026-04-13T21:01:20.42158Z","end":"2026-04-13T21:01:20.565146Z","steps":["trace[1851092351] 'agreement among raft nodes before linearized reading' (duration: 70.349762ms)","trace[1851092351] 'range keys from in-memory index tree' (duration: 72.603463ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:01:20.983319Z","caller":"traceutil/trace.go:171","msg":"trace[1401938008] transaction","detail":"{read_only:false; response_revision:41; number_of_response:1; }","duration":"245.347901ms","start":"2026-04-13T21:01:20.737906Z","end":"2026-04-13T21:01:20.983254Z","steps":["trace[1401938008] 'process raft request' (duration: 166.338417ms)","trace[1401938008] 'compare' (duration: 78.868419ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:01:20.985209Z","caller":"traceutil/trace.go:171","msg":"trace[1075992392] transaction","detail":"{read_only:false; response_revision:43; number_of_response:1; }","duration":"244.19868ms","start":"2026-04-13T21:01:20.740981Z","end":"2026-04-13T21:01:20.98518Z","steps":["trace[1075992392] 'process raft request' (duration: 244.031324ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:01:20.985265Z","caller":"traceutil/trace.go:171","msg":"trace[975183448] transaction","detail":"{read_only:false; response_revision:42; number_of_response:1; }","duration":"246.786662ms","start":"2026-04-13T21:01:20.738425Z","end":"2026-04-13T21:01:20.985211Z","steps":["trace[975183448] 'process raft request' (duration: 246.427558ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:01:43.459111Z","caller":"traceutil/trace.go:171","msg":"trace[132926537] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"224.86473ms","start":"2026-04-13T21:01:43.234207Z","end":"2026-04-13T21:01:43.459071Z","steps":["trace[132926537] 'process raft request' (duration: 224.668193ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:01:49.598097Z","caller":"traceutil/trace.go:171","msg":"trace[409523694] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"111.986695ms","start":"2026-04-13T21:01:49.486055Z","end":"2026-04-13T21:01:49.598042Z","steps":["trace[409523694] 'process raft request' (duration: 111.825625ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:01:50.131109Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185609651171868,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T21:01:50.631436Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185609651171868,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T21:01:50.642777Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.024082996s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-13T21:01:50.763139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.45846ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T21:01:50.763235Z","caller":"traceutil/trace.go:171","msg":"trace[31503427] linearizableReadLoop","detail":"{readStateIndex:487; appliedIndex:486; }","duration":"1.132550111s","start":"2026-04-13T21:01:49.630669Z","end":"2026-04-13T21:01:50.763219Z","steps":["trace[31503427] 'read index received' (duration: 1.01229599s)","trace[31503427] 'applied index is now lower than readState.Index' (duration: 120.252651ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:01:50.763299Z","caller":"traceutil/trace.go:171","msg":"trace[1902295898] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"1.144669297s","start":"2026-04-13T21:01:49.6186Z","end":"2026-04-13T21:01:50.76327Z","steps":["trace[1902295898] 'process raft request' (duration: 1.024451466s)","trace[1902295898] 'compare' (duration: 119.316ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:01:50.763349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"709.938021ms","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-04-13T21:01:50.763381Z","caller":"traceutil/trace.go:171","msg":"trace[2024299974] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:467; }","duration":"710.009581ms","start":"2026-04-13T21:01:50.05336Z","end":"2026-04-13T21:01:50.76337Z","steps":["trace[2024299974] 'agreement among raft nodes before linearized reading' (duration: 709.948451ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:01:50.763368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.132679691s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:01:50.763437Z","caller":"traceutil/trace.go:171","msg":"trace[140330412] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:467; }","duration":"1.132804781s","start":"2026-04-13T21:01:49.630612Z","end":"2026-04-13T21:01:50.763417Z","steps":["trace[140330412] 'agreement among raft nodes before linearized reading' (duration: 1.132680521s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:01:50.763423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:01:50.05334Z","time spent":"710.075871ms","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-13T21:01:50.763455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:01:49.618575Z","time spent":"1.144787047s","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:01:50.763423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.506448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:01:50.763553Z","caller":"traceutil/trace.go:171","msg":"trace[1643449139] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:467; }","duration":"566.687328ms","start":"2026-04-13T21:01:50.196837Z","end":"2026-04-13T21:01:50.763525Z","steps":["trace[1643449139] 'agreement among raft nodes before linearized reading' (duration: 566.497688ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:01:50.763482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:01:49.630582Z","time spent":"1.132893552s","remote":"127.0.0.1:51940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-13T21:01:50.763628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:01:50.196815Z","time spent":"566.796648ms","remote":"127.0.0.1:52064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"warn","ts":"2026-04-13T21:01:51.596955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.539571ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T21:01:51.597327Z","caller":"traceutil/trace.go:171","msg":"trace[871749931] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"201.601645ms","start":"2026-04-13T21:01:51.395669Z","end":"2026-04-13T21:01:51.597271Z","steps":["trace[871749931] 'compare' (duration: 192.180511ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:01:51.597421Z","caller":"traceutil/trace.go:171","msg":"trace[1220435237] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"197.515738ms","start":"2026-04-13T21:01:51.399885Z","end":"2026-04-13T21:01:51.597401Z","steps":["trace[1220435237] 'process raft request' (duration: 197.301288ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:01:51.629293Z","caller":"traceutil/trace.go:171","msg":"trace[1939697894] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"203.568747ms","start":"2026-04-13T21:01:51.425697Z","end":"2026-04-13T21:01:51.629266Z","steps":["trace[1939697894] 'process raft request' (duration: 203.210576ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:01:51.629458Z","caller":"traceutil/trace.go:171","msg":"trace[1354597703] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"170.903779ms","start":"2026-04-13T21:01:51.458541Z","end":"2026-04-13T21:01:51.629444Z","steps":["trace[1354597703] 'process raft request' (duration: 170.676858ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:01:52.50293Z","caller":"traceutil/trace.go:171","msg":"trace[1256015225] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"820.553571ms","start":"2026-04-13T21:01:51.682344Z","end":"2026-04-13T21:01:52.502897Z","steps":["trace[1256015225] 'process raft request' (duration: 820.364911ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:01:52.503331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:01:51.682314Z","time spent":"820.947722ms","remote":"127.0.0.1:52004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64392,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T21:01:52.51077Z","caller":"traceutil/trace.go:171","msg":"trace[1819636803] linearizableReadLoop","detail":"{readStateIndex:551; appliedIndex:549; }","duration":"436.467168ms","start":"2026-04-13T21:01:52.074277Z","end":"2026-04-13T21:01:52.510744Z","steps":["trace[1819636803] 'read index received' (duration: 428.386122ms)","trace[1819636803] 'applied index is now lower than readState.Index' (duration: 8.079246ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:01:52.510915Z","caller":"traceutil/trace.go:171","msg":"trace[1374733491] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"788.701686ms","start":"2026-04-13T21:01:51.722185Z","end":"2026-04-13T21:01:52.510887Z","steps":["trace[1374733491] 'process raft request' (duration: 788.274436ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:01:52.511034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:01:51.722166Z","time spent":"788.807717ms","remote":"127.0.0.1:52004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18032,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:01:52.510962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.670788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.250\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-13T21:01:52.511201Z","caller":"traceutil/trace.go:171","msg":"trace[546536790] range","detail":"{range_begin:/registry/masterleases/199.204.45.250; range_end:; response_count:1; response_revision:526; }","duration":"436.89868ms","start":"2026-04-13T21:01:52.074247Z","end":"2026-04-13T21:01:52.511145Z","steps":["trace[546536790] 'agreement among raft nodes before linearized reading' (duration: 436.573849ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:01:52.51129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:01:52.074231Z","time spent":"437.01296ms","remote":"127.0.0.1:51982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.204.45.250\" "} {"level":"info","ts":"2026-04-13T21:01:53.489071Z","caller":"traceutil/trace.go:171","msg":"trace[1395134631] linearizableReadLoop","detail":"{readStateIndex:576; appliedIndex:575; }","duration":"109.037794ms","start":"2026-04-13T21:01:53.380008Z","end":"2026-04-13T21:01:53.489045Z","steps":["trace[1395134631] 'read index received' (duration: 108.465072ms)","trace[1395134631] 'applied index is now lower than readState.Index' (duration: 571.802µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:01:53.489133Z","caller":"traceutil/trace.go:171","msg":"trace[1191586069] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"146.488067ms","start":"2026-04-13T21:01:53.342613Z","end":"2026-04-13T21:01:53.489101Z","steps":["trace[1191586069] 'process raft request' (duration: 145.925486ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:01:53.489328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.299574ms","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":"info","ts":"2026-04-13T21:01:53.489418Z","caller":"traceutil/trace.go:171","msg":"trace[126533209] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:550; }","duration":"109.434874ms","start":"2026-04-13T21:01:53.379962Z","end":"2026-04-13T21:01:53.489396Z","steps":["trace[126533209] 'agreement among raft nodes before linearized reading' (duration: 109.176524ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:01:55.898013Z","caller":"traceutil/trace.go:171","msg":"trace[1541612044] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"142.175313ms","start":"2026-04-13T21:01:55.755811Z","end":"2026-04-13T21:01:55.897987Z","steps":["trace[1541612044] 'process raft request' (duration: 141.588991ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:01:59.944954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.93294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-13T21:01:59.944984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.683679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:01:59.945681Z","caller":"traceutil/trace.go:171","msg":"trace[1006865119] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:591; }","duration":"252.666983ms","start":"2026-04-13T21:01:59.692961Z","end":"2026-04-13T21:01:59.945628Z","steps":["trace[1006865119] 'range keys from in-memory index tree' (duration: 251.761648ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:01:59.945745Z","caller":"traceutil/trace.go:171","msg":"trace[1129515674] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:591; }","duration":"382.456612ms","start":"2026-04-13T21:01:59.563265Z","end":"2026-04-13T21:01:59.945721Z","steps":["trace[1129515674] 'count revisions from in-memory index tree' (duration: 381.632359ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:01:59.945831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:01:59.563249Z","time spent":"382.559943ms","remote":"127.0.0.1:51250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-13T21:01:59.944975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.881405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:01:59.946049Z","caller":"traceutil/trace.go:171","msg":"trace[1555723814] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:591; }","duration":"398.990721ms","start":"2026-04-13T21:01:59.547042Z","end":"2026-04-13T21:01:59.946033Z","steps":["trace[1555723814] 'range keys from in-memory index tree' (duration: 397.817795ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:01:59.946115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:01:59.547025Z","time spent":"399.067441ms","remote":"127.0.0.1:51240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-04-13T21:01:59.945045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.698509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:01:59.945045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.038116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:01:59.946362Z","caller":"traceutil/trace.go:171","msg":"trace[1406965511] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:591; }","duration":"383.024215ms","start":"2026-04-13T21:01:59.563294Z","end":"2026-04-13T21:01:59.946318Z","steps":["trace[1406965511] 'range keys from in-memory index tree' (duration: 381.618078ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:01:59.946556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:01:59.563278Z","time spent":"383.222436ms","remote":"127.0.0.1:51250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-04-13T21:01:59.946433Z","caller":"traceutil/trace.go:171","msg":"trace[1763146678] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:591; }","duration":"399.430313ms","start":"2026-04-13T21:01:59.546976Z","end":"2026-04-13T21:01:59.946406Z","steps":["trace[1763146678] 'count revisions from in-memory index tree' (duration: 397.993146ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:01:59.946873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:01:59.546965Z","time spent":"399.853356ms","remote":"127.0.0.1:51240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-13T21:01:59.945119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.693572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:01:59.947084Z","caller":"traceutil/trace.go:171","msg":"trace[73788540] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:591; }","duration":"363.665663ms","start":"2026-04-13T21:01:59.5834Z","end":"2026-04-13T21:01:59.947065Z","steps":["trace[73788540] 'range keys from in-memory index tree' (duration: 361.651762ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:01:59.947159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:01:59.583391Z","time spent":"363.744704ms","remote":"127.0.0.1:51256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"warn","ts":"2026-04-13T21:01:59.945168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.145475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:01:59.947427Z","caller":"traceutil/trace.go:171","msg":"trace[1559052295] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:591; }","duration":"364.388027ms","start":"2026-04-13T21:01:59.582999Z","end":"2026-04-13T21:01:59.947387Z","steps":["trace[1559052295] 'count revisions from in-memory index tree' (duration: 362.102825ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:01:59.944954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.621038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:01:59.947513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:01:59.582989Z","time spent":"364.499077ms","remote":"127.0.0.1:51256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"info","ts":"2026-04-13T21:01:59.947549Z","caller":"traceutil/trace.go:171","msg":"trace[1750996206] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:591; }","duration":"382.259542ms","start":"2026-04-13T21:01:59.565238Z","end":"2026-04-13T21:01:59.947497Z","steps":["trace[1750996206] 'range keys from in-memory index tree' (duration: 379.546508ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:01:59.9451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.035814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:01:59.947664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:01:59.565224Z","time spent":"382.399983ms","remote":"127.0.0.1:51240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"info","ts":"2026-04-13T21:01:59.947674Z","caller":"traceutil/trace.go:171","msg":"trace[1333255447] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:591; }","duration":"364.623328ms","start":"2026-04-13T21:01:59.583032Z","end":"2026-04-13T21:01:59.947655Z","steps":["trace[1333255447] 'range keys from in-memory index tree' (duration: 361.965903ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:01:59.947917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:01:59.583018Z","time spent":"364.877999ms","remote":"127.0.0.1:51256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"info","ts":"2026-04-13T21:02:00.208362Z","caller":"traceutil/trace.go:171","msg":"trace[1689160632] linearizableReadLoop","detail":"{readStateIndex:619; appliedIndex:618; }","duration":"125.00771ms","start":"2026-04-13T21:02:00.083329Z","end":"2026-04-13T21:02:00.208337Z","steps":["trace[1689160632] 'read index received' (duration: 124.805429ms)","trace[1689160632] 'applied index is now lower than readState.Index' (duration: 201.331µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:02:00.208487Z","caller":"traceutil/trace.go:171","msg":"trace[692279612] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"258.165573ms","start":"2026-04-13T21:01:59.950256Z","end":"2026-04-13T21:02:00.208422Z","steps":["trace[692279612] 'process raft request' (duration: 257.939152ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:02:00.208671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.311812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-hsfcc\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-13T21:02:00.20897Z","caller":"traceutil/trace.go:171","msg":"trace[918828299] range","detail":"{range_begin:/registry/pods/kube-system/cilium-hsfcc; range_end:; response_count:1; response_revision:592; }","duration":"125.653204ms","start":"2026-04-13T21:02:00.083295Z","end":"2026-04-13T21:02:00.208948Z","steps":["trace[918828299] 'agreement among raft nodes before linearized reading' (duration: 125.149521ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:02:00.826404Z","caller":"traceutil/trace.go:171","msg":"trace[1466327386] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:619; }","duration":"196.25696ms","start":"2026-04-13T21:02:00.630116Z","end":"2026-04-13T21:02:00.826373Z","steps":["trace[1466327386] 'read index received' (duration: 195.950678ms)","trace[1466327386] 'applied index is now lower than readState.Index' (duration: 305.042µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:02:00.826699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.558322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:02:00.826801Z","caller":"traceutil/trace.go:171","msg":"trace[413948264] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:593; }","duration":"196.710063ms","start":"2026-04-13T21:02:00.630075Z","end":"2026-04-13T21:02:00.826785Z","steps":["trace[413948264] 'agreement among raft nodes before linearized reading' (duration: 196.560123ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:02:00.826664Z","caller":"traceutil/trace.go:171","msg":"trace[66112490] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"587.465223ms","start":"2026-04-13T21:02:00.239178Z","end":"2026-04-13T21:02:00.826643Z","steps":["trace[66112490] 'process raft request' (duration: 586.967409ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:02:00.827446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:02:00.239159Z","time spent":"587.988505ms","remote":"127.0.0.1:52172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:02:02.695514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.623872386s","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-04-13T21:02:02.696282Z","caller":"traceutil/trace.go:171","msg":"trace[1367297296] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:595; }","duration":"1.624678411s","start":"2026-04-13T21:02:01.071581Z","end":"2026-04-13T21:02:02.696259Z","steps":["trace[1367297296] 'range keys from in-memory index tree' (duration: 1.62160332s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:02:02.696414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:02:01.07156Z","time spent":"1.624837812s","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-13T21:02:02.696086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.989365ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T21:02:02.696527Z","caller":"traceutil/trace.go:171","msg":"trace[1083097282] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:622; }","duration":"621.857938ms","start":"2026-04-13T21:02:02.074656Z","end":"2026-04-13T21:02:02.696514Z","steps":["trace[1083097282] 'read index received' (duration: 436.381061ms)","trace[1083097282] 'applied index is now lower than readState.Index' (duration: 185.475667ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:02:02.696554Z","caller":"traceutil/trace.go:171","msg":"trace[451982676] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"913.813477ms","start":"2026-04-13T21:02:01.782713Z","end":"2026-04-13T21:02:02.696527Z","steps":["trace[451982676] 'process raft request' (duration: 728.299419ms)","trace[451982676] 'compare' (duration: 184.394321ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:02:02.696679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"622.020469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.250\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-04-13T21:02:02.696697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:02:01.782678Z","time spent":"913.943908ms","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T21:02:02.696716Z","caller":"traceutil/trace.go:171","msg":"trace[354539923] range","detail":"{range_begin:/registry/masterleases/199.204.45.250; range_end:; response_count:1; response_revision:596; }","duration":"622.096521ms","start":"2026-04-13T21:02:02.074609Z","end":"2026-04-13T21:02:02.696705Z","steps":["trace[354539923] 'agreement among raft nodes before linearized reading' (duration: 621.98937ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:02:02.696747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:02:02.074589Z","time spent":"622.151781ms","remote":"127.0.0.1:51982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.204.45.250\" "} {"level":"warn","ts":"2026-04-13T21:02:02.697619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.507796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-13T21:02:02.697753Z","caller":"traceutil/trace.go:171","msg":"trace[1792030804] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:596; }","duration":"485.682017ms","start":"2026-04-13T21:02:02.212012Z","end":"2026-04-13T21:02:02.697694Z","steps":["trace[1792030804] 'agreement among raft nodes before linearized reading' (duration: 484.68264ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:02:02.698529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:02:02.211993Z","time spent":"486.461793ms","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-13T21:02:02.954932Z","caller":"traceutil/trace.go:171","msg":"trace[451427861] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"253.284968ms","start":"2026-04-13T21:02:02.701613Z","end":"2026-04-13T21:02:02.954898Z","steps":["trace[451427861] 'process raft request' (duration: 253.064956ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:02:02.955124Z","caller":"traceutil/trace.go:171","msg":"trace[1728145930] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"252.192911ms","start":"2026-04-13T21:02:02.702908Z","end":"2026-04-13T21:02:02.955101Z","steps":["trace[1728145930] 'process raft request' (duration: 251.902869ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:02:05.140821Z","caller":"traceutil/trace.go:171","msg":"trace[295124410] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"169.695383ms","start":"2026-04-13T21:02:04.971096Z","end":"2026-04-13T21:02:05.140791Z","steps":["trace[295124410] 'process raft request' (duration: 131.584953ms)","trace[295124410] 'compare' (duration: 37.994499ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:02:05.146006Z","caller":"traceutil/trace.go:171","msg":"trace[313623208] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"174.29492ms","start":"2026-04-13T21:02:04.971664Z","end":"2026-04-13T21:02:05.145959Z","steps":["trace[313623208] 'process raft request' (duration: 174.049607ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:02:05.146093Z","caller":"traceutil/trace.go:171","msg":"trace[1129082531] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"111.838991ms","start":"2026-04-13T21:02:05.034233Z","end":"2026-04-13T21:02:05.146072Z","steps":["trace[1129082531] 'process raft request' (duration: 111.631889ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:02:05.561184Z","caller":"traceutil/trace.go:171","msg":"trace[98102641] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"135.84184ms","start":"2026-04-13T21:02:05.425317Z","end":"2026-04-13T21:02:05.561159Z","steps":["trace[98102641] 'process raft request' (duration: 135.633618ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:02:05.712861Z","caller":"traceutil/trace.go:171","msg":"trace[693445462] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"280.081134ms","start":"2026-04-13T21:02:05.432707Z","end":"2026-04-13T21:02:05.712788Z","steps":["trace[693445462] 'process raft request' (duration: 279.57224ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:02:13.170037Z","caller":"traceutil/trace.go:171","msg":"trace[1935749559] transaction","detail":"{read_only:false; response_revision:715; number_of_response:1; }","duration":"155.746861ms","start":"2026-04-13T21:02:13.014263Z","end":"2026-04-13T21:02:13.17001Z","steps":["trace[1935749559] 'process raft request' (duration: 109.213443ms)","trace[1935749559] 'compare' (duration: 46.412667ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:02:15.073634Z","caller":"traceutil/trace.go:171","msg":"trace[1267334108] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"114.79376ms","start":"2026-04-13T21:02:14.958806Z","end":"2026-04-13T21:02:15.073599Z","steps":["trace[1267334108] 'process raft request' (duration: 37.638355ms)","trace[1267334108] 'compare' (duration: 76.920762ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:02:15.476739Z","caller":"traceutil/trace.go:171","msg":"trace[1867698517] transaction","detail":"{read_only:false; response_revision:738; number_of_response:1; }","duration":"110.238491ms","start":"2026-04-13T21:02:15.366478Z","end":"2026-04-13T21:02:15.476716Z","steps":["trace[1867698517] 'process raft request' (duration: 109.519083ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:02:15.476933Z","caller":"traceutil/trace.go:171","msg":"trace[1622840802] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"108.50412ms","start":"2026-04-13T21:02:15.368394Z","end":"2026-04-13T21:02:15.476898Z","steps":["trace[1622840802] 'process raft request' (duration: 108.266258ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:02:23.935685Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185609651172489,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T21:02:24.304053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.673926031s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:02:24.304112Z","caller":"traceutil/trace.go:171","msg":"trace[194855184] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:758; }","duration":"1.674041042s","start":"2026-04-13T21:02:22.630057Z","end":"2026-04-13T21:02:24.304098Z","steps":["trace[194855184] 'range keys from in-memory index tree' (duration: 1.673847019s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:02:24.30414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:02:22.630039Z","time spent":"1.674096663s","remote":"127.0.0.1:51936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-13T21:02:24.304234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.56819714s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-13T21:02:24.304284Z","caller":"traceutil/trace.go:171","msg":"trace[1450475059] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:758; }","duration":"2.56825577s","start":"2026-04-13T21:02:21.736015Z","end":"2026-04-13T21:02:24.304271Z","steps":["trace[1450475059] 'range keys from in-memory index tree' (duration: 2.568032196s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:02:24.304263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.460594452s","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-04-13T21:02:24.304313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.56826028s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-13T21:02:24.304316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:02:21.736013Z","time spent":"2.568295841s","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-13T21:02:24.304345Z","caller":"traceutil/trace.go:171","msg":"trace[669438559] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:758; }","duration":"1.460717373s","start":"2026-04-13T21:02:22.843606Z","end":"2026-04-13T21:02:24.304323Z","steps":["trace[669438559] 'count revisions from in-memory index tree' (duration: 1.46054652s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:02:24.30442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:02:22.843591Z","time spent":"1.460816785s","remote":"127.0.0.1:52406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":31,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-04-13T21:02:24.304493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.229091442s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.250\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-13T21:02:24.304509Z","caller":"traceutil/trace.go:171","msg":"trace[458487974] range","detail":"{range_begin:/registry/masterleases/199.204.45.250; range_end:; response_count:1; response_revision:758; }","duration":"2.229142213s","start":"2026-04-13T21:02:22.075361Z","end":"2026-04-13T21:02:24.304504Z","steps":["trace[458487974] 'range keys from in-memory index tree' (duration: 2.22897707s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:02:24.304526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:02:22.075339Z","time spent":"2.229184734s","remote":"127.0.0.1:51982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.204.45.250\" "} {"level":"warn","ts":"2026-04-13T21:02:24.304699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.101618438s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-59lbx\" ","response":"range_response_count:1 size:3965"} {"level":"warn","ts":"2026-04-13T21:02:24.304801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.568809368s","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-04-13T21:02:24.304815Z","caller":"traceutil/trace.go:171","msg":"trace[163328255] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-59lbx; range_end:; response_count:1; response_revision:758; }","duration":"4.101804041s","start":"2026-04-13T21:02:20.202981Z","end":"2026-04-13T21:02:24.304785Z","steps":["trace[163328255] 'range keys from in-memory index tree' (duration: 4.101349354s)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:02:24.30484Z","caller":"traceutil/trace.go:171","msg":"trace[975676987] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:758; }","duration":"2.568852768s","start":"2026-04-13T21:02:21.735976Z","end":"2026-04-13T21:02:24.304829Z","steps":["trace[975676987] 'range keys from in-memory index tree' (duration: 2.568742787s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:02:24.304887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.568846339s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-13T21:02:24.304901Z","caller":"traceutil/trace.go:171","msg":"trace[1477164602] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:758; }","duration":"2.568862799s","start":"2026-04-13T21:02:21.736033Z","end":"2026-04-13T21:02:24.304896Z","steps":["trace[1477164602] 'range keys from in-memory index tree' (duration: 2.568794838s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:02:24.304883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:02:20.202955Z","time spent":"4.101908323s","remote":"127.0.0.1:52172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3989,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-59lbx\" "} {"level":"warn","ts":"2026-04-13T21:02:24.304915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:02:21.736031Z","time spent":"2.568881199s","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-13T21:02:24.305123Z","caller":"traceutil/trace.go:171","msg":"trace[1895638394] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:758; }","duration":"2.568280831s","start":"2026-04-13T21:02:21.736043Z","end":"2026-04-13T21:02:24.304324Z","steps":["trace[1895638394] 'range keys from in-memory index tree' (duration: 2.568207809s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:02:24.305178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:02:21.736041Z","time spent":"2.569124833s","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-13T21:02:24.304885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:02:21.735973Z","time spent":"2.568897249s","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-13T21:02:24.305675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.676524128s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:02:24.305718Z","caller":"traceutil/trace.go:171","msg":"trace[679517580] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:758; }","duration":"3.676604679s","start":"2026-04-13T21:02:20.6291Z","end":"2026-04-13T21:02:24.305705Z","steps":["trace[679517580] 'range keys from in-memory index tree' (duration: 3.676457217s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:02:24.305747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:02:20.62908Z","time spent":"3.676659979s","remote":"127.0.0.1:51940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-13T21:02:24.30485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.568920579s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-13T21:02:24.305788Z","caller":"traceutil/trace.go:171","msg":"trace[972381265] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:758; }","duration":"2.569865913s","start":"2026-04-13T21:02:21.735906Z","end":"2026-04-13T21:02:24.305772Z","steps":["trace[972381265] 'range keys from in-memory index tree' (duration: 2.568772817s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:02:24.30585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:02:21.735894Z","time spent":"2.569944985s","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-13T21:02:24.350692Z","caller":"traceutil/trace.go:171","msg":"trace[197950935] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"969.432993ms","start":"2026-04-13T21:02:23.381235Z","end":"2026-04-13T21:02:24.350668Z","steps":["trace[197950935] 'process raft request' (duration: 969.278141ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:02:24.350899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:02:23.381209Z","time spent":"969.563185ms","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:02:24.351148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"916.394808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-13T21:02:24.351223Z","caller":"traceutil/trace.go:171","msg":"trace[2038368209] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:759; }","duration":"916.560421ms","start":"2026-04-13T21:02:23.43465Z","end":"2026-04-13T21:02:24.35121Z","steps":["trace[2038368209] 'agreement among raft nodes before linearized reading' (duration: 916.166695ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:02:24.351272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:02:23.434627Z","time spent":"916.629591ms","remote":"127.0.0.1:52004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":31,"response size":31,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"info","ts":"2026-04-13T21:02:24.350751Z","caller":"traceutil/trace.go:171","msg":"trace[1028550157] linearizableReadLoop","detail":"{readStateIndex:791; appliedIndex:790; }","duration":"915.948182ms","start":"2026-04-13T21:02:23.434727Z","end":"2026-04-13T21:02:24.350675Z","steps":["trace[1028550157] 'read index received' (duration: 915.862191ms)","trace[1028550157] 'applied index is now lower than readState.Index' (duration: 83.761µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:02:24.484191Z","caller":"traceutil/trace.go:171","msg":"trace[1696264222] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"169.121689ms","start":"2026-04-13T21:02:24.315044Z","end":"2026-04-13T21:02:24.484166Z","steps":["trace[1696264222] 'process raft request' (duration: 169.068138ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:02:24.484584Z","caller":"traceutil/trace.go:171","msg":"trace[49717432] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"169.297261ms","start":"2026-04-13T21:02:24.315263Z","end":"2026-04-13T21:02:24.484561Z","steps":["trace[49717432] 'process raft request' (duration: 168.874925ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:02:24.484898Z","caller":"traceutil/trace.go:171","msg":"trace[2051477293] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"169.047987ms","start":"2026-04-13T21:02:24.31584Z","end":"2026-04-13T21:02:24.484888Z","steps":["trace[2051477293] 'process raft request' (duration: 168.612481ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:02:24.484934Z","caller":"traceutil/trace.go:171","msg":"trace[1676040002] linearizableReadLoop","detail":"{readStateIndex:799; appliedIndex:791; }","duration":"133.401179ms","start":"2026-04-13T21:02:24.351512Z","end":"2026-04-13T21:02:24.484913Z","steps":["trace[1676040002] 'read index received' (duration: 132.06033ms)","trace[1676040002] 'applied index is now lower than readState.Index' (duration: 1.339209ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:02:24.485Z","caller":"traceutil/trace.go:171","msg":"trace[2060956251] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"171.435372ms","start":"2026-04-13T21:02:24.313504Z","end":"2026-04-13T21:02:24.484939Z","steps":["trace[2060956251] 'process raft request' (duration: 170.488228ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:02:24.485176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.698664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-13T21:02:24.485245Z","caller":"traceutil/trace.go:171","msg":"trace[407789769] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"168.128184ms","start":"2026-04-13T21:02:24.317103Z","end":"2026-04-13T21:02:24.485231Z","steps":["trace[407789769] 'process raft request' (duration: 167.579346ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:02:24.485286Z","caller":"traceutil/trace.go:171","msg":"trace[622386530] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:765; }","duration":"498.870566ms","start":"2026-04-13T21:02:23.986392Z","end":"2026-04-13T21:02:24.485263Z","steps":["trace[622386530] 'agreement among raft nodes before linearized reading' (duration: 498.585502ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:02:24.485354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.235624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:02:24.485386Z","caller":"traceutil/trace.go:171","msg":"trace[693437565] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:765; }","duration":"170.306086ms","start":"2026-04-13T21:02:24.315072Z","end":"2026-04-13T21:02:24.485378Z","steps":["trace[693437565] 'agreement among raft nodes before linearized reading' (duration: 170.240905ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:02:24.485399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:02:23.986365Z","time spent":"498.990708ms","remote":"127.0.0.1:52344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":52,"response size":31,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"info","ts":"2026-04-13T21:02:24.484282Z","caller":"traceutil/trace.go:171","msg":"trace[254968248] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"170.099403ms","start":"2026-04-13T21:02:24.314139Z","end":"2026-04-13T21:02:24.484239Z","steps":["trace[254968248] 'process raft request' (duration: 169.945701ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:09.23462Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185609651173086,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-13T21:03:09.309968Z","caller":"traceutil/trace.go:171","msg":"trace[1971432691] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"576.103983ms","start":"2026-04-13T21:03:08.733833Z","end":"2026-04-13T21:03:09.309937Z","steps":["trace[1971432691] 'process raft request' (duration: 575.911309ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:09.310139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:08.733817Z","time spent":"576.222696ms","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T21:03:09.312394Z","caller":"traceutil/trace.go:171","msg":"trace[1323171259] linearizableReadLoop","detail":"{readStateIndex:1083; appliedIndex:1081; }","duration":"578.46445ms","start":"2026-04-13T21:03:08.733902Z","end":"2026-04-13T21:03:09.312366Z","steps":["trace[1323171259] 'read index received' (duration: 575.838406ms)","trace[1323171259] 'applied index is now lower than readState.Index' (duration: 2.625114ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:03:09.312614Z","caller":"traceutil/trace.go:171","msg":"trace[900031358] transaction","detail":"{read_only:false; response_revision:1039; number_of_response:1; }","duration":"245.584573ms","start":"2026-04-13T21:03:09.067016Z","end":"2026-04-13T21:03:09.3126Z","steps":["trace[900031358] 'process raft request' (duration: 245.087861ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:09.312806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.920368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-13T21:03:09.312877Z","caller":"traceutil/trace.go:171","msg":"trace[40677784] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1039; }","duration":"576.024361ms","start":"2026-04-13T21:03:08.736838Z","end":"2026-04-13T21:03:09.312863Z","steps":["trace[40677784] 'agreement among raft nodes before linearized reading' (duration: 575.815886ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:09.312923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:08.73683Z","time spent":"576.084213ms","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-13T21:03:09.312946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.956492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/kubeadm-config\" ","response":"range_response_count:1 size:1084"} {"level":"info","ts":"2026-04-13T21:03:09.313033Z","caller":"traceutil/trace.go:171","msg":"trace[1262362534] range","detail":"{range_begin:/registry/configmaps/kube-system/kubeadm-config; range_end:; response_count:1; response_revision:1039; }","duration":"415.102705ms","start":"2026-04-13T21:03:08.897905Z","end":"2026-04-13T21:03:09.313008Z","steps":["trace[1262362534] 'agreement among raft nodes before linearized reading' (duration: 414.937091ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:09.313087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:08.897878Z","time spent":"415.201018ms","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":1108,"request content":"key:\"/registry/configmaps/kube-system/kubeadm-config\" "} {"level":"warn","ts":"2026-04-13T21:03:09.313182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.382245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-13T21:03:09.313244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.980268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-13T21:03:09.313335Z","caller":"traceutil/trace.go:171","msg":"trace[104196346] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1039; }","duration":"568.195902ms","start":"2026-04-13T21:03:08.745119Z","end":"2026-04-13T21:03:09.313315Z","steps":["trace[104196346] 'agreement among raft nodes before linearized reading' (duration: 567.753322ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:03:09.313274Z","caller":"traceutil/trace.go:171","msg":"trace[47157532] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1039; }","duration":"570.535069ms","start":"2026-04-13T21:03:08.742719Z","end":"2026-04-13T21:03:09.313254Z","steps":["trace[47157532] 'agreement among raft nodes before linearized reading' (duration: 570.245522ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:09.313383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:08.745078Z","time spent":"568.295575ms","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-13T21:03:09.313507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:08.7427Z","time spent":"570.717354ms","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-13T21:03:09.315009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"581.092753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-13T21:03:09.315076Z","caller":"traceutil/trace.go:171","msg":"trace[227023223] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1039; }","duration":"581.164405ms","start":"2026-04-13T21:03:08.733898Z","end":"2026-04-13T21:03:09.315062Z","steps":["trace[227023223] 'agreement among raft nodes before linearized reading' (duration: 581.017002ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:09.315171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:08.733859Z","time spent":"581.287158ms","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-13T21:03:15.83903Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185609651173143,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T21:03:16.339863Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185609651173143,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T21:03:16.840661Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185609651173143,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T21:03:17.341767Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185609651173143,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T21:03:17.630805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000732662s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-13T21:03:17.630956Z","caller":"traceutil/trace.go:171","msg":"trace[1293340419] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000942507s","start":"2026-04-13T21:03:15.629992Z","end":"2026-04-13T21:03:17.630935Z","steps":["trace[1293340419] 'agreement among raft nodes before linearized reading' (duration: 2.000761552s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:17.631168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:15.629971Z","time spent":"2.001112902s","remote":"127.0.0.1:51940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-13T21:03:17.841929Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185609651173143,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T21:03:18.022017Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.686885721s","expected-duration":"1s"} {"level":"info","ts":"2026-04-13T21:03:18.022468Z","caller":"traceutil/trace.go:171","msg":"trace[1626015369] transaction","detail":"{read_only:false; response_revision:1057; number_of_response:1; }","duration":"2.687436225s","start":"2026-04-13T21:03:15.335002Z","end":"2026-04-13T21:03:18.022438Z","steps":["trace[1626015369] 'process raft request' (duration: 2.687289011s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:18.022626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:15.334966Z","time spent":"2.687577288s","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T21:03:18.121813Z","caller":"traceutil/trace.go:171","msg":"trace[1467652987] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"1.41699412s","start":"2026-04-13T21:03:16.704789Z","end":"2026-04-13T21:03:18.121783Z","steps":["trace[1467652987] 'process raft request' (duration: 1.416870797s)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:03:18.121873Z","caller":"traceutil/trace.go:171","msg":"trace[796238213] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"2.688704836s","start":"2026-04-13T21:03:15.433087Z","end":"2026-04-13T21:03:18.121792Z","steps":["trace[796238213] 'process raft request' (duration: 2.679295796s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:18.121996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:16.704763Z","time spent":"1.417142714s","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:03:18.122214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:15.433067Z","time spent":"2.688941802s","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T21:03:18.15804Z","caller":"traceutil/trace.go:171","msg":"trace[153149844] linearizableReadLoop","detail":"{readStateIndex:1105; appliedIndex:1101; }","duration":"2.819388839s","start":"2026-04-13T21:03:15.338621Z","end":"2026-04-13T21:03:18.15801Z","steps":["trace[153149844] 'read index received' (duration: 2.68367227s)","trace[153149844] 'applied index is now lower than readState.Index' (duration: 135.715139ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:03:18.158224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.108819397s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-13T21:03:18.15827Z","caller":"traceutil/trace.go:171","msg":"trace[467253202] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1059; }","duration":"2.10893761s","start":"2026-04-13T21:03:16.049318Z","end":"2026-04-13T21:03:18.158255Z","steps":["trace[467253202] 'agreement among raft nodes before linearized reading' (duration: 2.108840868s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:18.158285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.819663716s","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-04-13T21:03:18.158276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"989.154017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:03:18.158317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:16.049297Z","time spent":"2.109006212s","remote":"127.0.0.1:52358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":31,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"info","ts":"2026-04-13T21:03:18.158336Z","caller":"traceutil/trace.go:171","msg":"trace[1256750895] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1059; }","duration":"2.819753219s","start":"2026-04-13T21:03:15.338568Z","end":"2026-04-13T21:03:18.158322Z","steps":["trace[1256750895] 'agreement among raft nodes before linearized reading' (duration: 2.819579794s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:18.15837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:15.338553Z","time spent":"2.81980956s","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-13T21:03:18.158375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.799798768s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-13T21:03:18.158382Z","caller":"traceutil/trace.go:171","msg":"trace[15436195] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1059; }","duration":"989.27287ms","start":"2026-04-13T21:03:17.169062Z","end":"2026-04-13T21:03:18.158335Z","steps":["trace[15436195] 'agreement among raft nodes before linearized reading' (duration: 989.148707ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:03:18.158415Z","caller":"traceutil/trace.go:171","msg":"trace[1554094330] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1059; }","duration":"2.799846629s","start":"2026-04-13T21:03:15.358557Z","end":"2026-04-13T21:03:18.158404Z","steps":["trace[1554094330] 'agreement among raft nodes before linearized reading' (duration: 2.799760037s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:18.158426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:17.169048Z","time spent":"989.367252ms","remote":"127.0.0.1:51940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-13T21:03:18.158444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:15.35855Z","time spent":"2.799887291s","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-13T21:03:18.158469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.060859076s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:03:18.158542Z","caller":"traceutil/trace.go:171","msg":"trace[746022556] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1059; }","duration":"1.060945718s","start":"2026-04-13T21:03:17.097578Z","end":"2026-04-13T21:03:18.158524Z","steps":["trace[746022556] 'agreement among raft nodes before linearized reading' (duration: 1.060814245s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:18.158552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.801993782s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-13T21:03:18.158577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.802377043s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-13T21:03:18.158586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:17.097529Z","time spent":"1.06104724s","remote":"127.0.0.1:51170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-13T21:03:18.158607Z","caller":"traceutil/trace.go:171","msg":"trace[1660145929] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1059; }","duration":"2.802438425s","start":"2026-04-13T21:03:15.35616Z","end":"2026-04-13T21:03:18.158599Z","steps":["trace[1660145929] 'agreement among raft nodes before linearized reading' (duration: 2.802363853s)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:03:18.158614Z","caller":"traceutil/trace.go:171","msg":"trace[1892089430] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1059; }","duration":"2.802081405s","start":"2026-04-13T21:03:15.356515Z","end":"2026-04-13T21:03:18.158596Z","steps":["trace[1892089430] 'agreement among raft nodes before linearized reading' (duration: 2.80190143s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:18.158638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:15.356148Z","time spent":"2.802473865s","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-13T21:03:18.158291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.808060286s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-13T21:03:18.158666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:15.3565Z","time spent":"2.802154346s","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-13T21:03:18.158674Z","caller":"traceutil/trace.go:171","msg":"trace[182008182] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1059; }","duration":"2.808474275s","start":"2026-04-13T21:03:15.350189Z","end":"2026-04-13T21:03:18.158663Z","steps":["trace[182008182] 'agreement among raft nodes before linearized reading' (duration: 2.807971693s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:18.158708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:15.350173Z","time spent":"2.808526057s","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-13T21:03:18.158363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.477547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:03:18.159066Z","caller":"traceutil/trace.go:171","msg":"trace[879622867] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1059; }","duration":"527.189965ms","start":"2026-04-13T21:03:17.631842Z","end":"2026-04-13T21:03:18.159032Z","steps":["trace[879622867] 'agreement among raft nodes before linearized reading' (duration: 526.469996ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:18.159275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:17.631827Z","time spent":"527.431861ms","remote":"127.0.0.1:51936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-13T21:03:18.294368Z","caller":"traceutil/trace.go:171","msg":"trace[1735674625] transaction","detail":"{read_only:false; response_revision:1062; number_of_response:1; }","duration":"131.209393ms","start":"2026-04-13T21:03:18.163136Z","end":"2026-04-13T21:03:18.294345Z","steps":["trace[1735674625] 'process raft request' (duration: 131.130591ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:03:18.294437Z","caller":"traceutil/trace.go:171","msg":"trace[250139693] transaction","detail":"{read_only:false; response_revision:1061; number_of_response:1; }","duration":"131.645355ms","start":"2026-04-13T21:03:18.162756Z","end":"2026-04-13T21:03:18.294402Z","steps":["trace[250139693] 'process raft request' (duration: 129.783958ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:03:18.294574Z","caller":"traceutil/trace.go:171","msg":"trace[403704572] transaction","detail":"{read_only:false; response_revision:1063; number_of_response:1; }","duration":"131.360858ms","start":"2026-04-13T21:03:18.163199Z","end":"2026-04-13T21:03:18.29456Z","steps":["trace[403704572] 'process raft request' (duration: 131.106761ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:03:18.294582Z","caller":"traceutil/trace.go:171","msg":"trace[1322743505] transaction","detail":"{read_only:false; response_revision:1064; number_of_response:1; }","duration":"130.941216ms","start":"2026-04-13T21:03:18.163619Z","end":"2026-04-13T21:03:18.294561Z","steps":["trace[1322743505] 'process raft request' (duration: 130.856764ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:03:18.303042Z","caller":"traceutil/trace.go:171","msg":"trace[18547185] transaction","detail":"{read_only:false; response_revision:1065; number_of_response:1; }","duration":"116.574149ms","start":"2026-04-13T21:03:18.186447Z","end":"2026-04-13T21:03:18.303021Z","steps":["trace[18547185] 'process raft request' (duration: 116.478517ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:03:44.773753Z","caller":"traceutil/trace.go:171","msg":"trace[353910873] linearizableReadLoop","detail":"{readStateIndex:1196; appliedIndex:1195; }","duration":"392.051386ms","start":"2026-04-13T21:03:44.381669Z","end":"2026-04-13T21:03:44.773721Z","steps":["trace[353910873] 'read index received' (duration: 391.938392ms)","trace[353910873] 'applied index is now lower than readState.Index' (duration: 111.564µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:03:44.773864Z","caller":"traceutil/trace.go:171","msg":"trace[649164276] transaction","detail":"{read_only:false; response_revision:1145; number_of_response:1; }","duration":"629.180139ms","start":"2026-04-13T21:03:44.144651Z","end":"2026-04-13T21:03:44.773831Z","steps":["trace[649164276] 'process raft request' (duration: 628.9144ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:44.77401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.326494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-13T21:03:44.774053Z","caller":"traceutil/trace.go:171","msg":"trace[332801510] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1145; }","duration":"392.424957ms","start":"2026-04-13T21:03:44.381618Z","end":"2026-04-13T21:03:44.774043Z","steps":["trace[332801510] 'agreement among raft nodes before linearized reading' (duration: 392.273773ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:44.774032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:44.144627Z","time spent":"629.312883ms","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:03:44.774094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:44.381599Z","time spent":"392.487338ms","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-13T21:03:44.774261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.572471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-13T21:03:44.774329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.784384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-13T21:03:44.774381Z","caller":"traceutil/trace.go:171","msg":"trace[1552113230] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1145; }","duration":"258.842717ms","start":"2026-04-13T21:03:44.515525Z","end":"2026-04-13T21:03:44.774368Z","steps":["trace[1552113230] 'agreement among raft nodes before linearized reading' (duration: 258.689573ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:44.774417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.408287ms","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-04-13T21:03:44.774453Z","caller":"traceutil/trace.go:171","msg":"trace[1897906958] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1145; }","duration":"262.479889ms","start":"2026-04-13T21:03:44.511965Z","end":"2026-04-13T21:03:44.774445Z","steps":["trace[1897906958] 'agreement among raft nodes before linearized reading' (duration: 262.395707ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:44.774583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.289243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-13T21:03:44.774624Z","caller":"traceutil/trace.go:171","msg":"trace[577463264] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1145; }","duration":"268.354915ms","start":"2026-04-13T21:03:44.506259Z","end":"2026-04-13T21:03:44.774614Z","steps":["trace[577463264] 'agreement among raft nodes before linearized reading' (duration: 268.228111ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:03:44.774336Z","caller":"traceutil/trace.go:171","msg":"trace[1037734638] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1145; }","duration":"307.658563ms","start":"2026-04-13T21:03:44.466661Z","end":"2026-04-13T21:03:44.774319Z","steps":["trace[1037734638] 'agreement among raft nodes before linearized reading' (duration: 307.468278ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:44.774663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:44.466583Z","time spent":"308.072316ms","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-13T21:03:44.774632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.164968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:03:44.774779Z","caller":"traceutil/trace.go:171","msg":"trace[1235729073] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1145; }","duration":"139.340193ms","start":"2026-04-13T21:03:44.635428Z","end":"2026-04-13T21:03:44.774768Z","steps":["trace[1235729073] 'agreement among raft nodes before linearized reading' (duration: 139.183059ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:03:49.045184Z","caller":"traceutil/trace.go:171","msg":"trace[1118960794] transaction","detail":"{read_only:false; response_revision:1163; number_of_response:1; }","duration":"201.837958ms","start":"2026-04-13T21:03:48.843329Z","end":"2026-04-13T21:03:49.045167Z","steps":["trace[1118960794] 'process raft request' (duration: 201.802737ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:03:49.045428Z","caller":"traceutil/trace.go:171","msg":"trace[769246444] transaction","detail":"{read_only:false; response_revision:1162; number_of_response:1; }","duration":"203.440773ms","start":"2026-04-13T21:03:48.841978Z","end":"2026-04-13T21:03:49.045418Z","steps":["trace[769246444] 'process raft request' (duration: 203.121404ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:03:49.045173Z","caller":"traceutil/trace.go:171","msg":"trace[576144714] transaction","detail":"{read_only:false; response_revision:1160; number_of_response:1; }","duration":"203.663089ms","start":"2026-04-13T21:03:48.841482Z","end":"2026-04-13T21:03:49.045145Z","steps":["trace[576144714] 'process raft request' (duration: 203.433683ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:03:49.045338Z","caller":"traceutil/trace.go:171","msg":"trace[1244670646] transaction","detail":"{read_only:false; response_revision:1161; number_of_response:1; }","duration":"203.829623ms","start":"2026-04-13T21:03:48.841495Z","end":"2026-04-13T21:03:49.045324Z","steps":["trace[1244670646] 'process raft request' (duration: 203.565896ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:51.40804Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185609651173409,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T21:03:51.908869Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185609651173409,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T21:03:52.409443Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185609651173409,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T21:03:52.910243Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185609651173409,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T21:03:53.410578Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185609651173409,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T21:03:53.629219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000249868s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-13T21:03:53.629414Z","caller":"traceutil/trace.go:171","msg":"trace[1357819687] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000510166s","start":"2026-04-13T21:03:51.628868Z","end":"2026-04-13T21:03:53.629378Z","steps":["trace[1357819687] 'agreement among raft nodes before linearized reading' (duration: 2.000273399s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:53.629762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:51.628851Z","time spent":"2.000809025s","remote":"127.0.0.1:51940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/13 21:03:53 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-13T21:03:53.91101Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185609651173409,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T21:03:54.411728Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185609651173409,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T21:03:54.912298Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185609651173409,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T21:03:55.413228Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185609651173409,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T21:03:55.629562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999972229s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-13T21:03:55.629676Z","caller":"traceutil/trace.go:171","msg":"trace[354508187] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000153034s","start":"2026-04-13T21:03:53.629503Z","end":"2026-04-13T21:03:55.629656Z","steps":["trace[354508187] 'agreement among raft nodes before linearized reading' (duration: 2.000022671s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:55.629724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:53.629445Z","time spent":"2.000269827s","remote":"127.0.0.1:51936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/13 21:03:55 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-13T21:03:55.841016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:50.842882Z","time spent":"4.998124419s","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-04-13T21:03:55.913417Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185609651173409,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T21:03:56.049953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999999481s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-13T21:03:56.05009Z","caller":"traceutil/trace.go:171","msg":"trace[1541827235] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"5.000168266s","start":"2026-04-13T21:03:51.049877Z","end":"2026-04-13T21:03:56.050045Z","steps":["trace[1541827235] 'agreement among raft nodes before linearized reading' (duration: 5.000020351s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:56.050039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999925699s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context deadline exceeded"} {"level":"warn","ts":"2026-04-13T21:03:56.050157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:51.049862Z","time spent":"5.000281689s","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} 2026/04/13 21:03:56 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"info","ts":"2026-04-13T21:03:56.050188Z","caller":"traceutil/trace.go:171","msg":"trace[1702169034] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"5.000112363s","start":"2026-04-13T21:03:51.050029Z","end":"2026-04-13T21:03:56.050141Z","steps":["trace[1702169034] 'agreement among raft nodes before linearized reading' (duration: 4.999944839s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:56.050041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.000145934s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context canceled"} {"level":"warn","ts":"2026-04-13T21:03:56.050301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:51.050005Z","time spent":"5.000259028s","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-13T21:03:56.050278Z","caller":"traceutil/trace.go:171","msg":"trace[1154892866] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"5.000432743s","start":"2026-04-13T21:03:51.049822Z","end":"2026-04-13T21:03:56.050255Z","steps":["trace[1154892866] 'agreement among raft nodes before linearized reading' (duration: 5.000161665s)"],"step_count":1} 2026/04/13 21:03:56 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-13T21:03:56.050454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:51.049809Z","time spent":"5.000544916s","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} 2026/04/13 21:03:56 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-13T21:03:56.414618Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185609651173409,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T21:03:56.915508Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185609651173409,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T21:03:57.415884Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185609651173409,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T21:03:57.637063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000534422s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-13T21:03:57.63715Z","caller":"traceutil/trace.go:171","msg":"trace[1803177403] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000637875s","start":"2026-04-13T21:03:55.636489Z","end":"2026-04-13T21:03:57.637127Z","steps":["trace[1803177403] 'agreement among raft nodes before linearized reading' (duration: 2.000530952s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:57.637199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:55.636453Z","time spent":"2.000737318s","remote":"127.0.0.1:51940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/13 21:03:57 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-13T21:03:57.908032Z","caller":"etcdserver/v3_server.go:909","msg":"timed out waiting for read index response (local node might have slow network)","timeout":"7s"} {"level":"warn","ts":"2026-04-13T21:03:57.908261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.000321923s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-04-13T21:03:57.908317Z","caller":"traceutil/trace.go:171","msg":"trace[518287038] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; }","duration":"7.000396135s","start":"2026-04-13T21:03:50.907896Z","end":"2026-04-13T21:03:57.908292Z","steps":["trace[518287038] 'agreement among raft nodes before linearized reading' (duration: 7.000320503s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:57.90836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:50.907828Z","time spent":"7.000523089s","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-13T21:03:58.408229Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185609651173412,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T21:03:58.485876Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"7.64276264s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-13T21:03:58.710565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.733769ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-13T21:03:58.710899Z","caller":"traceutil/trace.go:171","msg":"trace[1493728116] linearizableReadLoop","detail":"{readStateIndex:1218; appliedIndex:1217; }","duration":"802.684981ms","start":"2026-04-13T21:03:57.908184Z","end":"2026-04-13T21:03:58.710869Z","steps":["trace[1493728116] 'read index received' (duration: 578.120751ms)","trace[1493728116] 'applied index is now lower than readState.Index' (duration: 224.5613ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:03:58.711165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.073801935s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:03:58.711205Z","caller":"traceutil/trace.go:171","msg":"trace[12428554] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1167; }","duration":"1.073906108s","start":"2026-04-13T21:03:57.637288Z","end":"2026-04-13T21:03:58.711194Z","steps":["trace[12428554] 'agreement among raft nodes before linearized reading' (duration: 1.073810495s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:58.711248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:57.637267Z","time spent":"1.073973081s","remote":"127.0.0.1:51936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-13T21:03:58.711267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.631169356s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.250\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:03:58.711326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.078872029s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18a606676c069d9e\" ","response":"range_response_count:1 size:774"} {"level":"info","ts":"2026-04-13T21:03:58.711367Z","caller":"traceutil/trace.go:171","msg":"trace[1823607060] range","detail":"{range_begin:/registry/masterleases/199.204.45.250; range_end:; response_count:0; response_revision:1167; }","duration":"6.631340411s","start":"2026-04-13T21:03:52.080006Z","end":"2026-04-13T21:03:58.711346Z","steps":["trace[1823607060] 'agreement among raft nodes before linearized reading' (duration: 6.631140685s)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:03:58.7114Z","caller":"traceutil/trace.go:171","msg":"trace[701048142] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18a606676c069d9e; range_end:; response_count:1; response_revision:1167; }","duration":"3.078987533s","start":"2026-04-13T21:03:55.632394Z","end":"2026-04-13T21:03:58.711381Z","steps":["trace[701048142] 'agreement among raft nodes before linearized reading' (duration: 3.078766706s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:58.711452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:52.079988Z","time spent":"6.631440434s","remote":"127.0.0.1:51982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":29,"request content":"key:\"/registry/masterleases/199.204.45.250\" "} {"level":"warn","ts":"2026-04-13T21:03:58.71145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.293037608s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-13T21:03:58.711463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:55.632375Z","time spent":"3.079074396s","remote":"127.0.0.1:52046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":798,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.18a606676c069d9e\" "} {"level":"warn","ts":"2026-04-13T21:03:58.71145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.615694886s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-13T21:03:58.711581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.921459199s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:03:58.71162Z","caller":"traceutil/trace.go:171","msg":"trace[565443608] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1167; }","duration":"6.921530551s","start":"2026-04-13T21:03:51.79008Z","end":"2026-04-13T21:03:58.711611Z","steps":["trace[565443608] 'agreement among raft nodes before linearized reading' (duration: 6.92147763s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:58.711658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:51.790059Z","time spent":"6.921589283s","remote":"127.0.0.1:51074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-13T21:03:58.711646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.161529774s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:03:58.711753Z","caller":"traceutil/trace.go:171","msg":"trace[2136122378] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1167; }","duration":"3.161646057s","start":"2026-04-13T21:03:55.550063Z","end":"2026-04-13T21:03:58.711709Z","steps":["trace[2136122378] 'agreement among raft nodes before linearized reading' (duration: 3.161541344s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:58.711777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.54266975s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:03:58.711803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:55.550041Z","time spent":"3.16174665s","remote":"127.0.0.1:51110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-04-13T21:03:58.711835Z","caller":"traceutil/trace.go:171","msg":"trace[1764891485] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1167; }","duration":"1.542762482s","start":"2026-04-13T21:03:57.169057Z","end":"2026-04-13T21:03:58.71182Z","steps":["trace[1764891485] 'agreement among raft nodes before linearized reading' (duration: 1.54267961s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:58.711883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:57.169035Z","time spent":"1.542837085s","remote":"127.0.0.1:51940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-13T21:03:58.711861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.964668297s","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":"info","ts":"2026-04-13T21:03:58.711958Z","caller":"traceutil/trace.go:171","msg":"trace[1860002948] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:1167; }","duration":"5.96478884s","start":"2026-04-13T21:03:52.747161Z","end":"2026-04-13T21:03:58.711949Z","steps":["trace[1860002948] 'agreement among raft nodes before linearized reading' (duration: 5.964615615s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:58.712004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:52.74714Z","time spent":"5.964854271s","remote":"127.0.0.1:51128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-13T21:03:58.712057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.661539008s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-13T21:03:58.712109Z","caller":"traceutil/trace.go:171","msg":"trace[1812935413] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1167; }","duration":"7.661680541s","start":"2026-04-13T21:03:51.050416Z","end":"2026-04-13T21:03:58.712097Z","steps":["trace[1812935413] 'agreement among raft nodes before linearized reading' (duration: 7.661242059s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:58.712119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.856200233s","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":"info","ts":"2026-04-13T21:03:58.712181Z","caller":"traceutil/trace.go:171","msg":"trace[678605332] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1167; }","duration":"2.856294975s","start":"2026-04-13T21:03:55.855869Z","end":"2026-04-13T21:03:58.712164Z","steps":["trace[678605332] 'agreement among raft nodes before linearized reading' (duration: 2.856206203s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:58.712195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.477239023s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:03:58.712237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:55.855852Z","time spent":"2.856367278s","remote":"127.0.0.1:40782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-13T21:03:58.712204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:51.050397Z","time spent":"7.661734843s","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-13T21:03:58.712259Z","caller":"traceutil/trace.go:171","msg":"trace[219214157] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1167; }","duration":"6.477344296s","start":"2026-04-13T21:03:52.234907Z","end":"2026-04-13T21:03:58.712251Z","steps":["trace[219214157] 'agreement among raft nodes before linearized reading' (duration: 6.477245703s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:58.712274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.008899667s","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":"warn","ts":"2026-04-13T21:03:58.712321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:52.234885Z","time spent":"6.477428078s","remote":"127.0.0.1:51070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-04-13T21:03:58.7124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.213169039s","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-04-13T21:03:58.712432Z","caller":"traceutil/trace.go:171","msg":"trace[874388748] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1167; }","duration":"7.213237741s","start":"2026-04-13T21:03:51.499186Z","end":"2026-04-13T21:03:58.712424Z","steps":["trace[874388748] 'agreement among raft nodes before linearized reading' (duration: 7.213185909s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:58.712462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:51.499166Z","time spent":"7.213287822s","remote":"127.0.0.1:40762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":4,"response size":31,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"info","ts":"2026-04-13T21:03:58.712353Z","caller":"traceutil/trace.go:171","msg":"trace[611528302] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1167; }","duration":"7.00900182s","start":"2026-04-13T21:03:51.703338Z","end":"2026-04-13T21:03:58.71234Z","steps":["trace[611528302] 'agreement among raft nodes before linearized reading' (duration: 7.008898107s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:58.712586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:51.703327Z","time spent":"7.009247967s","remote":"127.0.0.1:51202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-04-13T21:03:58.711578Z","caller":"traceutil/trace.go:171","msg":"trace[1434911679] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1167; }","duration":"5.61583043s","start":"2026-04-13T21:03:53.095732Z","end":"2026-04-13T21:03:58.711563Z","steps":["trace[1434911679] 'agreement among raft nodes before linearized reading' (duration: 5.615621374s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:58.712541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.651356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-13T21:03:58.712654Z","caller":"traceutil/trace.go:171","msg":"trace[811027297] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1167; }","duration":"660.81109ms","start":"2026-04-13T21:03:58.051835Z","end":"2026-04-13T21:03:58.712646Z","steps":["trace[811027297] 'agreement among raft nodes before linearized reading' (duration: 660.619535ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:03:58.71153Z","caller":"traceutil/trace.go:171","msg":"trace[1574266747] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1167; }","duration":"7.293166181s","start":"2026-04-13T21:03:51.418346Z","end":"2026-04-13T21:03:58.711512Z","steps":["trace[1574266747] 'agreement among raft nodes before linearized reading' (duration: 7.293033008s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:58.712702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:58.051812Z","time spent":"660.880763ms","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-13T21:03:58.712744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:51.418328Z","time spent":"7.294391887s","remote":"127.0.0.1:52004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":31,"response size":31,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"warn","ts":"2026-04-13T21:03:58.712803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.763199ms","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-04-13T21:03:58.712845Z","caller":"traceutil/trace.go:171","msg":"trace[58664605] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1167; }","duration":"659.818781ms","start":"2026-04-13T21:03:58.053014Z","end":"2026-04-13T21:03:58.712833Z","steps":["trace[58664605] 'agreement among raft nodes before linearized reading' (duration: 659.739238ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:58.712881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:58.053003Z","time spent":"659.870692ms","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-13T21:03:58.712529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.870105447s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:550"} {"level":"warn","ts":"2026-04-13T21:03:58.712733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.803452447s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329944"} {"level":"warn","ts":"2026-04-13T21:03:58.713116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.110369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-13T21:03:58.713164Z","caller":"traceutil/trace.go:171","msg":"trace[1287295881] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1167; }","duration":"660.240723ms","start":"2026-04-13T21:03:58.052912Z","end":"2026-04-13T21:03:58.713153Z","steps":["trace[1287295881] 'agreement among raft nodes before linearized reading' (duration: 660.047717ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:58.713187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:53.095672Z","time spent":"5.617496038s","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":8,"response size":31,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"info","ts":"2026-04-13T21:03:58.713164Z","caller":"traceutil/trace.go:171","msg":"trace[2120374894] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:1167; }","duration":"7.803877159s","start":"2026-04-13T21:03:50.909273Z","end":"2026-04-13T21:03:58.71315Z","steps":["trace[2120374894] 'agreement among raft nodes before linearized reading' (duration: 7.803294522s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:58.713316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:50.909262Z","time spent":"7.804037153s","remote":"127.0.0.1:52064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":4,"response size":329968,"request content":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" "} {"level":"info","ts":"2026-04-13T21:03:58.713058Z","caller":"traceutil/trace.go:171","msg":"trace[1425326807] range","detail":"{range_begin:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:1167; }","duration":"2.870676803s","start":"2026-04-13T21:03:55.842373Z","end":"2026-04-13T21:03:58.71305Z","steps":["trace[1425326807] 'agreement among raft nodes before linearized reading' (duration: 2.870056955s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:58.713402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:55.842355Z","time spent":"2.871037665s","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":574,"request content":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" "} {"level":"warn","ts":"2026-04-13T21:03:58.713237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:58.052894Z","time spent":"660.300215ms","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-13T21:03:58.829114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.669195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:03:58.829144Z","caller":"traceutil/trace.go:171","msg":"trace[1442158583] transaction","detail":"{read_only:false; response_revision:1172; number_of_response:1; }","duration":"103.686767ms","start":"2026-04-13T21:03:58.725376Z","end":"2026-04-13T21:03:58.829063Z","steps":["trace[1442158583] 'process raft request' (duration: 103.453641ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:03:58.829223Z","caller":"traceutil/trace.go:171","msg":"trace[1101225132] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1172; }","duration":"107.800159ms","start":"2026-04-13T21:03:58.721397Z","end":"2026-04-13T21:03:58.829197Z","steps":["trace[1101225132] 'agreement among raft nodes before linearized reading' (duration: 107.606604ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:03:59.119361Z","caller":"traceutil/trace.go:171","msg":"trace[1884719518] transaction","detail":"{read_only:false; response_revision:1174; number_of_response:1; }","duration":"253.014721ms","start":"2026-04-13T21:03:58.866291Z","end":"2026-04-13T21:03:59.119306Z","steps":["trace[1884719518] 'process raft request' (duration: 208.928137ms)","trace[1884719518] 'compare' (duration: 43.765274ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:04:04.970619Z","caller":"traceutil/trace.go:171","msg":"trace[1783676385] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"128.076164ms","start":"2026-04-13T21:04:04.842515Z","end":"2026-04-13T21:04:04.970591Z","steps":["trace[1783676385] 'process raft request' (duration: 94.119385ms)","trace[1783676385] 'compare' (duration: 33.701751ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:04:04.970991Z","caller":"traceutil/trace.go:171","msg":"trace[488690406] transaction","detail":"{read_only:false; response_revision:1194; number_of_response:1; }","duration":"128.160675ms","start":"2026-04-13T21:04:04.842811Z","end":"2026-04-13T21:04:04.970972Z","steps":["trace[488690406] 'process raft request' (duration: 128.106463ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:04:04.971157Z","caller":"traceutil/trace.go:171","msg":"trace[1010242204] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"128.590219ms","start":"2026-04-13T21:04:04.842551Z","end":"2026-04-13T21:04:04.971141Z","steps":["trace[1010242204] 'process raft request' (duration: 127.917199ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:04:07.14796Z","caller":"traceutil/trace.go:171","msg":"trace[1675831873] transaction","detail":"{read_only:false; response_revision:1198; number_of_response:1; }","duration":"170.931474ms","start":"2026-04-13T21:04:06.976999Z","end":"2026-04-13T21:04:07.14793Z","steps":["trace[1675831873] 'process raft request' (duration: 150.257787ms)","trace[1675831873] 'compare' (duration: 20.543123ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:04:07.167777Z","caller":"traceutil/trace.go:171","msg":"trace[1190100152] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"189.54202ms","start":"2026-04-13T21:04:06.97822Z","end":"2026-04-13T21:04:07.167762Z","steps":["trace[1190100152] 'process raft request' (duration: 189.431646ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:04:07.167717Z","caller":"traceutil/trace.go:171","msg":"trace[1859861603] transaction","detail":"{read_only:false; response_revision:1199; number_of_response:1; }","duration":"189.707925ms","start":"2026-04-13T21:04:06.977992Z","end":"2026-04-13T21:04:07.1677Z","steps":["trace[1859861603] 'process raft request' (duration: 189.578611ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:04:12.262142Z","caller":"traceutil/trace.go:171","msg":"trace[1792678572] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"105.651727ms","start":"2026-04-13T21:04:12.156454Z","end":"2026-04-13T21:04:12.262106Z","steps":["trace[1792678572] 'process raft request' (duration: 55.259097ms)","trace[1792678572] 'compare' (duration: 50.256946ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:04:13.329968Z","caller":"traceutil/trace.go:171","msg":"trace[1124859266] transaction","detail":"{read_only:false; response_revision:1230; number_of_response:1; }","duration":"107.234889ms","start":"2026-04-13T21:04:13.222698Z","end":"2026-04-13T21:04:13.329933Z","steps":["trace[1124859266] 'process raft request' (duration: 35.379968ms)","trace[1124859266] 'compare' (duration: 71.537822ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:04:13.496173Z","caller":"traceutil/trace.go:171","msg":"trace[1723960662] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"159.966503ms","start":"2026-04-13T21:04:13.336169Z","end":"2026-04-13T21:04:13.496135Z","steps":["trace[1723960662] 'process raft request' (duration: 142.198447ms)","trace[1723960662] 'compare' (duration: 17.626672ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:04:15.243794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.676907ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T21:04:15.244102Z","caller":"traceutil/trace.go:171","msg":"trace[380283071] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"170.717886ms","start":"2026-04-13T21:04:15.073347Z","end":"2026-04-13T21:04:15.244064Z","steps":["trace[380283071] 'process raft request' (duration: 55.648067ms)","trace[380283071] 'compare' (duration: 114.566344ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:04:15.634028Z","caller":"traceutil/trace.go:171","msg":"trace[1406114396] linearizableReadLoop","detail":"{readStateIndex:1297; appliedIndex:1296; }","duration":"132.500628ms","start":"2026-04-13T21:04:15.501505Z","end":"2026-04-13T21:04:15.634006Z","steps":["trace[1406114396] 'read index received' (duration: 132.281042ms)","trace[1406114396] 'applied index is now lower than readState.Index' (duration: 218.716µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:04:15.634116Z","caller":"traceutil/trace.go:171","msg":"trace[865625180] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"296.208041ms","start":"2026-04-13T21:04:15.337876Z","end":"2026-04-13T21:04:15.634084Z","steps":["trace[865625180] 'process raft request' (duration: 295.982815ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:15.63419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.663193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-13T21:04:15.634232Z","caller":"traceutil/trace.go:171","msg":"trace[1890341297] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1240; }","duration":"132.746776ms","start":"2026-04-13T21:04:15.501474Z","end":"2026-04-13T21:04:15.634221Z","steps":["trace[1890341297] 'agreement among raft nodes before linearized reading' (duration: 132.614752ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:04:15.758047Z","caller":"traceutil/trace.go:171","msg":"trace[1729179639] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"120.140213ms","start":"2026-04-13T21:04:15.637883Z","end":"2026-04-13T21:04:15.758024Z","steps":["trace[1729179639] 'process raft request' (duration: 59.399681ms)","trace[1729179639] 'compare' (duration: 60.544526ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:04:21.666513Z","caller":"traceutil/trace.go:171","msg":"trace[1256400866] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"139.336667ms","start":"2026-04-13T21:04:21.527132Z","end":"2026-04-13T21:04:21.666469Z","steps":["trace[1256400866] 'process raft request' (duration: 88.008456ms)","trace[1256400866] 'compare' (duration: 51.127425ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:04:21.681087Z","caller":"traceutil/trace.go:171","msg":"trace[235430422] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"149.674772ms","start":"2026-04-13T21:04:21.531376Z","end":"2026-04-13T21:04:21.681051Z","steps":["trace[235430422] 'process raft request' (duration: 149.470046ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:30.084186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.251661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-13T21:04:30.084248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.473155ms","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-04-13T21:04:30.084284Z","caller":"traceutil/trace.go:171","msg":"trace[523707316] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1309; }","duration":"347.434966ms","start":"2026-04-13T21:04:29.736824Z","end":"2026-04-13T21:04:30.084259Z","steps":["trace[523707316] 'count revisions from in-memory index tree' (duration: 347.173619ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:04:30.084323Z","caller":"traceutil/trace.go:171","msg":"trace[1845672185] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1309; }","duration":"323.589538ms","start":"2026-04-13T21:04:29.760716Z","end":"2026-04-13T21:04:30.084305Z","steps":["trace[1845672185] 'range keys from in-memory index tree' (duration: 323.294989ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:30.084356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"635.382767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-13T21:04:30.084365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:29.760701Z","time spent":"323.65476ms","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-13T21:04:30.084373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:29.736803Z","time spent":"347.54778ms","remote":"127.0.0.1:52046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":113,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"info","ts":"2026-04-13T21:04:30.084395Z","caller":"traceutil/trace.go:171","msg":"trace[1971804981] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1309; }","duration":"635.458079ms","start":"2026-04-13T21:04:29.448924Z","end":"2026-04-13T21:04:30.084383Z","steps":["trace[1971804981] 'range keys from in-memory index tree' (duration: 635.234443ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:30.084424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:29.448903Z","time spent":"635.514431ms","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-13T21:04:30.08445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.785511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-13T21:04:30.084507Z","caller":"traceutil/trace.go:171","msg":"trace[1726283512] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1309; }","duration":"228.883754ms","start":"2026-04-13T21:04:29.855608Z","end":"2026-04-13T21:04:30.084492Z","steps":["trace[1726283512] 'range keys from in-memory index tree' (duration: 228.659547ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:30.084643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.104142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-13T21:04:30.084673Z","caller":"traceutil/trace.go:171","msg":"trace[695757741] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1309; }","duration":"588.264167ms","start":"2026-04-13T21:04:29.496399Z","end":"2026-04-13T21:04:30.084663Z","steps":["trace[695757741] 'range keys from in-memory index tree' (duration: 587.964838ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:30.084702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:29.496378Z","time spent":"588.316259ms","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-13T21:04:30.084866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.144501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:04:30.084936Z","caller":"traceutil/trace.go:171","msg":"trace[176438864] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1309; }","duration":"453.261734ms","start":"2026-04-13T21:04:29.631655Z","end":"2026-04-13T21:04:30.084917Z","steps":["trace[176438864] 'range keys from in-memory index tree' (duration: 453.056809ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:30.084973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:29.631634Z","time spent":"453.331217ms","remote":"127.0.0.1:51940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-13T21:04:30.182303Z","caller":"traceutil/trace.go:171","msg":"trace[897978854] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"160.568042ms","start":"2026-04-13T21:04:30.0217Z","end":"2026-04-13T21:04:30.182268Z","steps":["trace[897978854] 'process raft request' (duration: 160.412947ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:30.682991Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185609651173800,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T21:04:31.184092Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185609651173800,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T21:04:31.429583Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.247505364s","expected-duration":"1s"} {"level":"info","ts":"2026-04-13T21:04:31.430098Z","caller":"traceutil/trace.go:171","msg":"trace[377587881] transaction","detail":"{read_only:false; response_revision:1314; number_of_response:1; }","duration":"1.341212633s","start":"2026-04-13T21:04:30.088858Z","end":"2026-04-13T21:04:31.430071Z","steps":["trace[377587881] 'process raft request' (duration: 1.341166271s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:31.430243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:30.088849Z","time spent":"1.341322446s","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T21:04:31.430708Z","caller":"traceutil/trace.go:171","msg":"trace[1631567320] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"1.342518482s","start":"2026-04-13T21:04:30.088165Z","end":"2026-04-13T21:04:31.430684Z","steps":["trace[1631567320] 'process raft request' (duration: 1.341628025s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:31.4309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:30.088125Z","time spent":"1.342654296s","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T21:04:31.430922Z","caller":"traceutil/trace.go:171","msg":"trace[684982646] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"1.342566314s","start":"2026-04-13T21:04:30.088253Z","end":"2026-04-13T21:04:31.430819Z","steps":["trace[684982646] 'process raft request' (duration: 1.341692807s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:31.431116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:30.08824Z","time spent":"1.342748441s","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T21:04:31.430628Z","caller":"traceutil/trace.go:171","msg":"trace[1523566525] transaction","detail":"{read_only:false; response_revision:1313; number_of_response:1; }","duration":"1.341954595s","start":"2026-04-13T21:04:30.088629Z","end":"2026-04-13T21:04:31.430584Z","steps":["trace[1523566525] 'process raft request' (duration: 1.341361257s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:31.431475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:30.088607Z","time spent":"1.3427603s","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:04:31.62385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.443703218s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-13T21:04:31.624041Z","caller":"traceutil/trace.go:171","msg":"trace[1011354737] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1315; }","duration":"1.443941006s","start":"2026-04-13T21:04:30.180072Z","end":"2026-04-13T21:04:31.624013Z","steps":["trace[1011354737] 'agreement among raft nodes before linearized reading' (duration: 1.443704019s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:31.624128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:30.180058Z","time spent":"1.444038839s","remote":"127.0.0.1:52156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":31,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"info","ts":"2026-04-13T21:04:31.623923Z","caller":"traceutil/trace.go:171","msg":"trace[247431611] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"441.035739ms","start":"2026-04-13T21:04:31.182874Z","end":"2026-04-13T21:04:31.62391Z","steps":["trace[247431611] 'process raft request' (duration: 351.85416ms)","trace[247431611] 'compare' (duration: 88.89854ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:04:31.62397Z","caller":"traceutil/trace.go:171","msg":"trace[2046592231] linearizableReadLoop","detail":"{readStateIndex:1376; appliedIndex:1371; }","duration":"1.44150909s","start":"2026-04-13T21:04:30.182241Z","end":"2026-04-13T21:04:31.62375Z","steps":["trace[2046592231] 'read index received' (duration: 1.247581197s)","trace[2046592231] 'applied index is now lower than readState.Index' (duration: 193.926673ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:04:31.624511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:31.182813Z","time spent":"441.512774ms","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:04:31.624568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.377766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-13T21:04:31.624616Z","caller":"traceutil/trace.go:171","msg":"trace[2123407227] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1315; }","duration":"352.468178ms","start":"2026-04-13T21:04:31.272134Z","end":"2026-04-13T21:04:31.624603Z","steps":["trace[2123407227] 'agreement among raft nodes before linearized reading' (duration: 352.394856ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:31.62466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"737.519844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:04:31.624702Z","caller":"traceutil/trace.go:171","msg":"trace[1080122569] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1315; }","duration":"737.583936ms","start":"2026-04-13T21:04:30.887103Z","end":"2026-04-13T21:04:31.624687Z","steps":["trace[1080122569] 'agreement among raft nodes before linearized reading' (duration: 737.534734ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:31.6247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.239971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:04:31.624738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:30.887061Z","time spent":"737.669329ms","remote":"127.0.0.1:52206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":29,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-04-13T21:04:31.624658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:31.272112Z","time spent":"352.53611ms","remote":"127.0.0.1:52176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":3,"response size":31,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"info","ts":"2026-04-13T21:04:31.624765Z","caller":"traceutil/trace.go:171","msg":"trace[31286050] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1315; }","duration":"381.328274ms","start":"2026-04-13T21:04:31.243418Z","end":"2026-04-13T21:04:31.624746Z","steps":["trace[31286050] 'agreement among raft nodes before linearized reading' (duration: 381.22354ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:31.624814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:31.243409Z","time spent":"381.390446ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-13T21:04:31.624614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.199406531s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-13T21:04:31.624959Z","caller":"traceutil/trace.go:171","msg":"trace[104128195] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1315; }","duration":"1.199796753s","start":"2026-04-13T21:04:30.425152Z","end":"2026-04-13T21:04:31.624948Z","steps":["trace[104128195] 'agreement among raft nodes before linearized reading' (duration: 1.199362039s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:31.624997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:30.425133Z","time spent":"1.199852714s","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-13T21:04:32.480715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.132651ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T21:04:32.48095Z","caller":"traceutil/trace.go:171","msg":"trace[2084708637] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"325.40009ms","start":"2026-04-13T21:04:32.155527Z","end":"2026-04-13T21:04:32.480927Z","steps":["trace[2084708637] 'process raft request' (duration: 109.96288ms)","trace[2084708637] 'compare' (duration: 215.016837ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:04:32.481122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:32.155502Z","time spent":"325.584256ms","remote":"127.0.0.1:51982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:04:33.014646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.105942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-13T21:04:33.014808Z","caller":"traceutil/trace.go:171","msg":"trace[1854900447] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1317; }","duration":"126.279308ms","start":"2026-04-13T21:04:32.888462Z","end":"2026-04-13T21:04:33.014741Z","steps":["trace[1854900447] 'count revisions from in-memory index tree' (duration: 126.033981ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:33.01499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.062571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:500 ","response":"range_response_count:6 size:2185"} {"level":"info","ts":"2026-04-13T21:04:33.015104Z","caller":"traceutil/trace.go:171","msg":"trace[1899003330] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:6; response_revision:1317; }","duration":"271.236326ms","start":"2026-04-13T21:04:32.743848Z","end":"2026-04-13T21:04:33.015084Z","steps":["trace[1899003330] 'range keys from in-memory index tree' (duration: 270.624848ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:34.071538Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185609651173825,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-13T21:04:34.181425Z","caller":"traceutil/trace.go:171","msg":"trace[1170097588] transaction","detail":"{read_only:false; response_revision:1318; number_of_response:1; }","duration":"743.269911ms","start":"2026-04-13T21:04:33.438105Z","end":"2026-04-13T21:04:34.181375Z","steps":["trace[1170097588] 'process raft request' (duration: 743.053165ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:34.181682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:33.438088Z","time spent":"743.506249ms","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T21:04:34.223404Z","caller":"traceutil/trace.go:171","msg":"trace[2102556637] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"785.135197ms","start":"2026-04-13T21:04:33.438247Z","end":"2026-04-13T21:04:34.223382Z","steps":["trace[2102556637] 'process raft request' (duration: 784.933961ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:04:34.224054Z","caller":"traceutil/trace.go:171","msg":"trace[1338748522] linearizableReadLoop","detail":"{readStateIndex:1384; appliedIndex:1379; }","duration":"653.552381ms","start":"2026-04-13T21:04:33.570473Z","end":"2026-04-13T21:04:34.224025Z","steps":["trace[1338748522] 'read index received' (duration: 610.785017ms)","trace[1338748522] 'applied index is now lower than readState.Index' (duration: 42.765484ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:04:34.224117Z","caller":"traceutil/trace.go:171","msg":"trace[604356884] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"591.395336ms","start":"2026-04-13T21:04:33.632714Z","end":"2026-04-13T21:04:34.224109Z","steps":["trace[604356884] 'process raft request' (duration: 591.148698ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:34.224147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:33.632697Z","time spent":"591.435886ms","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:04:34.224084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:33.438214Z","time spent":"785.814559ms","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:04:34.224807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.334015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:5 size:1050256"} {"level":"info","ts":"2026-04-13T21:04:34.224875Z","caller":"traceutil/trace.go:171","msg":"trace[1407896704] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:1322; }","duration":"654.434438ms","start":"2026-04-13T21:04:33.570426Z","end":"2026-04-13T21:04:34.22486Z","steps":["trace[1407896704] 'agreement among raft nodes before linearized reading' (duration: 653.738416ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:34.22491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:33.570409Z","time spent":"654.49056ms","remote":"127.0.0.1:52064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":5,"response size":1050280,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"warn","ts":"2026-04-13T21:04:34.225113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.802746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-13T21:04:34.225188Z","caller":"traceutil/trace.go:171","msg":"trace[1517523534] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1322; }","duration":"230.928119ms","start":"2026-04-13T21:04:33.994244Z","end":"2026-04-13T21:04:34.225172Z","steps":["trace[1517523534] 'agreement among raft nodes before linearized reading' (duration: 230.790045ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:34.22527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.780814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:04:34.225396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.186596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-13T21:04:34.225418Z","caller":"traceutil/trace.go:171","msg":"trace[1715176610] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1322; }","duration":"554.239628ms","start":"2026-04-13T21:04:33.671173Z","end":"2026-04-13T21:04:34.225413Z","steps":["trace[1715176610] 'agreement among raft nodes before linearized reading' (duration: 554.172316ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:34.225431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:33.67116Z","time spent":"554.268478ms","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-13T21:04:34.225332Z","caller":"traceutil/trace.go:171","msg":"trace[1873081962] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1322; }","duration":"597.887927ms","start":"2026-04-13T21:04:33.627426Z","end":"2026-04-13T21:04:34.225314Z","steps":["trace[1873081962] 'agreement among raft nodes before linearized reading' (duration: 597.371041ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:04:34.223915Z","caller":"traceutil/trace.go:171","msg":"trace[457807810] transaction","detail":"{read_only:false; response_revision:1321; number_of_response:1; }","duration":"783.251459ms","start":"2026-04-13T21:04:33.440652Z","end":"2026-04-13T21:04:34.223903Z","steps":["trace[457807810] 'process raft request' (duration: 782.899307ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:34.225728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:33.440622Z","time spent":"785.026644ms","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T21:04:34.223657Z","caller":"traceutil/trace.go:171","msg":"trace[362086822] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"782.996761ms","start":"2026-04-13T21:04:33.44064Z","end":"2026-04-13T21:04:34.223637Z","steps":["trace[362086822] 'process raft request' (duration: 782.702732ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:34.225943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:33.627405Z","time spent":"598.181485ms","remote":"127.0.0.1:51940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-13T21:04:34.225971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:33.440629Z","time spent":"785.294983ms","remote":"127.0.0.1:52258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T21:04:34.336237Z","caller":"traceutil/trace.go:171","msg":"trace[425905975] transaction","detail":"{read_only:false; response_revision:1323; number_of_response:1; }","duration":"105.041766ms","start":"2026-04-13T21:04:34.231166Z","end":"2026-04-13T21:04:34.336208Z","steps":["trace[425905975] 'process raft request' (duration: 61.195418ms)","trace[425905975] 'compare' (duration: 43.720264ms)"],"step_count":2}