{"level":"warn","ts":"2026-04-21T19:15:47.404659Z","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-21T19:15:47.404781Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.216: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.216:2380","--initial-cluster=instance=https://199.204.45.216:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.216:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.216: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-21T19:15:47.404872Z","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-21T19:15:47.404884Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.216:2380"]} {"level":"info","ts":"2026-04-21T19:15:47.404921Z","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-21T19:15:47.405812Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"]} {"level":"info","ts":"2026-04-21T19:15:47.405939Z","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.216:2380"],"listen-peer-urls":["https://199.204.45.216:2380"],"advertise-client-urls":["https://199.204.45.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.216: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-21T19:15:47.411209Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.963257ms"} {"level":"info","ts":"2026-04-21T19:15:47.418032Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4e98569549cc430c","cluster-id":"65d70b4d1d4a8bf9"} {"level":"info","ts":"2026-04-21T19:15:47.418111Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=()"} {"level":"info","ts":"2026-04-21T19:15:47.418132Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became follower at term 0"} {"level":"info","ts":"2026-04-21T19:15:47.418142Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4e98569549cc430c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-21T19:15:47.418149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became follower at term 1"} {"level":"info","ts":"2026-04-21T19:15:47.418182Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=(5663371730606637836)"} {"level":"warn","ts":"2026-04-21T19:15:47.430188Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-21T19:15:47.435784Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-21T19:15:47.445428Z","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-21T19:15:47.448007Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4e98569549cc430c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-21T19:15:47.44883Z","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-21T19:15:47.454742Z","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-21T19:15:47.454755Z","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-21T19:15:47.448835Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4e98569549cc430c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-21T19:15:47.45973Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=(5663371730606637836)"} {"level":"info","ts":"2026-04-21T19:15:47.459879Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"65d70b4d1d4a8bf9","local-member-id":"4e98569549cc430c","added-peer-id":"4e98569549cc430c","added-peer-peer-urls":["https://199.204.45.216:2380"]} {"level":"info","ts":"2026-04-21T19:15:47.460999Z","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-21T19:15:47.461247Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4e98569549cc430c","initial-advertise-peer-urls":["https://199.204.45.216:2380"],"listen-peer-urls":["https://199.204.45.216:2380"],"advertise-client-urls":["https://199.204.45.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-21T19:15:47.461284Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-21T19:15:47.461418Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.216:2380"} {"level":"info","ts":"2026-04-21T19:15:47.461443Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.216:2380"} {"level":"info","ts":"2026-04-21T19:15:47.918624Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c is starting a new election at term 1"} {"level":"info","ts":"2026-04-21T19:15:47.918681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became pre-candidate at term 1"} {"level":"info","ts":"2026-04-21T19:15:47.918722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c received MsgPreVoteResp from 4e98569549cc430c at term 1"} {"level":"info","ts":"2026-04-21T19:15:47.918746Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became candidate at term 2"} {"level":"info","ts":"2026-04-21T19:15:47.918757Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c received MsgVoteResp from 4e98569549cc430c at term 2"} {"level":"info","ts":"2026-04-21T19:15:47.918785Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became leader at term 2"} {"level":"info","ts":"2026-04-21T19:15:47.918798Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4e98569549cc430c elected leader 4e98569549cc430c at term 2"} {"level":"info","ts":"2026-04-21T19:15:47.991756Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4e98569549cc430c","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.216:2379]}","request-path":"/0/members/4e98569549cc430c/attributes","cluster-id":"65d70b4d1d4a8bf9","publish-timeout":"7s"} {"level":"info","ts":"2026-04-21T19:15:47.991936Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T19:15:47.991802Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T19:15:47.992978Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T19:15:47.99325Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-21T19:15:47.993313Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-21T19:15:47.994487Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-21T19:15:48.003633Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.216:2379"} {"level":"info","ts":"2026-04-21T19:15:48.244129Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"65d70b4d1d4a8bf9","local-member-id":"4e98569549cc430c","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T19:15:48.244322Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T19:15:48.244375Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T19:15:48.244629Z","caller":"traceutil/trace.go:171","msg":"trace[29561324] linearizableReadLoop","detail":"{readStateIndex:4; appliedIndex:4; }","duration":"204.055215ms","start":"2026-04-21T19:15:48.040496Z","end":"2026-04-21T19:15:48.244552Z","steps":["trace[29561324] 'read index received' (duration: 204.037545ms)","trace[29561324] 'applied index is now lower than readState.Index' (duration: 13.46µs)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:15:48.24532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.930689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-21T19:15:48.245399Z","caller":"traceutil/trace.go:171","msg":"trace[227531346] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1; }","duration":"157.051513ms","start":"2026-04-21T19:15:48.088321Z","end":"2026-04-21T19:15:48.245372Z","steps":["trace[227531346] 'agreement among raft nodes before linearized reading' (duration: 156.514509ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:15:48.245698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.168613ms","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:4"} {"level":"warn","ts":"2026-04-21T19:15:48.24575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.086095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-21T19:15:48.245772Z","caller":"traceutil/trace.go:171","msg":"trace[2066870156] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"205.267586ms","start":"2026-04-21T19:15:48.040472Z","end":"2026-04-21T19:15:48.24574Z","steps":["trace[2066870156] 'agreement among raft nodes before linearized reading' (duration: 205.168763ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:15:48.245801Z","caller":"traceutil/trace.go:171","msg":"trace[1937941303] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"103.158156ms","start":"2026-04-21T19:15:48.142622Z","end":"2026-04-21T19:15:48.24578Z","steps":["trace[1937941303] 'agreement among raft nodes before linearized reading' (duration: 103.095925ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:15:48.24587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.399649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-21T19:15:48.24593Z","caller":"traceutil/trace.go:171","msg":"trace[1233719024] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"205.45726ms","start":"2026-04-21T19:15:48.040451Z","end":"2026-04-21T19:15:48.245909Z","steps":["trace[1233719024] 'agreement among raft nodes before linearized reading' (duration: 205.366578ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:15:48.24594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.863016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-21T19:15:48.245984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.923258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-21T19:15:48.246004Z","caller":"traceutil/trace.go:171","msg":"trace[1273444945] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"122.928818ms","start":"2026-04-21T19:15:48.12305Z","end":"2026-04-21T19:15:48.245978Z","steps":["trace[1273444945] 'agreement among raft nodes before linearized reading' (duration: 122.865816ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:15:48.246034Z","caller":"traceutil/trace.go:171","msg":"trace[1671206003] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"122.974489ms","start":"2026-04-21T19:15:48.123043Z","end":"2026-04-21T19:15:48.246017Z","steps":["trace[1671206003] 'agreement among raft nodes before linearized reading' (duration: 122.922468ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:15:48.245882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.31844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-21T19:15:48.246153Z","caller":"traceutil/trace.go:171","msg":"trace[1684053670] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"103.606438ms","start":"2026-04-21T19:15:48.142529Z","end":"2026-04-21T19:15:48.246135Z","steps":["trace[1684053670] 'agreement among raft nodes before linearized reading' (duration: 103.306251ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:15:48.249958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.062331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-21T19:15:48.249998Z","caller":"traceutil/trace.go:171","msg":"trace[380469088] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"151.116713ms","start":"2026-04-21T19:15:48.098869Z","end":"2026-04-21T19:15:48.249986Z","steps":["trace[380469088] 'agreement among raft nodes before linearized reading' (duration: 147.234514ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:15:48.2502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.344548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-21T19:15:48.250227Z","caller":"traceutil/trace.go:171","msg":"trace[617291818] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"151.405489ms","start":"2026-04-21T19:15:48.098814Z","end":"2026-04-21T19:15:48.25022Z","steps":["trace[617291818] 'agreement among raft nodes before linearized reading' (duration: 147.293295ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:15:48.250582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.420006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-21T19:15:48.250639Z","caller":"traceutil/trace.go:171","msg":"trace[1898733408] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"139.524199ms","start":"2026-04-21T19:15:48.11108Z","end":"2026-04-21T19:15:48.250604Z","steps":["trace[1898733408] 'agreement among raft nodes before linearized reading' (duration: 135.014324ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:15:48.250737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.740684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-21T19:15:48.250766Z","caller":"traceutil/trace.go:171","msg":"trace[2047984437] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"139.781905ms","start":"2026-04-21T19:15:48.110977Z","end":"2026-04-21T19:15:48.250759Z","steps":["trace[2047984437] 'agreement among raft nodes before linearized reading' (duration: 135.122107ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:15:51.096874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.483459ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:15:51.097114Z","caller":"traceutil/trace.go:171","msg":"trace[586628832] transaction","detail":"{read_only:false; response_revision:144; number_of_response:1; }","duration":"143.706075ms","start":"2026-04-21T19:15:50.953348Z","end":"2026-04-21T19:15:51.097054Z","steps":["trace[586628832] 'process raft request' (duration: 26.706488ms)","trace[586628832] 'compare' (duration: 115.308684ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:15:54.376055Z","caller":"traceutil/trace.go:171","msg":"trace[371876831] linearizableReadLoop","detail":"{readStateIndex:283; appliedIndex:282; }","duration":"115.794206ms","start":"2026-04-21T19:15:54.260228Z","end":"2026-04-21T19:15:54.376022Z","steps":["trace[371876831] 'read index received' (duration: 115.628012ms)","trace[371876831] 'applied index is now lower than readState.Index' (duration: 165.444µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:15:54.376109Z","caller":"traceutil/trace.go:171","msg":"trace[586657371] transaction","detail":"{read_only:false; response_revision:272; number_of_response:1; }","duration":"161.962137ms","start":"2026-04-21T19:15:54.214121Z","end":"2026-04-21T19:15:54.376083Z","steps":["trace[586657371] 'process raft request' (duration: 161.782193ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:15:54.376277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.024791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:15:54.37652Z","caller":"traceutil/trace.go:171","msg":"trace[286768676] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:272; }","duration":"116.302679ms","start":"2026-04-21T19:15:54.260192Z","end":"2026-04-21T19:15:54.376494Z","steps":["trace[286768676] 'agreement among raft nodes before linearized reading' (duration: 115.96649ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:18.93846Z","caller":"traceutil/trace.go:171","msg":"trace[1971127120] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"199.620659ms","start":"2026-04-21T19:16:18.738742Z","end":"2026-04-21T19:16:18.938363Z","steps":["trace[1971127120] 'process raft request' (duration: 129.117431ms)","trace[1971127120] 'compare' (duration: 70.271413ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:16:18.950897Z","caller":"traceutil/trace.go:171","msg":"trace[1293697603] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"202.146735ms","start":"2026-04-21T19:16:18.748723Z","end":"2026-04-21T19:16:18.95087Z","steps":["trace[1293697603] 'process raft request' (duration: 201.971341ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:18.950928Z","caller":"traceutil/trace.go:171","msg":"trace[1385601953] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"201.675873ms","start":"2026-04-21T19:16:18.749223Z","end":"2026-04-21T19:16:18.950899Z","steps":["trace[1385601953] 'process raft request' (duration: 201.57701ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:18.951131Z","caller":"traceutil/trace.go:171","msg":"trace[531156223] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"168.655671ms","start":"2026-04-21T19:16:18.782446Z","end":"2026-04-21T19:16:18.951101Z","steps":["trace[531156223] 'process raft request' (duration: 168.519377ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:18.951199Z","caller":"traceutil/trace.go:171","msg":"trace[1940083606] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"170.075538ms","start":"2026-04-21T19:16:18.781083Z","end":"2026-04-21T19:16:18.951158Z","steps":["trace[1940083606] 'process raft request' (duration: 169.751269ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:18.951104Z","caller":"traceutil/trace.go:171","msg":"trace[1922649484] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"169.538634ms","start":"2026-04-21T19:16:18.781535Z","end":"2026-04-21T19:16:18.951074Z","steps":["trace[1922649484] 'process raft request' (duration: 169.395631ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:18.951225Z","caller":"traceutil/trace.go:171","msg":"trace[1686997358] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"142.565568ms","start":"2026-04-21T19:16:18.808643Z","end":"2026-04-21T19:16:18.951208Z","steps":["trace[1686997358] 'process raft request' (duration: 142.489067ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:18.951254Z","caller":"traceutil/trace.go:171","msg":"trace[1164691268] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"169.949305ms","start":"2026-04-21T19:16:18.781279Z","end":"2026-04-21T19:16:18.951228Z","steps":["trace[1164691268] 'process raft request' (duration: 169.619896ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:18.951316Z","caller":"traceutil/trace.go:171","msg":"trace[218677913] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"163.875698ms","start":"2026-04-21T19:16:18.787433Z","end":"2026-04-21T19:16:18.951308Z","steps":["trace[218677913] 'process raft request' (duration: 163.59425ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:18.951339Z","caller":"traceutil/trace.go:171","msg":"trace[989743888] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"166.184628ms","start":"2026-04-21T19:16:18.785145Z","end":"2026-04-21T19:16:18.95133Z","steps":["trace[989743888] 'process raft request' (duration: 165.845359ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:18.951351Z","caller":"traceutil/trace.go:171","msg":"trace[791898829] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"156.914638ms","start":"2026-04-21T19:16:18.794429Z","end":"2026-04-21T19:16:18.951343Z","steps":["trace[791898829] 'process raft request' (duration: 156.65471ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:19.343184Z","caller":"traceutil/trace.go:171","msg":"trace[1133744871] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"140.577557ms","start":"2026-04-21T19:16:19.202569Z","end":"2026-04-21T19:16:19.343146Z","steps":["trace[1133744871] 'process raft request' (duration: 112.478041ms)","trace[1133744871] 'compare' (duration: 27.967852ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:16:19.642734Z","caller":"traceutil/trace.go:171","msg":"trace[1315793620] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"248.352886ms","start":"2026-04-21T19:16:19.394351Z","end":"2026-04-21T19:16:19.642704Z","steps":["trace[1315793620] 'process raft request' (duration: 239.001035ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:19.642863Z","caller":"traceutil/trace.go:171","msg":"trace[1697253447] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"238.853534ms","start":"2026-04-21T19:16:19.403983Z","end":"2026-04-21T19:16:19.642836Z","steps":["trace[1697253447] 'process raft request' (duration: 238.770181ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:19.642872Z","caller":"traceutil/trace.go:171","msg":"trace[305395122] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"241.192483ms","start":"2026-04-21T19:16:19.401644Z","end":"2026-04-21T19:16:19.642836Z","steps":["trace[305395122] 'process raft request' (duration: 240.974176ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:25.153999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.739848ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:16:25.154149Z","caller":"traceutil/trace.go:171","msg":"trace[1206843219] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:600; }","duration":"373.991878ms","start":"2026-04-21T19:16:24.780141Z","end":"2026-04-21T19:16:25.154133Z","steps":["trace[1206843219] 'read index received' (duration: 88.482µs)","trace[1206843219] 'applied index is now lower than readState.Index' (duration: 373.901836ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:16:25.154189Z","caller":"traceutil/trace.go:171","msg":"trace[1239905209] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"574.742278ms","start":"2026-04-21T19:16:24.579421Z","end":"2026-04-21T19:16:25.154163Z","steps":["trace[1239905209] 'process raft request' (duration: 35.706521ms)","trace[1239905209] 'compare' (duration: 538.40387ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:16:25.154283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:24.579384Z","time spent":"574.860611ms","remote":"127.0.0.1:58302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T19:16:25.154422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.285626ms","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-21T19:16:25.154485Z","caller":"traceutil/trace.go:171","msg":"trace[579480379] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:575; }","duration":"374.417429ms","start":"2026-04-21T19:16:24.780057Z","end":"2026-04-21T19:16:25.154474Z","steps":["trace[579480379] 'agreement among raft nodes before linearized reading' (duration: 374.147843ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:25.154547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:24.780026Z","time spent":"374.511822ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-21T19:16:25.77497Z","caller":"traceutil/trace.go:171","msg":"trace[1927745704] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:605; }","duration":"159.111116ms","start":"2026-04-21T19:16:25.615818Z","end":"2026-04-21T19:16:25.774929Z","steps":["trace[1927745704] 'read index received' (duration: 158.12449ms)","trace[1927745704] 'applied index is now lower than readState.Index' (duration: 984.576µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:16:25.775113Z","caller":"traceutil/trace.go:171","msg":"trace[1026932996] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"178.417523ms","start":"2026-04-21T19:16:25.596656Z","end":"2026-04-21T19:16:25.775073Z","steps":["trace[1026932996] 'process raft request' (duration: 177.54281ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:25.775244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.397493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-72xwr\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-21T19:16:25.775284Z","caller":"traceutil/trace.go:171","msg":"trace[2088826728] range","detail":"{range_begin:/registry/pods/kube-system/cilium-72xwr; range_end:; response_count:1; response_revision:580; }","duration":"159.498965ms","start":"2026-04-21T19:16:25.615775Z","end":"2026-04-21T19:16:25.775274Z","steps":["trace[2088826728] 'agreement among raft nodes before linearized reading' (duration: 159.28884ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:25.894858Z","caller":"traceutil/trace.go:171","msg":"trace[951179906] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"100.950144ms","start":"2026-04-21T19:16:25.793887Z","end":"2026-04-21T19:16:25.894837Z","steps":["trace[951179906] 'process raft request' (duration: 100.77536ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:26.395469Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831409885815529152,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T19:16:27.489912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"961.104966ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:16:27.490183Z","caller":"traceutil/trace.go:171","msg":"trace[1830888736] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"1.657014109s","start":"2026-04-21T19:16:25.833146Z","end":"2026-04-21T19:16:27.490161Z","steps":["trace[1830888736] 'process raft request' (duration: 695.553464ms)","trace[1830888736] 'compare' (duration: 960.501519ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:16:27.490368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:25.833117Z","time spent":"1.657132122s","remote":"127.0.0.1:40220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T19:16:27.490339Z","caller":"traceutil/trace.go:171","msg":"trace[1536783934] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:607; }","duration":"1.595562233s","start":"2026-04-21T19:16:25.894751Z","end":"2026-04-21T19:16:27.490314Z","steps":["trace[1536783934] 'read index received' (duration: 633.875073ms)","trace[1536783934] 'applied index is now lower than readState.Index' (duration: 961.66007ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:16:27.501501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.606740501s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-21T19:16:27.501626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.565328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:16:27.501691Z","caller":"traceutil/trace.go:171","msg":"trace[1598578767] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:582; }","duration":"261.703231ms","start":"2026-04-21T19:16:27.239978Z","end":"2026-04-21T19:16:27.501682Z","steps":["trace[1598578767] 'agreement among raft nodes before linearized reading' (duration: 261.597479ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:27.501724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.665349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:16:27.501749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.468467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:16:27.501795Z","caller":"traceutil/trace.go:171","msg":"trace[532786374] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:582; }","duration":"382.543189ms","start":"2026-04-21T19:16:27.11924Z","end":"2026-04-21T19:16:27.501783Z","steps":["trace[532786374] 'agreement among raft nodes before linearized reading' (duration: 382.462517ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:27.501766Z","caller":"traceutil/trace.go:171","msg":"trace[719662076] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:582; }","duration":"178.799552ms","start":"2026-04-21T19:16:27.322956Z","end":"2026-04-21T19:16:27.501755Z","steps":["trace[719662076] 'agreement among raft nodes before linearized reading' (duration: 178.687739ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:27.501832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:27.119223Z","time spent":"382.5985ms","remote":"127.0.0.1:33808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T19:16:27.501941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.707321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:16:27.501983Z","caller":"traceutil/trace.go:171","msg":"trace[642448433] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:582; }","duration":"223.776313ms","start":"2026-04-21T19:16:27.2782Z","end":"2026-04-21T19:16:27.501976Z","steps":["trace[642448433] 'agreement among raft nodes before linearized reading' (duration: 223.722241ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:27.502027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.582719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:16:27.502036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.463578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:16:27.502111Z","caller":"traceutil/trace.go:171","msg":"trace[1458357549] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:582; }","duration":"222.562082ms","start":"2026-04-21T19:16:27.279525Z","end":"2026-04-21T19:16:27.502087Z","steps":["trace[1458357549] 'agreement among raft nodes before linearized reading' (duration: 222.407397ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:27.502137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.815975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:16:27.502134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.912467ms","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-21T19:16:27.502204Z","caller":"traceutil/trace.go:171","msg":"trace[944054305] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:582; }","duration":"224.003349ms","start":"2026-04-21T19:16:27.278195Z","end":"2026-04-21T19:16:27.502198Z","steps":["trace[944054305] 'agreement among raft nodes before linearized reading' (duration: 223.921137ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:27.502747Z","caller":"traceutil/trace.go:171","msg":"trace[2043195478] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:582; }","duration":"306.644762ms","start":"2026-04-21T19:16:27.195413Z","end":"2026-04-21T19:16:27.502058Z","steps":["trace[2043195478] 'agreement among raft nodes before linearized reading' (duration: 306.571829ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:27.506941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:27.195404Z","time spent":"311.518366ms","remote":"127.0.0.1:33836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 "} {"level":"info","ts":"2026-04-21T19:16:27.501549Z","caller":"traceutil/trace.go:171","msg":"trace[1099122027] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:582; }","duration":"1.606831494s","start":"2026-04-21T19:16:25.894706Z","end":"2026-04-21T19:16:27.501537Z","steps":["trace[1099122027] 'agreement among raft nodes before linearized reading' (duration: 1.595870961s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:27.50718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:25.894688Z","time spent":"1.61246267s","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-21T19:16:27.502826Z","caller":"traceutil/trace.go:171","msg":"trace[1607861737] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:582; }","duration":"199.869807ms","start":"2026-04-21T19:16:27.302296Z","end":"2026-04-21T19:16:27.502166Z","steps":["trace[1607861737] 'agreement among raft nodes before linearized reading' (duration: 199.807316ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:27.502916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.021205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:16:27.507418Z","caller":"traceutil/trace.go:171","msg":"trace[1992055048] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:582; }","duration":"184.566471ms","start":"2026-04-21T19:16:27.322836Z","end":"2026-04-21T19:16:27.507402Z","steps":["trace[1992055048] 'agreement among raft nodes before linearized reading' (duration: 179.999324ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:27.502968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.541083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:16:27.507541Z","caller":"traceutil/trace.go:171","msg":"trace[926539124] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:582; }","duration":"405.118471ms","start":"2026-04-21T19:16:27.102402Z","end":"2026-04-21T19:16:27.507521Z","steps":["trace[926539124] 'agreement among raft nodes before linearized reading' (duration: 400.147443ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:27.50761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:27.102398Z","time spent":"405.197902ms","remote":"127.0.0.1:33792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-21T19:16:27.503256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.21816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:16:27.507925Z","caller":"traceutil/trace.go:171","msg":"trace[1708425166] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:582; }","duration":"205.896461ms","start":"2026-04-21T19:16:27.302015Z","end":"2026-04-21T19:16:27.507911Z","steps":["trace[1708425166] 'agreement among raft nodes before linearized reading' (duration: 200.170324ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:27.503257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.715824ms","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-21T19:16:27.503579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.57303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:16:27.508264Z","caller":"traceutil/trace.go:171","msg":"trace[1574776661] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:582; }","duration":"206.288041ms","start":"2026-04-21T19:16:27.301963Z","end":"2026-04-21T19:16:27.508251Z","steps":["trace[1574776661] 'agreement among raft nodes before linearized reading' (duration: 200.233456ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:27.503583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.065894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:16:27.508385Z","caller":"traceutil/trace.go:171","msg":"trace[1943108738] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:582; }","duration":"406.889878ms","start":"2026-04-21T19:16:27.101477Z","end":"2026-04-21T19:16:27.508366Z","steps":["trace[1943108738] 'agreement among raft nodes before linearized reading' (duration: 401.803556ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:27.508433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:27.10146Z","time spent":"406.952869ms","remote":"127.0.0.1:33804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T19:16:27.503596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.554314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:16:27.508643Z","caller":"traceutil/trace.go:171","msg":"trace[1477092425] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:582; }","duration":"367.622474ms","start":"2026-04-21T19:16:27.141002Z","end":"2026-04-21T19:16:27.508624Z","steps":["trace[1477092425] 'agreement among raft nodes before linearized reading' (duration: 362.540843ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:27.508691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:27.140991Z","time spent":"367.685246ms","remote":"127.0.0.1:33820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-21T19:16:27.503724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.214938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:16:27.509079Z","caller":"traceutil/trace.go:171","msg":"trace[499172616] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:582; }","duration":"314.605127ms","start":"2026-04-21T19:16:27.19446Z","end":"2026-04-21T19:16:27.509065Z","steps":["trace[499172616] 'agreement among raft nodes before linearized reading' (duration: 309.162667ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:27.509132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:27.194439Z","time spent":"314.671608ms","remote":"127.0.0.1:33836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-21T19:16:27.503806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.471757ms","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-21T19:16:27.509301Z","caller":"traceutil/trace.go:171","msg":"trace[105354078] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:582; }","duration":"268.99662ms","start":"2026-04-21T19:16:27.240292Z","end":"2026-04-21T19:16:27.509289Z","steps":["trace[105354078] 'agreement among raft nodes before linearized reading' (duration: 263.412206ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:27.503868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.414963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:16:27.509542Z","caller":"traceutil/trace.go:171","msg":"trace[1945643190] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:582; }","duration":"315.13697ms","start":"2026-04-21T19:16:27.194392Z","end":"2026-04-21T19:16:27.509529Z","steps":["trace[1945643190] 'agreement among raft nodes before linearized reading' (duration: 309.346301ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:27.509599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:27.194382Z","time spent":"315.192952ms","remote":"127.0.0.1:33836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T19:16:27.503994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.21224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:16:27.509811Z","caller":"traceutil/trace.go:171","msg":"trace[547508459] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:582; }","duration":"545.054922ms","start":"2026-04-21T19:16:26.964736Z","end":"2026-04-21T19:16:27.509791Z","steps":["trace[547508459] 'agreement among raft nodes before linearized reading' (duration: 538.868002ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:27.509857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:26.964709Z","time spent":"545.133594ms","remote":"127.0.0.1:33792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-21T19:16:27.504061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.023849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:16:27.510042Z","caller":"traceutil/trace.go:171","msg":"trace[658620572] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:582; }","duration":"249.030635ms","start":"2026-04-21T19:16:27.260999Z","end":"2026-04-21T19:16:27.510029Z","steps":["trace[658620572] 'agreement among raft nodes before linearized reading' (duration: 242.835155ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:27.504093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.253058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-21T19:16:27.504126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.435848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:16:27.510308Z","caller":"traceutil/trace.go:171","msg":"trace[252208825] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:582; }","duration":"390.654528ms","start":"2026-04-21T19:16:27.119642Z","end":"2026-04-21T19:16:27.510297Z","steps":["trace[252208825] 'agreement among raft nodes before linearized reading' (duration: 384.459988ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:27.510362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:27.11962Z","time spent":"390.72003ms","remote":"127.0.0.1:33808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"warn","ts":"2026-04-21T19:16:27.504244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.217215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:16:27.510507Z","caller":"traceutil/trace.go:171","msg":"trace[665735221] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:582; }","duration":"368.508297ms","start":"2026-04-21T19:16:27.141982Z","end":"2026-04-21T19:16:27.510491Z","steps":["trace[665735221] 'agreement among raft nodes before linearized reading' (duration: 362.125422ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:27.510547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:27.141967Z","time spent":"368.568129ms","remote":"127.0.0.1:33820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "} {"level":"info","ts":"2026-04-21T19:16:27.510591Z","caller":"traceutil/trace.go:171","msg":"trace[2137486606] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:582; }","duration":"406.679012ms","start":"2026-04-21T19:16:27.10152Z","end":"2026-04-21T19:16:27.508199Z","steps":["trace[2137486606] 'agreement among raft nodes before linearized reading' (duration: 401.482119ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:27.510653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:27.101517Z","time spent":"409.106045ms","remote":"127.0.0.1:33804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-04-21T19:16:27.511245Z","caller":"traceutil/trace.go:171","msg":"trace[1264409357] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:582; }","duration":"322.435248ms","start":"2026-04-21T19:16:27.187803Z","end":"2026-04-21T19:16:27.510238Z","steps":["trace[1264409357] 'agreement among raft nodes before linearized reading' (duration: 316.084454ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:27.51129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:27.187787Z","time spent":"323.494195ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-21T19:16:27.50427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.56735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:16:27.512141Z","caller":"traceutil/trace.go:171","msg":"trace[1472199358] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:582; }","duration":"547.454714ms","start":"2026-04-21T19:16:26.964668Z","end":"2026-04-21T19:16:27.512123Z","steps":["trace[1472199358] 'agreement among raft nodes before linearized reading' (duration: 539.348164ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:27.50428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.275382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:16:27.512264Z","caller":"traceutil/trace.go:171","msg":"trace[2087359398] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:582; }","duration":"371.265978ms","start":"2026-04-21T19:16:27.140981Z","end":"2026-04-21T19:16:27.512247Z","steps":["trace[2087359398] 'agreement among raft nodes before linearized reading' (duration: 363.161439ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:27.512305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:27.140971Z","time spent":"371.319979ms","remote":"127.0.0.1:33820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T19:16:27.504401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.144079636s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-21T19:16:27.504481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.146326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:16:27.512207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:26.964653Z","time spent":"547.534965ms","remote":"127.0.0.1:33792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"info","ts":"2026-04-21T19:16:27.512584Z","caller":"traceutil/trace.go:171","msg":"trace[2061232797] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:582; }","duration":"393.267256ms","start":"2026-04-21T19:16:27.119306Z","end":"2026-04-21T19:16:27.512573Z","steps":["trace[2061232797] 'agreement among raft nodes before linearized reading' (duration: 384.995502ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:27.512672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:27.119295Z","time spent":"393.323657ms","remote":"127.0.0.1:33808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-04-21T19:16:27.504819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.439936688s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-21T19:16:27.512767Z","caller":"traceutil/trace.go:171","msg":"trace[404375747] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:582; }","duration":"1.447881513s","start":"2026-04-21T19:16:26.064875Z","end":"2026-04-21T19:16:27.512757Z","steps":["trace[404375747] 'agreement among raft nodes before linearized reading' (duration: 1.439549618s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:27.512794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:26.064815Z","time spent":"1.447972506s","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-21T19:16:27.504894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.976989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:16:27.512534Z","caller":"traceutil/trace.go:171","msg":"trace[1297976512] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:582; }","duration":"1.152242425s","start":"2026-04-21T19:16:26.360273Z","end":"2026-04-21T19:16:27.512515Z","steps":["trace[1297976512] 'agreement among raft nodes before linearized reading' (duration: 1.144016844s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:27.513068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:26.360252Z","time spent":"1.152807461s","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-21T19:16:27.513698Z","caller":"traceutil/trace.go:171","msg":"trace[319329610] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:582; }","duration":"188.999416ms","start":"2026-04-21T19:16:27.323896Z","end":"2026-04-21T19:16:27.512895Z","steps":["trace[319329610] 'agreement among raft nodes before linearized reading' (duration: 180.957729ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:29.009483Z","caller":"traceutil/trace.go:171","msg":"trace[1701579957] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"127.14382ms","start":"2026-04-21T19:16:28.88232Z","end":"2026-04-21T19:16:29.009464Z","steps":["trace[1701579957] 'process raft request' (duration: 127.003966ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:42.848397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.233468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:16:42.848455Z","caller":"traceutil/trace.go:171","msg":"trace[455772739] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:747; }","duration":"585.336191ms","start":"2026-04-21T19:16:42.263107Z","end":"2026-04-21T19:16:42.848443Z","steps":["trace[455772739] 'range keys from in-memory index tree' (duration: 585.064364ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:42.848482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:42.263086Z","time spent":"585.389692ms","remote":"127.0.0.1:57950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-21T19:16:42.869488Z","caller":"traceutil/trace.go:171","msg":"trace[534669192] linearizableReadLoop","detail":"{readStateIndex:779; appliedIndex:778; }","duration":"105.226234ms","start":"2026-04-21T19:16:42.764245Z","end":"2026-04-21T19:16:42.869471Z","steps":["trace[534669192] 'read index received' (duration: 105.111422ms)","trace[534669192] 'applied index is now lower than readState.Index' (duration: 113.652µs)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:16:42.869667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.408029ms","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-21T19:16:42.869695Z","caller":"traceutil/trace.go:171","msg":"trace[101116367] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:748; }","duration":"105.45011ms","start":"2026-04-21T19:16:42.764238Z","end":"2026-04-21T19:16:42.869688Z","steps":["trace[101116367] 'agreement among raft nodes before linearized reading' (duration: 105.337347ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:42.869675Z","caller":"traceutil/trace.go:171","msg":"trace[1076970341] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"140.511755ms","start":"2026-04-21T19:16:42.729042Z","end":"2026-04-21T19:16:42.869554Z","steps":["trace[1076970341] 'process raft request' (duration: 140.31293ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:43.873115Z","caller":"traceutil/trace.go:171","msg":"trace[1507728928] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"111.403785ms","start":"2026-04-21T19:16:43.761684Z","end":"2026-04-21T19:16:43.873087Z","steps":["trace[1507728928] 'process raft request' (duration: 111.25659ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:51.691418Z","caller":"traceutil/trace.go:171","msg":"trace[1144474846] transaction","detail":"{read_only:false; response_revision:860; number_of_response:1; }","duration":"120.321074ms","start":"2026-04-21T19:16:51.571059Z","end":"2026-04-21T19:16:51.69138Z","steps":["trace[1144474846] 'process raft request' (duration: 96.300115ms)","trace[1144474846] 'compare' (duration: 23.853295ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:16:56.438591Z","caller":"traceutil/trace.go:171","msg":"trace[1280248145] transaction","detail":"{read_only:false; response_revision:880; number_of_response:1; }","duration":"123.059916ms","start":"2026-04-21T19:16:56.315509Z","end":"2026-04-21T19:16:56.438569Z","steps":["trace[1280248145] 'process raft request' (duration: 122.882202ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:56.544174Z","caller":"traceutil/trace.go:171","msg":"trace[1417843480] transaction","detail":"{read_only:false; response_revision:882; number_of_response:1; }","duration":"100.808981ms","start":"2026-04-21T19:16:56.443327Z","end":"2026-04-21T19:16:56.544136Z","steps":["trace[1417843480] 'process raft request' (duration: 100.644696ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:17.555311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.266362ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-21T19:17:17.555524Z","caller":"traceutil/trace.go:171","msg":"trace[190463740] linearizableReadLoop","detail":"{readStateIndex:999; appliedIndex:998; }","duration":"514.029177ms","start":"2026-04-21T19:17:17.041448Z","end":"2026-04-21T19:17:17.555477Z","steps":["trace[190463740] 'read index received' (duration: 363.591831ms)","trace[190463740] 'applied index is now lower than readState.Index' (duration: 150.432476ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:17:17.555619Z","caller":"traceutil/trace.go:171","msg":"trace[323949390] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"501.791026ms","start":"2026-04-21T19:17:17.053809Z","end":"2026-04-21T19:17:17.5556Z","steps":["trace[323949390] 'process raft request' (duration: 501.619702ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:17.555734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.271703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-21T19:17:17.555794Z","caller":"traceutil/trace.go:171","msg":"trace[1480586177] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:960; }","duration":"514.375567ms","start":"2026-04-21T19:17:17.041405Z","end":"2026-04-21T19:17:17.55578Z","steps":["trace[1480586177] 'agreement among raft nodes before linearized reading' (duration: 514.175002ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:17.555785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.292179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:17:17.555833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:17.041386Z","time spent":"514.436529ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-21T19:17:17.55584Z","caller":"traceutil/trace.go:171","msg":"trace[1608147159] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:960; }","duration":"294.411062ms","start":"2026-04-21T19:17:17.261415Z","end":"2026-04-21T19:17:17.555826Z","steps":["trace[1608147159] 'agreement among raft nodes before linearized reading' (duration: 294.295069ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:17.55583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.750778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:17:17.555901Z","caller":"traceutil/trace.go:171","msg":"trace[1332183879] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:960; }","duration":"419.87268ms","start":"2026-04-21T19:17:17.136013Z","end":"2026-04-21T19:17:17.555885Z","steps":["trace[1332183879] 'agreement among raft nodes before linearized reading' (duration: 419.718926ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:17.555974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:17.135995Z","time spent":"419.970113ms","remote":"127.0.0.1:40156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":27,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"warn","ts":"2026-04-21T19:17:17.556084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:17.053791Z","time spent":"501.874548ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:17:17.556383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.53591ms","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":"info","ts":"2026-04-21T19:17:17.556429Z","caller":"traceutil/trace.go:171","msg":"trace[472213077] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:960; }","duration":"452.621533ms","start":"2026-04-21T19:17:17.103797Z","end":"2026-04-21T19:17:17.556418Z","steps":["trace[472213077] 'agreement among raft nodes before linearized reading' (duration: 451.885133ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:17.55646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:17.103779Z","time spent":"452.672393ms","remote":"127.0.0.1:40226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":93,"response size":29,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-04-21T19:17:18.631783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.488625ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:17:18.631861Z","caller":"traceutil/trace.go:171","msg":"trace[1664972119] linearizableReadLoop","detail":"{readStateIndex:1001; appliedIndex:1000; }","duration":"749.005147ms","start":"2026-04-21T19:17:17.882844Z","end":"2026-04-21T19:17:18.631849Z","steps":["trace[1664972119] 'read index received' (duration: 311.292307ms)","trace[1664972119] 'applied index is now lower than readState.Index' (duration: 437.71185ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:17:18.631936Z","caller":"traceutil/trace.go:171","msg":"trace[1753794612] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"1.071553749s","start":"2026-04-21T19:17:17.560375Z","end":"2026-04-21T19:17:18.631929Z","steps":["trace[1753794612] 'process raft request' (duration: 633.847819ms)","trace[1753794612] 'compare' (duration: 437.29201ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:17:18.631976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:17.560355Z","time spent":"1.07159927s","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:17:18.63217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"748.184966ms","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-21T19:17:18.632191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.503053ms","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-21T19:17:18.632227Z","caller":"traceutil/trace.go:171","msg":"trace[192301204] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:961; }","duration":"748.288458ms","start":"2026-04-21T19:17:17.883927Z","end":"2026-04-21T19:17:18.632215Z","steps":["trace[192301204] 'agreement among raft nodes before linearized reading' (duration: 748.139055ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:18.632239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"749.402428ms","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-21T19:17:18.632262Z","caller":"traceutil/trace.go:171","msg":"trace[1442330894] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:961; }","duration":"749.46354ms","start":"2026-04-21T19:17:17.882792Z","end":"2026-04-21T19:17:18.632255Z","steps":["trace[1442330894] 'agreement among raft nodes before linearized reading' (duration: 749.366447ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:18.632257Z","caller":"traceutil/trace.go:171","msg":"trace[1572338695] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:961; }","duration":"454.630936ms","start":"2026-04-21T19:17:18.177609Z","end":"2026-04-21T19:17:18.63224Z","steps":["trace[1572338695] 'agreement among raft nodes before linearized reading' (duration: 454.506423ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:18.632284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:17.882773Z","time spent":"749.506631ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-21T19:17:18.632294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"692.08055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-21T19:17:18.632313Z","caller":"traceutil/trace.go:171","msg":"trace[1281715699] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:961; }","duration":"692.137882ms","start":"2026-04-21T19:17:17.940169Z","end":"2026-04-21T19:17:18.632307Z","steps":["trace[1281715699] 'agreement among raft nodes before linearized reading' (duration: 692.106261ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:18.632261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:17.883895Z","time spent":"748.360721ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-21T19:17:18.632317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:18.17759Z","time spent":"454.710859ms","remote":"127.0.0.1:58310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":29,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-21T19:17:18.63233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:17.940149Z","time spent":"692.176343ms","remote":"127.0.0.1:58226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":3,"response size":29,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "} {"level":"warn","ts":"2026-04-21T19:17:18.632377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"744.477687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-21T19:17:18.6324Z","caller":"traceutil/trace.go:171","msg":"trace[1885267453] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:961; }","duration":"744.519179ms","start":"2026-04-21T19:17:17.887872Z","end":"2026-04-21T19:17:18.632392Z","steps":["trace[1885267453] 'agreement among raft nodes before linearized reading' (duration: 744.467908ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:18.632399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"744.16628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-21T19:17:18.632426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:17.887861Z","time spent":"744.56052ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-21T19:17:18.63245Z","caller":"traceutil/trace.go:171","msg":"trace[1890834687] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:961; }","duration":"744.242692ms","start":"2026-04-21T19:17:17.888192Z","end":"2026-04-21T19:17:18.632435Z","steps":["trace[1890834687] 'agreement among raft nodes before linearized reading' (duration: 744.089778ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:18.632504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:17.888177Z","time spent":"744.315543ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-21T19:17:18.632401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.571479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:17:18.632636Z","caller":"traceutil/trace.go:171","msg":"trace[879049085] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:961; }","duration":"369.827095ms","start":"2026-04-21T19:17:18.262782Z","end":"2026-04-21T19:17:18.632609Z","steps":["trace[879049085] 'agreement among raft nodes before linearized reading' (duration: 369.589429ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:18.632719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:18.262766Z","time spent":"369.928047ms","remote":"127.0.0.1:57950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-21T19:17:32.828216Z","caller":"traceutil/trace.go:171","msg":"trace[1946569641] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"103.387539ms","start":"2026-04-21T19:17:32.72481Z","end":"2026-04-21T19:17:32.828197Z","steps":["trace[1946569641] 'process raft request' (duration: 103.360218ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:32.828508Z","caller":"traceutil/trace.go:171","msg":"trace[173994957] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"104.616611ms","start":"2026-04-21T19:17:32.723858Z","end":"2026-04-21T19:17:32.828475Z","steps":["trace[173994957] 'process raft request' (duration: 104.18435ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:32.828534Z","caller":"traceutil/trace.go:171","msg":"trace[1944468757] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"103.864851ms","start":"2026-04-21T19:17:32.724636Z","end":"2026-04-21T19:17:32.828501Z","steps":["trace[1944468757] 'process raft request' (duration: 103.505352ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:36.932501Z","caller":"traceutil/trace.go:171","msg":"trace[715642584] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"146.40818ms","start":"2026-04-21T19:17:36.785083Z","end":"2026-04-21T19:17:36.931491Z","steps":["trace[715642584] 'process raft request' (duration: 146.173284ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:37.000317Z","caller":"traceutil/trace.go:171","msg":"trace[887622297] linearizableReadLoop","detail":"{readStateIndex:1066; appliedIndex:1064; }","duration":"159.258077ms","start":"2026-04-21T19:17:36.841042Z","end":"2026-04-21T19:17:37.0003Z","steps":["trace[887622297] 'read index received' (duration: 90.15147ms)","trace[887622297] 'applied index is now lower than readState.Index' (duration: 69.105817ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:17:37.000445Z","caller":"traceutil/trace.go:171","msg":"trace[2097470196] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"215.328943ms","start":"2026-04-21T19:17:36.785104Z","end":"2026-04-21T19:17:37.000433Z","steps":["trace[2097470196] 'process raft request' (duration: 211.617095ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:37.000611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.578867ms","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-21T19:17:37.000651Z","caller":"traceutil/trace.go:171","msg":"trace[161039166] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1022; }","duration":"159.658459ms","start":"2026-04-21T19:17:36.840985Z","end":"2026-04-21T19:17:37.000643Z","steps":["trace[161039166] 'agreement among raft nodes before linearized reading' (duration: 159.566096ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:37.000661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.941649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-21T19:17:37.000692Z","caller":"traceutil/trace.go:171","msg":"trace[376533913] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1022; }","duration":"153.99577ms","start":"2026-04-21T19:17:36.846688Z","end":"2026-04-21T19:17:37.000684Z","steps":["trace[376533913] 'agreement among raft nodes before linearized reading' (duration: 153.937018ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:37.000606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.968699ms","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-21T19:17:37.000768Z","caller":"traceutil/trace.go:171","msg":"trace[1464821] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1022; }","duration":"154.160333ms","start":"2026-04-21T19:17:36.8466Z","end":"2026-04-21T19:17:37.00076Z","steps":["trace[1464821] 'agreement among raft nodes before linearized reading' (duration: 153.917697ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:41.050845Z","caller":"traceutil/trace.go:171","msg":"trace[684712522] transaction","detail":"{read_only:false; response_revision:1033; number_of_response:1; }","duration":"102.080965ms","start":"2026-04-21T19:17:40.948735Z","end":"2026-04-21T19:17:41.050816Z","steps":["trace[684712522] 'process raft request' (duration: 101.906701ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:41.947451Z","caller":"traceutil/trace.go:171","msg":"trace[1252892462] transaction","detail":"{read_only:false; response_revision:1034; number_of_response:1; }","duration":"885.928038ms","start":"2026-04-21T19:17:41.061495Z","end":"2026-04-21T19:17:41.947423Z","steps":["trace[1252892462] 'process raft request' (duration: 885.767553ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:41.947825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:41.061478Z","time spent":"886.051721ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:17:41.953665Z","caller":"traceutil/trace.go:171","msg":"trace[1598398815] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"890.070038ms","start":"2026-04-21T19:17:41.063578Z","end":"2026-04-21T19:17:41.953648Z","steps":["trace[1598398815] 'process raft request' (duration: 890.006696ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:41.95377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:41.063567Z","time spent":"890.147269ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:17:41.953661Z","caller":"traceutil/trace.go:171","msg":"trace[925509325] transaction","detail":"{read_only:false; response_revision:1035; number_of_response:1; }","duration":"890.9567ms","start":"2026-04-21T19:17:41.062681Z","end":"2026-04-21T19:17:41.953638Z","steps":["trace[925509325] 'process raft request' (duration: 890.824146ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:41.953925Z","caller":"traceutil/trace.go:171","msg":"trace[1550055895] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"248.090304ms","start":"2026-04-21T19:17:41.705826Z","end":"2026-04-21T19:17:41.953917Z","steps":["trace[1550055895] 'process raft request' (duration: 247.968651ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:41.953934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:41.062665Z","time spent":"891.209876ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:17:41.953929Z","caller":"traceutil/trace.go:171","msg":"trace[2006684963] transaction","detail":"{read_only:false; response_revision:1037; number_of_response:1; }","duration":"889.780549ms","start":"2026-04-21T19:17:41.064112Z","end":"2026-04-21T19:17:41.953893Z","steps":["trace[2006684963] 'process raft request' (duration: 889.504722ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:41.954034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.197706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.216\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-21T19:17:41.954101Z","caller":"traceutil/trace.go:171","msg":"trace[1879909911] range","detail":"{range_begin:/registry/masterleases/199.204.45.216; range_end:; response_count:1; response_revision:1038; }","duration":"413.298838ms","start":"2026-04-21T19:17:41.540789Z","end":"2026-04-21T19:17:41.954088Z","steps":["trace[1879909911] 'agreement among raft nodes before linearized reading' (duration: 413.108424ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:41.954103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:41.064101Z","time spent":"889.915863ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:17:41.95409Z","caller":"traceutil/trace.go:171","msg":"trace[2047340523] linearizableReadLoop","detail":"{readStateIndex:1081; appliedIndex:1077; }","duration":"413.063043ms","start":"2026-04-21T19:17:41.54083Z","end":"2026-04-21T19:17:41.953893Z","steps":["trace[2047340523] 'read index received' (duration: 406.50124ms)","trace[2047340523] 'applied index is now lower than readState.Index' (duration: 6.560463ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:17:41.954155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:41.54077Z","time spent":"413.353339ms","remote":"127.0.0.1:58008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.216\" "} {"level":"info","ts":"2026-04-21T19:17:43.27667Z","caller":"traceutil/trace.go:171","msg":"trace[1946188595] linearizableReadLoop","detail":"{readStateIndex:1085; appliedIndex:1084; }","duration":"221.369311ms","start":"2026-04-21T19:17:43.055278Z","end":"2026-04-21T19:17:43.276647Z","steps":["trace[1946188595] 'read index received' (duration: 221.192537ms)","trace[1946188595] 'applied index is now lower than readState.Index' (duration: 175.854µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:17:43.276702Z","caller":"traceutil/trace.go:171","msg":"trace[22631778] transaction","detail":"{read_only:false; response_revision:1040; number_of_response:1; }","duration":"490.825038ms","start":"2026-04-21T19:17:42.785845Z","end":"2026-04-21T19:17:43.27667Z","steps":["trace[22631778] 'process raft request' (duration: 490.675764ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:43.276968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.681379ms","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-21T19:17:43.277012Z","caller":"traceutil/trace.go:171","msg":"trace[1854250480] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1040; }","duration":"221.855224ms","start":"2026-04-21T19:17:43.055146Z","end":"2026-04-21T19:17:43.277001Z","steps":["trace[1854250480] 'agreement among raft nodes before linearized reading' (duration: 221.617678ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:43.277428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.265878ms","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-21T19:17:43.277473Z","caller":"traceutil/trace.go:171","msg":"trace[1266241499] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1040; }","duration":"140.352321ms","start":"2026-04-21T19:17:43.13711Z","end":"2026-04-21T19:17:43.277462Z","steps":["trace[1266241499] 'agreement among raft nodes before linearized reading' (duration: 140.259418ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:43.277658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:42.78581Z","time spent":"490.968292ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:17:43.899487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.845223ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:17:43.899606Z","caller":"traceutil/trace.go:171","msg":"trace[63070939] transaction","detail":"{read_only:false; response_revision:1041; number_of_response:1; }","duration":"617.939271ms","start":"2026-04-21T19:17:43.281646Z","end":"2026-04-21T19:17:43.899585Z","steps":["trace[63070939] 'process raft request' (duration: 203.863332ms)","trace[63070939] 'compare' (duration: 413.35539ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:17:43.899667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:43.281621Z","time spent":"618.015632ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:17:44.468487Z","caller":"traceutil/trace.go:171","msg":"trace[612639168] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"509.383736ms","start":"2026-04-21T19:17:43.959073Z","end":"2026-04-21T19:17:44.468457Z","steps":["trace[612639168] 'process raft request' (duration: 509.317614ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:44.468672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:43.959063Z","time spent":"509.517349ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:17:44.469072Z","caller":"traceutil/trace.go:171","msg":"trace[1086410633] linearizableReadLoop","detail":"{readStateIndex:1087; appliedIndex:1086; }","duration":"512.064327ms","start":"2026-04-21T19:17:43.956958Z","end":"2026-04-21T19:17:44.469023Z","steps":["trace[1086410633] 'read index received' (duration: 413.853674ms)","trace[1086410633] 'applied index is now lower than readState.Index' (duration: 98.208022ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:17:44.469123Z","caller":"traceutil/trace.go:171","msg":"trace[1815841298] transaction","detail":"{read_only:false; response_revision:1042; number_of_response:1; }","duration":"513.72588ms","start":"2026-04-21T19:17:43.955346Z","end":"2026-04-21T19:17:44.469072Z","steps":["trace[1815841298] 'process raft request' (duration: 415.488506ms)","trace[1815841298] 'compare' (duration: 97.391921ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:17:44.469354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:43.955313Z","time spent":"513.905164ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:17:44.469376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.392695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-21T19:17:44.469427Z","caller":"traceutil/trace.go:171","msg":"trace[986612001] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1043; }","duration":"512.497378ms","start":"2026-04-21T19:17:43.956914Z","end":"2026-04-21T19:17:44.469412Z","steps":["trace[986612001] 'agreement among raft nodes before linearized reading' (duration: 512.285233ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:44.469465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:43.956898Z","time spent":"512.557319ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-21T19:17:44.469442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.468048ms","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-21T19:17:44.469442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.751187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:17:44.469635Z","caller":"traceutil/trace.go:171","msg":"trace[417897472] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1043; }","duration":"206.986343ms","start":"2026-04-21T19:17:44.262627Z","end":"2026-04-21T19:17:44.469613Z","steps":["trace[417897472] 'agreement among raft nodes before linearized reading' (duration: 206.756527ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:44.469534Z","caller":"traceutil/trace.go:171","msg":"trace[1305551584] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1043; }","duration":"509.583521ms","start":"2026-04-21T19:17:43.959929Z","end":"2026-04-21T19:17:44.469512Z","steps":["trace[1305551584] 'agreement among raft nodes before linearized reading' (duration: 509.358356ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:44.469875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:43.959921Z","time spent":"509.940131ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-21T19:17:44.469551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.15892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-21T19:17:44.47005Z","caller":"traceutil/trace.go:171","msg":"trace[2006138351] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1043; }","duration":"509.658123ms","start":"2026-04-21T19:17:43.960376Z","end":"2026-04-21T19:17:44.470034Z","steps":["trace[2006138351] 'agreement among raft nodes before linearized reading' (duration: 509.047387ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:44.470087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:43.960368Z","time spent":"509.708444ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-21T19:17:45.273563Z","caller":"traceutil/trace.go:171","msg":"trace[1033681613] transaction","detail":"{read_only:false; response_revision:1047; number_of_response:1; }","duration":"118.26168ms","start":"2026-04-21T19:17:45.155274Z","end":"2026-04-21T19:17:45.273535Z","steps":["trace[1033681613] 'process raft request' (duration: 118.032224ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:59.152033Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831409885815530382,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T19:17:59.652877Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831409885815530382,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T19:17:59.880496Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.272588695s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-21T19:18:00.399057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.262909ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:18:00.399349Z","caller":"traceutil/trace.go:171","msg":"trace[1983544716] linearizableReadLoop","detail":"{readStateIndex:1194; appliedIndex:1192; }","duration":"1.74809544s","start":"2026-04-21T19:17:58.651229Z","end":"2026-04-21T19:18:00.399324Z","steps":["trace[1983544716] 'read index received' (duration: 1.229487002s)","trace[1983544716] 'applied index is now lower than readState.Index' (duration: 518.606988ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:00.399645Z","caller":"traceutil/trace.go:171","msg":"trace[563624935] transaction","detail":"{read_only:false; response_revision:1143; number_of_response:1; }","duration":"1.791801168s","start":"2026-04-21T19:17:58.607822Z","end":"2026-04-21T19:18:00.399623Z","steps":["trace[563624935] 'process raft request' (duration: 1.272870262s)","trace[563624935] 'compare' (duration: 517.320754ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:18:00.399744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:58.607808Z","time spent":"1.791882192s","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:18:00.399839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.582779673s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-21T19:18:00.39992Z","caller":"traceutil/trace.go:171","msg":"trace[1824783122] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1144; }","duration":"1.582886655s","start":"2026-04-21T19:17:58.817004Z","end":"2026-04-21T19:18:00.39989Z","steps":["trace[1824783122] 'agreement among raft nodes before linearized reading' (duration: 1.582743371s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:00.399966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:58.816981Z","time spent":"1.582975228s","remote":"127.0.0.1:58296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":70,"response size":29,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"info","ts":"2026-04-21T19:18:00.400164Z","caller":"traceutil/trace.go:171","msg":"trace[400757494] transaction","detail":"{read_only:false; response_revision:1144; number_of_response:1; }","duration":"1.791969833s","start":"2026-04-21T19:17:58.608179Z","end":"2026-04-21T19:18:00.400148Z","steps":["trace[400757494] 'process raft request' (duration: 1.791029989s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:00.40026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:58.60816Z","time spent":"1.792050215s","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:18:00.400435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.140243735s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:18:00.400455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.74922425s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:18:00.400458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.97113ms","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-21T19:18:00.400509Z","caller":"traceutil/trace.go:171","msg":"trace[1193564002] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1144; }","duration":"1.749277881s","start":"2026-04-21T19:17:58.651215Z","end":"2026-04-21T19:18:00.400493Z","steps":["trace[1193564002] 'agreement among raft nodes before linearized reading' (duration: 1.749196739s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:00.400568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:58.651122Z","time spent":"1.749433355s","remote":"127.0.0.1:57950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-21T19:18:00.40052Z","caller":"traceutil/trace.go:171","msg":"trace[583554328] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1144; }","duration":"383.074693ms","start":"2026-04-21T19:18:00.017428Z","end":"2026-04-21T19:18:00.400502Z","steps":["trace[583554328] 'agreement among raft nodes before linearized reading' (duration: 382.864797ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:00.400734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:00.01741Z","time spent":"383.29617ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-21T19:18:00.400477Z","caller":"traceutil/trace.go:171","msg":"trace[1843237236] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1144; }","duration":"1.140316427s","start":"2026-04-21T19:17:59.26015Z","end":"2026-04-21T19:18:00.400466Z","steps":["trace[1843237236] 'agreement among raft nodes before linearized reading' (duration: 1.140256726s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:00.400959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:59.260132Z","time spent":"1.140811999s","remote":"127.0.0.1:57952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-21T19:18:06.675308Z","caller":"traceutil/trace.go:171","msg":"trace[1292199288] linearizableReadLoop","detail":"{readStateIndex:1216; appliedIndex:1215; }","duration":"185.61879ms","start":"2026-04-21T19:18:06.489672Z","end":"2026-04-21T19:18:06.675291Z","steps":["trace[1292199288] 'read index received' (duration: 94.392758ms)","trace[1292199288] 'applied index is now lower than readState.Index' (duration: 91.224572ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:06.675336Z","caller":"traceutil/trace.go:171","msg":"trace[1666388589] transaction","detail":"{read_only:false; response_revision:1166; number_of_response:1; }","duration":"131.955028ms","start":"2026-04-21T19:18:06.543352Z","end":"2026-04-21T19:18:06.675307Z","steps":["trace[1666388589] 'process raft request' (duration: 131.877606ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:06.675579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.884048ms","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-21T19:18:06.675614Z","caller":"traceutil/trace.go:171","msg":"trace[2049715166] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1166; }","duration":"185.945759ms","start":"2026-04-21T19:18:06.489658Z","end":"2026-04-21T19:18:06.675604Z","steps":["trace[2049715166] 'agreement among raft nodes before linearized reading' (duration: 185.739174ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:06.675946Z","caller":"traceutil/trace.go:171","msg":"trace[1566462066] transaction","detail":"{read_only:false; response_revision:1165; number_of_response:1; }","duration":"187.492578ms","start":"2026-04-21T19:18:06.487738Z","end":"2026-04-21T19:18:06.675231Z","steps":["trace[1566462066] 'process raft request' (duration: 96.317108ms)","trace[1566462066] 'compare' (duration: 90.822472ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:18:06.679976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.52455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-21T19:18:06.679974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.523598ms","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-21T19:18:06.680013Z","caller":"traceutil/trace.go:171","msg":"trace[676585294] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1166; }","duration":"109.592202ms","start":"2026-04-21T19:18:06.570413Z","end":"2026-04-21T19:18:06.680006Z","steps":["trace[676585294] 'agreement among raft nodes before linearized reading' (duration: 109.492179ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:06.680032Z","caller":"traceutil/trace.go:171","msg":"trace[867259262] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1166; }","duration":"110.616409ms","start":"2026-04-21T19:18:06.5694Z","end":"2026-04-21T19:18:06.680017Z","steps":["trace[867259262] 'agreement among raft nodes before linearized reading' (duration: 110.452335ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:06.790968Z","caller":"traceutil/trace.go:171","msg":"trace[829541311] transaction","detail":"{read_only:false; response_revision:1169; number_of_response:1; }","duration":"107.188708ms","start":"2026-04-21T19:18:06.683745Z","end":"2026-04-21T19:18:06.790933Z","steps":["trace[829541311] 'process raft request' (duration: 106.90262ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:14.866077Z","caller":"traceutil/trace.go:171","msg":"trace[1179184407] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"146.727872ms","start":"2026-04-21T19:18:14.719302Z","end":"2026-04-21T19:18:14.86603Z","steps":["trace[1179184407] 'process raft request' (duration: 127.013147ms)","trace[1179184407] 'compare' (duration: 18.078342ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:14.869651Z","caller":"traceutil/trace.go:171","msg":"trace[667963491] transaction","detail":"{read_only:false; response_revision:1202; number_of_response:1; }","duration":"149.967468ms","start":"2026-04-21T19:18:14.719651Z","end":"2026-04-21T19:18:14.869619Z","steps":["trace[667963491] 'process raft request' (duration: 149.915837ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:14.869991Z","caller":"traceutil/trace.go:171","msg":"trace[1900608810] transaction","detail":"{read_only:false; response_revision:1201; number_of_response:1; }","duration":"150.580986ms","start":"2026-04-21T19:18:14.719395Z","end":"2026-04-21T19:18:14.869976Z","steps":["trace[1900608810] 'process raft request' (duration: 150.017171ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:16.687393Z","caller":"traceutil/trace.go:171","msg":"trace[756524003] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"116.392983ms","start":"2026-04-21T19:18:16.570981Z","end":"2026-04-21T19:18:16.687374Z","steps":["trace[756524003] 'process raft request' (duration: 116.287261ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:17.077483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.606979ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"warn","ts":"2026-04-21T19:18:17.281612Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831409885815530550,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T19:18:17.782789Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831409885815530550,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T19:18:17.835953Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.073092122s","expected-duration":"1s"} {"level":"info","ts":"2026-04-21T19:18:17.836244Z","caller":"traceutil/trace.go:171","msg":"trace[830466306] linearizableReadLoop","detail":"{readStateIndex:1272; appliedIndex:1271; }","duration":"1.05575379s","start":"2026-04-21T19:18:16.780474Z","end":"2026-04-21T19:18:17.836228Z","steps":["trace[830466306] 'read index received' (duration: 1.055601266s)","trace[830466306] 'applied index is now lower than readState.Index' (duration: 150.024µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:17.836491Z","caller":"traceutil/trace.go:171","msg":"trace[492230899] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"1.115978086s","start":"2026-04-21T19:18:16.720504Z","end":"2026-04-21T19:18:17.836482Z","steps":["trace[492230899] 'process raft request' (duration: 1.115619406s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:17.836567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:16.720481Z","time spent":"1.116035267s","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:18:17.836703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.056235223s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-21T19:18:17.836729Z","caller":"traceutil/trace.go:171","msg":"trace[87016973] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1218; }","duration":"1.056304975s","start":"2026-04-21T19:18:16.780418Z","end":"2026-04-21T19:18:17.836723Z","steps":["trace[87016973] 'agreement among raft nodes before linearized reading' (duration: 1.056259734s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:17.83675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:16.780398Z","time spent":"1.056346665s","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":5,"response size":29,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"warn","ts":"2026-04-21T19:18:17.837051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.782414ms","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:7"} {"level":"warn","ts":"2026-04-21T19:18:17.837068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"966.013587ms","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-21T19:18:17.837093Z","caller":"traceutil/trace.go:171","msg":"trace[1329251645] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1218; }","duration":"209.827155ms","start":"2026-04-21T19:18:17.627256Z","end":"2026-04-21T19:18:17.837083Z","steps":["trace[1329251645] 'agreement among raft nodes before linearized reading' (duration: 209.763503ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:17.837139Z","caller":"traceutil/trace.go:171","msg":"trace[2119914704] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1218; }","duration":"966.12187ms","start":"2026-04-21T19:18:16.870998Z","end":"2026-04-21T19:18:17.837119Z","steps":["trace[2119914704] 'agreement among raft nodes before linearized reading' (duration: 965.846102ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:17.837145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"960.689745ms","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-21T19:18:17.837183Z","caller":"traceutil/trace.go:171","msg":"trace[1114084899] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1218; }","duration":"960.758826ms","start":"2026-04-21T19:18:16.876413Z","end":"2026-04-21T19:18:17.837172Z","steps":["trace[1114084899] 'agreement among raft nodes before linearized reading' (duration: 960.622603ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:17.837182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:16.870951Z","time spent":"966.220632ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-21T19:18:17.837209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:16.876399Z","time spent":"960.803169ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-21T19:18:17.837176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"877.624731ms","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-21T19:18:17.837187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"959.634407ms","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-21T19:18:17.837272Z","caller":"traceutil/trace.go:171","msg":"trace[82878245] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1218; }","duration":"959.7778ms","start":"2026-04-21T19:18:16.877477Z","end":"2026-04-21T19:18:17.837255Z","steps":["trace[82878245] 'agreement among raft nodes before linearized reading' (duration: 959.42972ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:17.837269Z","caller":"traceutil/trace.go:171","msg":"trace[682518699] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1218; }","duration":"877.812296ms","start":"2026-04-21T19:18:16.959434Z","end":"2026-04-21T19:18:17.837246Z","steps":["trace[682518699] 'agreement among raft nodes before linearized reading' (duration: 877.486737ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:17.83733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:16.877468Z","time spent":"959.849333ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-21T19:18:17.83733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:16.959413Z","time spent":"877.904618ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-21T19:18:19.070445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.491379ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:18:19.07058Z","caller":"traceutil/trace.go:171","msg":"trace[1996504201] linearizableReadLoop","detail":"{readStateIndex:1280; appliedIndex:1278; }","duration":"387.42512ms","start":"2026-04-21T19:18:18.68314Z","end":"2026-04-21T19:18:19.070565Z","steps":["trace[1996504201] 'read index received' (duration: 40.775097ms)","trace[1996504201] 'applied index is now lower than readState.Index' (duration: 346.649143ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:19.070737Z","caller":"traceutil/trace.go:171","msg":"trace[232447645] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"624.494511ms","start":"2026-04-21T19:18:18.446231Z","end":"2026-04-21T19:18:19.070726Z","steps":["trace[232447645] 'process raft request' (duration: 277.672493ms)","trace[232447645] 'compare' (duration: 345.981486ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:18:19.070792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:18.446203Z","time spent":"624.562252ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T19:18:19.070945Z","caller":"traceutil/trace.go:171","msg":"trace[1368910963] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"609.156312ms","start":"2026-04-21T19:18:18.46178Z","end":"2026-04-21T19:18:19.070937Z","steps":["trace[1368910963] 'process raft request' (duration: 608.739301ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:19.070995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:18.461758Z","time spent":"609.212103ms","remote":"127.0.0.1:58046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T19:18:19.071654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.048286ms","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-21T19:18:19.071708Z","caller":"traceutil/trace.go:171","msg":"trace[822581204] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1226; }","duration":"388.58615ms","start":"2026-04-21T19:18:18.683097Z","end":"2026-04-21T19:18:19.071683Z","steps":["trace[822581204] 'agreement among raft nodes before linearized reading' (duration: 388.033686ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:19.071747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:18.683078Z","time spent":"388.657223ms","remote":"127.0.0.1:33842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"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-21T19:18:19.072116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.692357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-21T19:18:19.072151Z","caller":"traceutil/trace.go:171","msg":"trace[525920140] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1226; }","duration":"381.773219ms","start":"2026-04-21T19:18:18.690369Z","end":"2026-04-21T19:18:19.072142Z","steps":["trace[525920140] 'agreement among raft nodes before linearized reading' (duration: 381.600985ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:19.072185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:18.690349Z","time spent":"381.828301ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-21T19:18:19.072469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.378929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:18:19.072506Z","caller":"traceutil/trace.go:171","msg":"trace[1943045431] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1226; }","duration":"219.445111ms","start":"2026-04-21T19:18:18.853052Z","end":"2026-04-21T19:18:19.072497Z","steps":["trace[1943045431] 'agreement among raft nodes before linearized reading' (duration: 219.384799ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:19.07267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.263093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:18:19.072702Z","caller":"traceutil/trace.go:171","msg":"trace[1844272580] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1226; }","duration":"316.335825ms","start":"2026-04-21T19:18:18.756358Z","end":"2026-04-21T19:18:19.072694Z","steps":["trace[1844272580] 'agreement among raft nodes before linearized reading' (duration: 316.283564ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:19.072732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:18.756333Z","time spent":"316.390966ms","remote":"127.0.0.1:48708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"warn","ts":"2026-04-21T19:18:19.578464Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831409885815530569,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T19:18:19.831117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.602828ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:18:19.831314Z","caller":"traceutil/trace.go:171","msg":"trace[1068911258] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"755.270347ms","start":"2026-04-21T19:18:19.076018Z","end":"2026-04-21T19:18:19.831289Z","steps":["trace[1068911258] 'process raft request' (duration: 527.421313ms)","trace[1068911258] 'compare' (duration: 227.430254ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:18:19.83139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:19.076001Z","time spent":"755.35529ms","remote":"127.0.0.1:58046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":773,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T19:18:20.104189Z","caller":"traceutil/trace.go:171","msg":"trace[681795881] linearizableReadLoop","detail":"{readStateIndex:1283; appliedIndex:1280; }","duration":"1.026395326s","start":"2026-04-21T19:18:19.077767Z","end":"2026-04-21T19:18:20.104163Z","steps":["trace[681795881] 'read index received' (duration: 525.683516ms)","trace[681795881] 'applied index is now lower than readState.Index' (duration: 500.71062ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:20.10429Z","caller":"traceutil/trace.go:171","msg":"trace[981346973] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"1.026270934s","start":"2026-04-21T19:18:19.077977Z","end":"2026-04-21T19:18:20.104248Z","steps":["trace[981346973] 'process raft request' (duration: 976.788734ms)","trace[981346973] 'compare' (duration: 49.138981ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:20.104329Z","caller":"traceutil/trace.go:171","msg":"trace[1299905411] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"1.026324815s","start":"2026-04-21T19:18:19.077988Z","end":"2026-04-21T19:18:20.104313Z","steps":["trace[1299905411] 'process raft request' (duration: 1.026084979s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:20.104409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:19.077961Z","time spent":"1.026388416s","remote":"127.0.0.1:58046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":836,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T19:18:20.104491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:19.077974Z","time spent":"1.026392517s","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:18:20.104508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.026730875s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-04-21T19:18:20.104564Z","caller":"traceutil/trace.go:171","msg":"trace[414762843] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1229; }","duration":"1.026826468s","start":"2026-04-21T19:18:19.077725Z","end":"2026-04-21T19:18:20.104551Z","steps":["trace[414762843] 'agreement among raft nodes before linearized reading' (duration: 1.026674203s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:20.104596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:19.077701Z","time spent":"1.02688729s","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-04-21T19:18:20.268133Z","caller":"traceutil/trace.go:171","msg":"trace[322825384] linearizableReadLoop","detail":"{readStateIndex:1284; appliedIndex:1283; }","duration":"163.805278ms","start":"2026-04-21T19:18:20.104268Z","end":"2026-04-21T19:18:20.268073Z","steps":["trace[322825384] 'read index received' (duration: 108.213226ms)","trace[322825384] 'applied index is now lower than readState.Index' (duration: 55.590882ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:20.268258Z","caller":"traceutil/trace.go:171","msg":"trace[1229640367] transaction","detail":"{read_only:false; response_revision:1231; number_of_response:1; }","duration":"159.574955ms","start":"2026-04-21T19:18:20.108664Z","end":"2026-04-21T19:18:20.268239Z","steps":["trace[1229640367] 'process raft request' (duration: 159.356709ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:20.268495Z","caller":"traceutil/trace.go:171","msg":"trace[3967244] transaction","detail":"{read_only:false; response_revision:1230; number_of_response:1; }","duration":"424.349086ms","start":"2026-04-21T19:18:19.844081Z","end":"2026-04-21T19:18:20.26843Z","steps":["trace[3967244] 'process raft request' (duration: 368.451735ms)","trace[3967244] 'compare' (duration: 55.115239ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:18:20.268858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.903699ms","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-21T19:18:20.269594Z","caller":"traceutil/trace.go:171","msg":"trace[2093347952] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1231; }","duration":"407.711991ms","start":"2026-04-21T19:18:19.86187Z","end":"2026-04-21T19:18:20.269582Z","steps":["trace[2093347952] 'agreement among raft nodes before linearized reading' (duration: 406.755626ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:20.269525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:19.844049Z","time spent":"425.351052ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:18:20.26963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:19.861813Z","time spent":"407.805623ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-21T19:18:20.268965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.906692ms","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-21T19:18:20.270128Z","caller":"traceutil/trace.go:171","msg":"trace[1098439178] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1231; }","duration":"350.085604ms","start":"2026-04-21T19:18:19.920034Z","end":"2026-04-21T19:18:20.27012Z","steps":["trace[1098439178] 'agreement among raft nodes before linearized reading' (duration: 348.899832ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:20.27016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:19.920027Z","time spent":"350.126155ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-21T19:18:20.269004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.999745ms","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-21T19:18:20.270217Z","caller":"traceutil/trace.go:171","msg":"trace[161313757] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1231; }","duration":"350.258509ms","start":"2026-04-21T19:18:19.919953Z","end":"2026-04-21T19:18:20.270212Z","steps":["trace[161313757] 'agreement among raft nodes before linearized reading' (duration: 349.021555ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:20.270235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:19.919924Z","time spent":"350.30593ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-21T19:18:20.269225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.021369ms","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-21T19:18:20.268921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.647836ms","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-21T19:18:20.270306Z","caller":"traceutil/trace.go:171","msg":"trace[372158980] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1231; }","duration":"553.185979ms","start":"2026-04-21T19:18:19.717091Z","end":"2026-04-21T19:18:20.270277Z","steps":["trace[372158980] 'agreement among raft nodes before linearized reading' (duration: 552.019779ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:20.270373Z","caller":"traceutil/trace.go:171","msg":"trace[393040687] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1231; }","duration":"350.113054ms","start":"2026-04-21T19:18:19.92025Z","end":"2026-04-21T19:18:20.270363Z","steps":["trace[393040687] 'agreement among raft nodes before linearized reading' (duration: 348.629425ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:20.270401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:19.92024Z","time spent":"350.152876ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-21T19:18:20.27042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:19.717069Z","time spent":"553.310493ms","remote":"127.0.0.1:33874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"info","ts":"2026-04-21T19:18:24.449084Z","caller":"traceutil/trace.go:171","msg":"trace[793585516] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"168.526093ms","start":"2026-04-21T19:18:24.280497Z","end":"2026-04-21T19:18:24.449023Z","steps":["trace[793585516] 'process raft request' (duration: 168.345829ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:24.449637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.963065ms","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-21T19:18:24.449107Z","caller":"traceutil/trace.go:171","msg":"trace[524966907] linearizableReadLoop","detail":"{readStateIndex:1313; appliedIndex:1313; }","duration":"156.42039ms","start":"2026-04-21T19:18:24.292655Z","end":"2026-04-21T19:18:24.449076Z","steps":["trace[524966907] 'read index received' (duration: 156.375899ms)","trace[524966907] 'applied index is now lower than readState.Index' (duration: 42.481µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:24.449963Z","caller":"traceutil/trace.go:171","msg":"trace[742855742] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1258; }","duration":"157.324304ms","start":"2026-04-21T19:18:24.292619Z","end":"2026-04-21T19:18:24.449944Z","steps":["trace[742855742] 'agreement among raft nodes before linearized reading' (duration: 156.528283ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:24.470721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.243099ms","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-21T19:18:24.470777Z","caller":"traceutil/trace.go:171","msg":"trace[1442986672] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1259; }","duration":"155.344542ms","start":"2026-04-21T19:18:24.315419Z","end":"2026-04-21T19:18:24.470763Z","steps":["trace[1442986672] 'agreement among raft nodes before linearized reading' (duration: 155.189088ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:24.470778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.391984ms","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-21T19:18:24.470728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.331678ms","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-21T19:18:24.47089Z","caller":"traceutil/trace.go:171","msg":"trace[1611591263] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1259; }","duration":"152.497506ms","start":"2026-04-21T19:18:24.31833Z","end":"2026-04-21T19:18:24.470827Z","steps":["trace[1611591263] 'agreement among raft nodes before linearized reading' (duration: 152.308461ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:24.470941Z","caller":"traceutil/trace.go:171","msg":"trace[1670399570] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1259; }","duration":"153.568124ms","start":"2026-04-21T19:18:24.317358Z","end":"2026-04-21T19:18:24.470926Z","steps":["trace[1670399570] 'agreement among raft nodes before linearized reading' (duration: 153.292937ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:26.254457Z","caller":"traceutil/trace.go:171","msg":"trace[1182506868] linearizableReadLoop","detail":"{readStateIndex:1320; appliedIndex:1319; }","duration":"105.988937ms","start":"2026-04-21T19:18:26.14845Z","end":"2026-04-21T19:18:26.254439Z","steps":["trace[1182506868] 'read index received' (duration: 105.751421ms)","trace[1182506868] 'applied index is now lower than readState.Index' (duration: 236.806µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:26.254502Z","caller":"traceutil/trace.go:171","msg":"trace[1537335826] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"122.001883ms","start":"2026-04-21T19:18:26.132481Z","end":"2026-04-21T19:18:26.254482Z","steps":["trace[1537335826] 'process raft request' (duration: 121.813079ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:26.254544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.093969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:18:26.254566Z","caller":"traceutil/trace.go:171","msg":"trace[510327498] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1265; }","duration":"106.13582ms","start":"2026-04-21T19:18:26.148423Z","end":"2026-04-21T19:18:26.254559Z","steps":["trace[510327498] 'agreement among raft nodes before linearized reading' (duration: 106.080809ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:26.668206Z","caller":"traceutil/trace.go:171","msg":"trace[680509406] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"152.540278ms","start":"2026-04-21T19:18:26.51564Z","end":"2026-04-21T19:18:26.668181Z","steps":["trace[680509406] 'process raft request' (duration: 152.512817ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:26.668495Z","caller":"traceutil/trace.go:171","msg":"trace[2106132477] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"155.104736ms","start":"2026-04-21T19:18:26.513385Z","end":"2026-04-21T19:18:26.66849Z","steps":["trace[2106132477] 'process raft request' (duration: 154.647234ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:26.668567Z","caller":"traceutil/trace.go:171","msg":"trace[1464287674] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"153.05618ms","start":"2026-04-21T19:18:26.515506Z","end":"2026-04-21T19:18:26.668562Z","steps":["trace[1464287674] 'process raft request' (duration: 152.62448ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:26.978Z","caller":"traceutil/trace.go:171","msg":"trace[568722384] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"152.591989ms","start":"2026-04-21T19:18:26.82538Z","end":"2026-04-21T19:18:26.977972Z","steps":["trace[568722384] 'process raft request' (duration: 152.486206ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:28.958059Z","caller":"traceutil/trace.go:171","msg":"trace[920371165] linearizableReadLoop","detail":"{readStateIndex:1350; appliedIndex:1349; }","duration":"364.926471ms","start":"2026-04-21T19:18:28.593109Z","end":"2026-04-21T19:18:28.958035Z","steps":["trace[920371165] 'read index received' (duration: 364.671844ms)","trace[920371165] 'applied index is now lower than readState.Index' (duration: 253.657µs)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:18:28.958221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.473405ms","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-21T19:18:28.958257Z","caller":"traceutil/trace.go:171","msg":"trace[1359979830] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1294; }","duration":"290.573337ms","start":"2026-04-21T19:18:28.667672Z","end":"2026-04-21T19:18:28.958245Z","steps":["trace[1359979830] 'agreement among raft nodes before linearized reading' (duration: 290.493015ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:28.958347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.159284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-21T19:18:28.958423Z","caller":"traceutil/trace.go:171","msg":"trace[1663205979] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1294; }","duration":"174.290768ms","start":"2026-04-21T19:18:28.784116Z","end":"2026-04-21T19:18:28.958407Z","steps":["trace[1663205979] 'agreement among raft nodes before linearized reading' (duration: 174.151704ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:28.958581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.342948ms","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-21T19:18:28.958624Z","caller":"traceutil/trace.go:171","msg":"trace[877934421] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1294; }","duration":"285.407349ms","start":"2026-04-21T19:18:28.673208Z","end":"2026-04-21T19:18:28.958615Z","steps":["trace[877934421] 'agreement among raft nodes before linearized reading' (duration: 285.277356ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:28.958771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.538063ms","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-21T19:18:28.958823Z","caller":"traceutil/trace.go:171","msg":"trace[1702014216] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1294; }","duration":"285.625076ms","start":"2026-04-21T19:18:28.673187Z","end":"2026-04-21T19:18:28.958812Z","steps":["trace[1702014216] 'agreement among raft nodes before linearized reading' (duration: 285.477432ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:28.959144Z","caller":"traceutil/trace.go:171","msg":"trace[147879426] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"482.017962ms","start":"2026-04-21T19:18:28.476057Z","end":"2026-04-21T19:18:28.958075Z","steps":["trace[147879426] 'process raft request' (duration: 481.826646ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:28.959138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.990409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-21T19:18:28.959562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.218712ms","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-21T19:18:28.959663Z","caller":"traceutil/trace.go:171","msg":"trace[309374940] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1294; }","duration":"286.379446ms","start":"2026-04-21T19:18:28.673264Z","end":"2026-04-21T19:18:28.959643Z","steps":["trace[309374940] 'agreement among raft nodes before linearized reading' (duration: 284.990439ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:28.959291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:28.476036Z","time spent":"483.182223ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:18:28.960152Z","caller":"traceutil/trace.go:171","msg":"trace[522017361] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1294; }","duration":"366.306138ms","start":"2026-04-21T19:18:28.593059Z","end":"2026-04-21T19:18:28.959365Z","steps":["trace[522017361] 'agreement among raft nodes before linearized reading' (duration: 365.217178ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:28.960439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:28.593039Z","time spent":"367.377955ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-21T19:18:29.700831Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831409885815530691,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T19:18:30.145068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.263672ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:18:30.145153Z","caller":"traceutil/trace.go:171","msg":"trace[461190893] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"1.182030296s","start":"2026-04-21T19:18:28.963105Z","end":"2026-04-21T19:18:30.145135Z","steps":["trace[461190893] 'process raft request' (duration: 784.631731ms)","trace[461190893] 'compare' (duration: 396.909993ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:18:30.145207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:28.963082Z","time spent":"1.182097307s","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:18:30.149198Z","caller":"traceutil/trace.go:171","msg":"trace[963380447] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"1.185493428s","start":"2026-04-21T19:18:28.963693Z","end":"2026-04-21T19:18:30.149187Z","steps":["trace[963380447] 'process raft request' (duration: 1.185389015s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:30.14926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:28.963555Z","time spent":"1.185674932s","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:18:30.149476Z","caller":"traceutil/trace.go:171","msg":"trace[1192813024] linearizableReadLoop","detail":"{readStateIndex:1354; appliedIndex:1350; }","duration":"949.264609ms","start":"2026-04-21T19:18:29.200186Z","end":"2026-04-21T19:18:30.149451Z","steps":["trace[1192813024] 'read index received' (duration: 547.584609ms)","trace[1192813024] 'applied index is now lower than readState.Index' (duration: 401.6791ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:30.149636Z","caller":"traceutil/trace.go:171","msg":"trace[12181041] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"1.184296197s","start":"2026-04-21T19:18:28.965322Z","end":"2026-04-21T19:18:30.149618Z","steps":["trace[12181041] 'process raft request' (duration: 1.183844335s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:30.149754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:28.9653Z","time spent":"1.184372618s","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:18:30.149887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"938.283287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-04-21T19:18:30.149913Z","caller":"traceutil/trace.go:171","msg":"trace[995124355] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1298; }","duration":"938.349048ms","start":"2026-04-21T19:18:29.211558Z","end":"2026-04-21T19:18:30.149907Z","steps":["trace[995124355] 'agreement among raft nodes before linearized reading' (duration: 938.247616ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:30.149929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:29.211538Z","time spent":"938.38734ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":552,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-04-21T19:18:30.149985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"885.086808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:18:30.15Z","caller":"traceutil/trace.go:171","msg":"trace[1890039862] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1298; }","duration":"885.1377ms","start":"2026-04-21T19:18:29.264859Z","end":"2026-04-21T19:18:30.149996Z","steps":["trace[1890039862] 'agreement among raft nodes before linearized reading' (duration: 885.115789ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:30.150012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:29.264839Z","time spent":"885.170191ms","remote":"127.0.0.1:57950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-21T19:18:30.150184Z","caller":"traceutil/trace.go:171","msg":"trace[1352721402] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"1.18369591s","start":"2026-04-21T19:18:28.966482Z","end":"2026-04-21T19:18:30.150178Z","steps":["trace[1352721402] 'process raft request' (duration: 1.182885519s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:30.150219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:28.966471Z","time spent":"1.183730761s","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:18:30.150371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"950.168933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-04-21T19:18:30.151772Z","caller":"traceutil/trace.go:171","msg":"trace[2053799949] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1298; }","duration":"951.605793ms","start":"2026-04-21T19:18:29.200144Z","end":"2026-04-21T19:18:30.15175Z","steps":["trace[2053799949] 'agreement among raft nodes before linearized reading' (duration: 949.602019ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:30.151883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:29.200124Z","time spent":"951.742037ms","remote":"127.0.0.1:58212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-04-21T19:18:32.257408Z","caller":"traceutil/trace.go:171","msg":"trace[951252541] linearizableReadLoop","detail":"{readStateIndex:1363; appliedIndex:1362; }","duration":"102.924324ms","start":"2026-04-21T19:18:32.15446Z","end":"2026-04-21T19:18:32.257384Z","steps":["trace[951252541] 'read index received' (duration: 101.511196ms)","trace[951252541] 'applied index is now lower than readState.Index' (duration: 1.412058ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:32.257623Z","caller":"traceutil/trace.go:171","msg":"trace[1853514691] transaction","detail":"{read_only:false; response_revision:1306; number_of_response:1; }","duration":"103.972352ms","start":"2026-04-21T19:18:32.153639Z","end":"2026-04-21T19:18:32.257611Z","steps":["trace[1853514691] 'process raft request' (duration: 102.216464ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:32.257912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.445308ms","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-21T19:18:32.257971Z","caller":"traceutil/trace.go:171","msg":"trace[373579043] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1306; }","duration":"103.51678ms","start":"2026-04-21T19:18:32.154442Z","end":"2026-04-21T19:18:32.257959Z","steps":["trace[373579043] 'agreement among raft nodes before linearized reading' (duration: 103.365576ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:32.258628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.743109ms","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-21T19:18:32.258696Z","caller":"traceutil/trace.go:171","msg":"trace[1344208197] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1307; }","duration":"102.854252ms","start":"2026-04-21T19:18:32.155825Z","end":"2026-04-21T19:18:32.258679Z","steps":["trace[1344208197] 'agreement among raft nodes before linearized reading' (duration: 102.664887ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:32.25904Z","caller":"traceutil/trace.go:171","msg":"trace[1409796189] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"102.147214ms","start":"2026-04-21T19:18:32.156882Z","end":"2026-04-21T19:18:32.259029Z","steps":["trace[1409796189] 'process raft request' (duration: 101.492886ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:32.369131Z","caller":"traceutil/trace.go:171","msg":"trace[791611986] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"101.455305ms","start":"2026-04-21T19:18:32.267655Z","end":"2026-04-21T19:18:32.36911Z","steps":["trace[791611986] 'process raft request' (duration: 90.069592ms)","trace[791611986] 'compare' (duration: 11.253659ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:32.369563Z","caller":"traceutil/trace.go:171","msg":"trace[901100236] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"100.533191ms","start":"2026-04-21T19:18:32.269021Z","end":"2026-04-21T19:18:32.369555Z","steps":["trace[901100236] 'process raft request' (duration: 100.060228ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:34.459401Z","caller":"traceutil/trace.go:171","msg":"trace[1937104323] transaction","detail":"{read_only:false; response_revision:1316; number_of_response:1; }","duration":"118.060228ms","start":"2026-04-21T19:18:34.341318Z","end":"2026-04-21T19:18:34.459379Z","steps":["trace[1937104323] 'process raft request' (duration: 115.927221ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:35.349124Z","caller":"traceutil/trace.go:171","msg":"trace[467998087] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"126.738899ms","start":"2026-04-21T19:18:35.222343Z","end":"2026-04-21T19:18:35.349082Z","steps":["trace[467998087] 'process raft request' (duration: 55.036678ms)","trace[467998087] 'compare' (duration: 71.314811ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:22:44.000946Z","caller":"traceutil/trace.go:171","msg":"trace[349132271] transaction","detail":"{read_only:false; response_revision:2509; number_of_response:1; }","duration":"126.831308ms","start":"2026-04-21T19:22:43.874081Z","end":"2026-04-21T19:22:44.000913Z","steps":["trace[349132271] 'process raft request' (duration: 80.352726ms)","trace[349132271] 'compare' (duration: 46.236506ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:22:44.001085Z","caller":"traceutil/trace.go:171","msg":"trace[146868964] linearizableReadLoop","detail":"{readStateIndex:2619; appliedIndex:2617; }","duration":"115.750289ms","start":"2026-04-21T19:22:43.885306Z","end":"2026-04-21T19:22:44.001056Z","steps":["trace[146868964] 'read index received' (duration: 69.147304ms)","trace[146868964] 'applied index is now lower than readState.Index' (duration: 46.600865ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:22:44.001211Z","caller":"traceutil/trace.go:171","msg":"trace[433454308] transaction","detail":"{read_only:false; response_revision:2510; number_of_response:1; }","duration":"126.471658ms","start":"2026-04-21T19:22:43.87469Z","end":"2026-04-21T19:22:44.001162Z","steps":["trace[433454308] 'process raft request' (duration: 126.1496ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:22:44.001547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.224402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-04-21T19:22:44.001684Z","caller":"traceutil/trace.go:171","msg":"trace[1214053723] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2510; }","duration":"116.348575ms","start":"2026-04-21T19:22:43.885247Z","end":"2026-04-21T19:22:44.001595Z","steps":["trace[1214053723] 'agreement among raft nodes before linearized reading' (duration: 115.955565ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:23:58.304362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.579234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:23:58.304451Z","caller":"traceutil/trace.go:171","msg":"trace[825469927] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:2857; }","duration":"122.700937ms","start":"2026-04-21T19:23:58.181727Z","end":"2026-04-21T19:23:58.304428Z","steps":["trace[825469927] 'count revisions from in-memory index tree' (duration: 122.525491ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:23:58.304507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.585159ms","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-21T19:23:58.304564Z","caller":"traceutil/trace.go:171","msg":"trace[1915028572] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2857; }","duration":"104.659621ms","start":"2026-04-21T19:23:58.199892Z","end":"2026-04-21T19:23:58.304551Z","steps":["trace[1915028572] 'range keys from in-memory index tree' (duration: 104.506357ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:23:58.498004Z","caller":"traceutil/trace.go:171","msg":"trace[708357389] linearizableReadLoop","detail":"{readStateIndex:2983; appliedIndex:2981; }","duration":"162.997146ms","start":"2026-04-21T19:23:58.334977Z","end":"2026-04-21T19:23:58.497974Z","steps":["trace[708357389] 'read index received' (duration: 32.374936ms)","trace[708357389] 'applied index is now lower than readState.Index' (duration: 130.62081ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:23:58.498167Z","caller":"traceutil/trace.go:171","msg":"trace[199208081] transaction","detail":"{read_only:false; response_revision:2859; number_of_response:1; }","duration":"169.710949ms","start":"2026-04-21T19:23:58.328389Z","end":"2026-04-21T19:23:58.4981Z","steps":["trace[199208081] 'process raft request' (duration: 116.815995ms)","trace[199208081] 'compare' (duration: 52.635637ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:23:58.498251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.248792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-21T19:23:58.498288Z","caller":"traceutil/trace.go:171","msg":"trace[958527490] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2859; }","duration":"163.304274ms","start":"2026-04-21T19:23:58.334973Z","end":"2026-04-21T19:23:58.498277Z","steps":["trace[958527490] 'agreement among raft nodes before linearized reading' (duration: 163.151569ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:23:58.498423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.702387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-21T19:23:58.498457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.767696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-after-finished-controller\" ","response":"range_response_count:1 size:224"} {"level":"info","ts":"2026-04-21T19:23:58.498505Z","caller":"traceutil/trace.go:171","msg":"trace[1074333357] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-after-finished-controller; range_end:; response_count:1; response_revision:2859; }","duration":"106.856947ms","start":"2026-04-21T19:23:58.391633Z","end":"2026-04-21T19:23:58.49849Z","steps":["trace[1074333357] 'agreement among raft nodes before linearized reading' (duration: 106.742834ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:23:58.498515Z","caller":"traceutil/trace.go:171","msg":"trace[743791035] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2859; }","duration":"160.83744ms","start":"2026-04-21T19:23:58.337649Z","end":"2026-04-21T19:23:58.498487Z","steps":["trace[743791035] 'agreement among raft nodes before linearized reading' (duration: 160.575124ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:23:58.498526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.912181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/token-cleaner\" ","response":"range_response_count:1 size:191"} {"level":"info","ts":"2026-04-21T19:23:58.498562Z","caller":"traceutil/trace.go:171","msg":"trace[284109666] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/token-cleaner; range_end:; response_count:1; response_revision:2859; }","duration":"115.971843ms","start":"2026-04-21T19:23:58.382581Z","end":"2026-04-21T19:23:58.498553Z","steps":["trace[284109666] 'agreement among raft nodes before linearized reading' (duration: 115.912811ms)"],"step_count":1}