{"level":"warn","ts":"2026-07-14T22:57:18.467957Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-14T22:57:18.468056Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.3: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.3:2380","--initial-cluster=instance=https://199.204.45.3:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.3:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.3:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-07-14T22:57:18.46813Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-14T22:57:18.468146Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.3:2380"]} {"level":"info","ts":"2026-07-14T22:57:18.468162Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-14T22:57:18.468777Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"]} {"level":"info","ts":"2026-07-14T22:57:18.468852Z","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.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.3:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-07-14T22:57:18.473948Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.875461ms"} {"level":"info","ts":"2026-07-14T22:57:18.482482Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"597401b06ce1cf3d","cluster-id":"dfc54657ad8a2432"} {"level":"info","ts":"2026-07-14T22:57:18.482557Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=()"} {"level":"info","ts":"2026-07-14T22:57:18.482574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 0"} {"level":"info","ts":"2026-07-14T22:57:18.482584Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 597401b06ce1cf3d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-14T22:57:18.482592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 1"} {"level":"info","ts":"2026-07-14T22:57:18.482625Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"} {"level":"warn","ts":"2026-07-14T22:57:18.494405Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-14T22:57:18.496551Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-14T22:57:18.497385Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-07-14T22:57:18.499602Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"597401b06ce1cf3d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-14T22:57:18.499728Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-14T22:57:18.499805Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-14T22:57:18.499818Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-14T22:57:18.499982Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"597401b06ce1cf3d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-14T22:57:18.501329Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"} {"level":"info","ts":"2026-07-14T22:57:18.501621Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","added-peer-id":"597401b06ce1cf3d","added-peer-peer-urls":["https://199.204.45.3:2380"]} {"level":"info","ts":"2026-07-14T22:57:18.503248Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-14T22:57:18.503451Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"597401b06ce1cf3d","initial-advertise-peer-urls":["https://199.204.45.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-14T22:57:18.503506Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-14T22:57:18.503477Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.3:2380"} {"level":"info","ts":"2026-07-14T22:57:18.503545Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.3:2380"} {"level":"info","ts":"2026-07-14T22:57:18.788609Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d is starting a new election at term 1"} {"level":"info","ts":"2026-07-14T22:57:18.788666Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became pre-candidate at term 1"} {"level":"info","ts":"2026-07-14T22:57:18.788692Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgPreVoteResp from 597401b06ce1cf3d at term 1"} {"level":"info","ts":"2026-07-14T22:57:18.788717Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became candidate at term 2"} {"level":"info","ts":"2026-07-14T22:57:18.788729Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgVoteResp from 597401b06ce1cf3d at term 2"} {"level":"info","ts":"2026-07-14T22:57:18.78874Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became leader at term 2"} {"level":"info","ts":"2026-07-14T22:57:18.788749Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 597401b06ce1cf3d elected leader 597401b06ce1cf3d at term 2"} {"level":"info","ts":"2026-07-14T22:57:18.789546Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T22:57:18.790403Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-14T22:57:18.790408Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"597401b06ce1cf3d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.3:2379]}","request-path":"/0/members/597401b06ce1cf3d/attributes","cluster-id":"dfc54657ad8a2432","publish-timeout":"7s"} {"level":"info","ts":"2026-07-14T22:57:18.790746Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-14T22:57:18.79114Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-14T22:57:18.791156Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-14T22:57:18.792623Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.3:2379"} {"level":"info","ts":"2026-07-14T22:57:18.792905Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-14T22:57:18.795006Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T22:57:18.795242Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T22:57:18.795458Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T22:57:50.779713Z","caller":"traceutil/trace.go:171","msg":"trace[2051072187] linearizableReadLoop","detail":"{readStateIndex:496; appliedIndex:495; }","duration":"262.610119ms","start":"2026-07-14T22:57:50.517082Z","end":"2026-07-14T22:57:50.779692Z","steps":["trace[2051072187] 'read index received' (duration: 262.566888ms)","trace[2051072187] 'applied index is now lower than readState.Index' (duration: 42.161µs)"],"step_count":2} {"level":"info","ts":"2026-07-14T22:57:50.77982Z","caller":"traceutil/trace.go:171","msg":"trace[453313071] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"302.411299ms","start":"2026-07-14T22:57:50.477364Z","end":"2026-07-14T22:57:50.779776Z","steps":["trace[453313071] 'process raft request' (duration: 302.216543ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:57:50.779909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.812725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-14T22:57:50.780015Z","caller":"traceutil/trace.go:171","msg":"trace[217977461] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:476; }","duration":"262.96851ms","start":"2026-07-14T22:57:50.517026Z","end":"2026-07-14T22:57:50.779994Z","steps":["trace[217977461] 'agreement among raft nodes before linearized reading' (duration: 262.760903ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:57:50.780548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:57:50.477352Z","time spent":"302.574264ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T22:57:53.991089Z","caller":"traceutil/trace.go:171","msg":"trace[1443829628] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"102.660608ms","start":"2026-07-14T22:57:53.888405Z","end":"2026-07-14T22:57:53.991065Z","steps":["trace[1443829628] 'process raft request' (duration: 102.378139ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T22:57:53.99475Z","caller":"traceutil/trace.go:171","msg":"trace[683388513] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"100.585213ms","start":"2026-07-14T22:57:53.894141Z","end":"2026-07-14T22:57:53.994727Z","steps":["trace[683388513] 'process raft request' (duration: 100.216951ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T22:57:59.999301Z","caller":"traceutil/trace.go:171","msg":"trace[321590851] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:648; }","duration":"279.390702ms","start":"2026-07-14T22:57:59.719895Z","end":"2026-07-14T22:57:59.999286Z","steps":["trace[321590851] 'read index received' (duration: 279.220297ms)","trace[321590851] 'applied index is now lower than readState.Index' (duration: 169.595µs)"],"step_count":2} {"level":"info","ts":"2026-07-14T22:57:59.999393Z","caller":"traceutil/trace.go:171","msg":"trace[1117652056] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"369.605163ms","start":"2026-07-14T22:57:59.629765Z","end":"2026-07-14T22:57:59.999371Z","steps":["trace[1117652056] 'process raft request' (duration: 369.396316ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:57:59.999438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.529577ms","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-07-14T22:57:59.999488Z","caller":"traceutil/trace.go:171","msg":"trace[51023690] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:624; }","duration":"279.64084ms","start":"2026-07-14T22:57:59.719837Z","end":"2026-07-14T22:57:59.999478Z","steps":["trace[51023690] 'agreement among raft nodes before linearized reading' (duration: 279.540247ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:57:59.999522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:57:59.629747Z","time spent":"369.714276ms","remote":"127.0.0.1:32902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-14T22:57:59.999784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.239246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T22:57:59.999826Z","caller":"traceutil/trace.go:171","msg":"trace[1836585132] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:624; }","duration":"103.309768ms","start":"2026-07-14T22:57:59.896506Z","end":"2026-07-14T22:57:59.999816Z","steps":["trace[1836585132] 'agreement among raft nodes before linearized reading' (duration: 103.243796ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:57:59.999796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.294537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-14T22:58:00.000089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.392764ms","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-07-14T22:58:00.000126Z","caller":"traceutil/trace.go:171","msg":"trace[1186517301] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:624; }","duration":"184.478916ms","start":"2026-07-14T22:57:59.815638Z","end":"2026-07-14T22:58:00.000117Z","steps":["trace[1186517301] 'agreement among raft nodes before linearized reading' (duration: 184.361592ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T22:58:00.000055Z","caller":"traceutil/trace.go:171","msg":"trace[1484101092] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:624; }","duration":"146.574566ms","start":"2026-07-14T22:57:59.853463Z","end":"2026-07-14T22:58:00.000038Z","steps":["trace[1484101092] 'agreement among raft nodes before linearized reading' (duration: 146.298987ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:58:00.000359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.418476ms","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-07-14T22:58:00.000399Z","caller":"traceutil/trace.go:171","msg":"trace[1583162277] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:624; }","duration":"273.478448ms","start":"2026-07-14T22:57:59.726907Z","end":"2026-07-14T22:58:00.000385Z","steps":["trace[1583162277] 'agreement among raft nodes before linearized reading' (duration: 273.371935ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:58:00.000533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.617531ms","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-07-14T22:58:00.000567Z","caller":"traceutil/trace.go:171","msg":"trace[1041467610] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:624; }","duration":"280.693813ms","start":"2026-07-14T22:57:59.719865Z","end":"2026-07-14T22:58:00.000559Z","steps":["trace[1041467610] 'agreement among raft nodes before linearized reading' (duration: 280.629151ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:58:00.000706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.289679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-14T22:58:00.00084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.550837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T22:58:00.000887Z","caller":"traceutil/trace.go:171","msg":"trace[1644440263] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:624; }","duration":"104.617729ms","start":"2026-07-14T22:57:59.896257Z","end":"2026-07-14T22:58:00.000875Z","steps":["trace[1644440263] 'agreement among raft nodes before linearized reading' (duration: 104.554577ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:58:00.001068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.170391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-14T22:57:59.99998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.485853ms","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-07-14T22:58:00.001107Z","caller":"traceutil/trace.go:171","msg":"trace[1489836437] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:624; }","duration":"118.232933ms","start":"2026-07-14T22:57:59.882864Z","end":"2026-07-14T22:58:00.001097Z","steps":["trace[1489836437] 'agreement among raft nodes before linearized reading' (duration: 118.173901ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T22:58:00.001117Z","caller":"traceutil/trace.go:171","msg":"trace[416470171] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:624; }","duration":"147.649709ms","start":"2026-07-14T22:57:59.853456Z","end":"2026-07-14T22:58:00.001106Z","steps":["trace[416470171] 'agreement among raft nodes before linearized reading' (duration: 146.495973ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:58:00.001225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.185275ms","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-07-14T22:58:00.001308Z","caller":"traceutil/trace.go:171","msg":"trace[389471123] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:624; }","duration":"147.295248ms","start":"2026-07-14T22:57:59.853987Z","end":"2026-07-14T22:58:00.001282Z","steps":["trace[389471123] 'agreement among raft nodes before linearized reading' (duration: 147.119243ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:58:00.00143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.831013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T22:58:00.001694Z","caller":"traceutil/trace.go:171","msg":"trace[681531929] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:624; }","duration":"120.111821ms","start":"2026-07-14T22:57:59.88146Z","end":"2026-07-14T22:58:00.001572Z","steps":["trace[681531929] 'agreement among raft nodes before linearized reading' (duration: 119.555764ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T22:58:00.002431Z","caller":"traceutil/trace.go:171","msg":"trace[1278044078] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:624; }","duration":"104.453364ms","start":"2026-07-14T22:57:59.896401Z","end":"2026-07-14T22:58:00.000854Z","steps":["trace[1278044078] 'agreement among raft nodes before linearized reading' (duration: 104.271688ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:58:00.000784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.399239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T22:58:00.003068Z","caller":"traceutil/trace.go:171","msg":"trace[1643015166] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:624; }","duration":"121.68042ms","start":"2026-07-14T22:57:59.881366Z","end":"2026-07-14T22:58:00.003047Z","steps":["trace[1643015166] 'agreement among raft nodes before linearized reading' (duration: 119.381839ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:58:00.410332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.422596ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-14T22:58:00.410613Z","caller":"traceutil/trace.go:171","msg":"trace[954166540] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:649; }","duration":"399.190354ms","start":"2026-07-14T22:58:00.011375Z","end":"2026-07-14T22:58:00.410565Z","steps":["trace[954166540] 'read index received' (duration: 126.094447ms)","trace[954166540] 'applied index is now lower than readState.Index' (duration: 273.095087ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T22:58:00.410632Z","caller":"traceutil/trace.go:171","msg":"trace[22250591] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"401.734383ms","start":"2026-07-14T22:58:00.008873Z","end":"2026-07-14T22:58:00.410607Z","steps":["trace[22250591] 'process raft request' (duration: 401.594219ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T22:58:00.410668Z","caller":"traceutil/trace.go:171","msg":"trace[440283909] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"401.767404ms","start":"2026-07-14T22:58:00.008877Z","end":"2026-07-14T22:58:00.410645Z","steps":["trace[440283909] 'process raft request' (duration: 128.661317ms)","trace[440283909] 'compare' (duration: 272.186129ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T22:58:00.410773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.370549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-14T22:58:00.41079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:58:00.008861Z","time spent":"401.832457ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T22:58:00.410813Z","caller":"traceutil/trace.go:171","msg":"trace[560399807] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:626; }","duration":"399.446052ms","start":"2026-07-14T22:58:00.011349Z","end":"2026-07-14T22:58:00.410795Z","steps":["trace[560399807] 'agreement among raft nodes before linearized reading' (duration: 399.355799ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:58:00.410869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:58:00.011341Z","time spent":"399.519744ms","remote":"127.0.0.1:60854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-07-14T22:58:00.410889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.206249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-14T22:58:00.410853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:58:00.008865Z","time spent":"401.851157ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T22:58:00.411005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.23944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T22:58:00.411044Z","caller":"traceutil/trace.go:171","msg":"trace[893928610] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:626; }","duration":"377.285781ms","start":"2026-07-14T22:58:00.033745Z","end":"2026-07-14T22:58:00.411031Z","steps":["trace[893928610] 'agreement among raft nodes before linearized reading' (duration: 377.23608ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T22:58:00.410951Z","caller":"traceutil/trace.go:171","msg":"trace[874395422] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:626; }","duration":"193.298272ms","start":"2026-07-14T22:58:00.21764Z","end":"2026-07-14T22:58:00.410938Z","steps":["trace[874395422] 'agreement among raft nodes before linearized reading' (duration: 193.193788ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:58:00.411094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.329073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T22:58:00.411351Z","caller":"traceutil/trace.go:171","msg":"trace[1910538756] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:626; }","duration":"377.632222ms","start":"2026-07-14T22:58:00.033709Z","end":"2026-07-14T22:58:00.411341Z","steps":["trace[1910538756] 'agreement among raft nodes before linearized reading' (duration: 377.314292ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:58:00.411457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:58:00.033702Z","time spent":"377.744176ms","remote":"127.0.0.1:41888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-07-14T22:58:00.410969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.376138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T22:58:00.411573Z","caller":"traceutil/trace.go:171","msg":"trace[636911291] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:626; }","duration":"389.977447ms","start":"2026-07-14T22:58:00.021582Z","end":"2026-07-14T22:58:00.411559Z","steps":["trace[636911291] 'agreement among raft nodes before linearized reading' (duration: 389.343917ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:58:00.411117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.148946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-14T22:58:00.411715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:58:00.021572Z","time spent":"390.05895ms","remote":"127.0.0.1:41882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-07-14T22:58:00.411787Z","caller":"traceutil/trace.go:171","msg":"trace[1972150460] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:626; }","duration":"376.772706ms","start":"2026-07-14T22:58:00.034951Z","end":"2026-07-14T22:58:00.411724Z","steps":["trace[1972150460] 'agreement among raft nodes before linearized reading' (duration: 376.147857ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:58:00.411982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:58:00.034947Z","time spent":"377.023314ms","remote":"127.0.0.1:41882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"warn","ts":"2026-07-14T22:58:00.41108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:58:00.033741Z","time spent":"377.330763ms","remote":"127.0.0.1:41888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-07-14T22:58:00.411173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.311947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T22:58:00.412246Z","caller":"traceutil/trace.go:171","msg":"trace[1669867982] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:626; }","duration":"390.37924ms","start":"2026-07-14T22:58:00.021855Z","end":"2026-07-14T22:58:00.412234Z","steps":["trace[1669867982] 'agreement among raft nodes before linearized reading' (duration: 389.300956ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:58:00.412321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:58:00.02185Z","time spent":"390.456312ms","remote":"127.0.0.1:41882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-07-14T22:58:01.161828Z","caller":"traceutil/trace.go:171","msg":"trace[1203000859] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"331.62291ms","start":"2026-07-14T22:58:00.830177Z","end":"2026-07-14T22:58:01.1618Z","steps":["trace[1203000859] 'process raft request' (duration: 331.409044ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:58:01.162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:58:00.830157Z","time spent":"331.752154ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T22:58:01.674671Z","caller":"traceutil/trace.go:171","msg":"trace[2119951348] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:652; }","duration":"806.928944ms","start":"2026-07-14T22:58:00.867721Z","end":"2026-07-14T22:58:01.67465Z","steps":["trace[2119951348] 'read index received' (duration: 294.029529ms)","trace[2119951348] 'applied index is now lower than readState.Index' (duration: 512.898615ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T22:58:01.674792Z","caller":"traceutil/trace.go:171","msg":"trace[267645240] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"723.414623ms","start":"2026-07-14T22:58:00.951368Z","end":"2026-07-14T22:58:01.674783Z","steps":["trace[267645240] 'process raft request' (duration: 723.230847ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T22:58:01.674856Z","caller":"traceutil/trace.go:171","msg":"trace[1952698471] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"838.301041ms","start":"2026-07-14T22:58:00.836539Z","end":"2026-07-14T22:58:01.67484Z","steps":["trace[1952698471] 'process raft request' (duration: 837.468256ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:58:01.674894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:58:00.951347Z","time spent":"723.476934ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T22:58:01.674946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:58:00.836519Z","time spent":"838.381303ms","remote":"127.0.0.1:60692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T22:58:01.67511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.710806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T22:58:01.67515Z","caller":"traceutil/trace.go:171","msg":"trace[1094175568] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:630; }","duration":"457.777518ms","start":"2026-07-14T22:58:01.217362Z","end":"2026-07-14T22:58:01.67514Z","steps":["trace[1094175568] 'agreement among raft nodes before linearized reading' (duration: 457.684385ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:58:01.675178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:58:01.21735Z","time spent":"457.82228ms","remote":"127.0.0.1:60626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-14T22:58:01.675379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"807.628815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-14T22:58:01.675472Z","caller":"traceutil/trace.go:171","msg":"trace[1103028784] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:630; }","duration":"807.763229ms","start":"2026-07-14T22:58:00.867685Z","end":"2026-07-14T22:58:01.675448Z","steps":["trace[1103028784] 'agreement among raft nodes before linearized reading' (duration: 807.47554ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:58:01.675523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:58:00.867668Z","time spent":"807.845892ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-14T22:58:16.906791Z","caller":"traceutil/trace.go:171","msg":"trace[1769954197] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"409.113456ms","start":"2026-07-14T22:58:16.497652Z","end":"2026-07-14T22:58:16.906766Z","steps":["trace[1769954197] 'process raft request' (duration: 408.875948ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:58:16.907022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:58:16.497635Z","time spent":"409.277161ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T22:58:17.034967Z","caller":"traceutil/trace.go:171","msg":"trace[1639169461] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"534.496871ms","start":"2026-07-14T22:58:16.500438Z","end":"2026-07-14T22:58:17.034935Z","steps":["trace[1639169461] 'process raft request' (duration: 534.313626ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:58:17.035117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:58:16.500427Z","time spent":"534.606625ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T22:58:17.035161Z","caller":"traceutil/trace.go:171","msg":"trace[767567014] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"461.112685ms","start":"2026-07-14T22:58:16.574009Z","end":"2026-07-14T22:58:17.035122Z","steps":["trace[767567014] 'process raft request' (duration: 460.876738ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:58:17.035359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:58:16.57399Z","time spent":"461.252709ms","remote":"127.0.0.1:60854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T22:58:52.33744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.436426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-14T22:58:52.337531Z","caller":"traceutil/trace.go:171","msg":"trace[1652057711] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1006; }","duration":"320.56657ms","start":"2026-07-14T22:58:52.016943Z","end":"2026-07-14T22:58:52.337509Z","steps":["trace[1652057711] 'range keys from in-memory index tree' (duration: 320.275111ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:58:52.337572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:58:52.016926Z","time spent":"320.637462ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-14T22:58:52.840075Z","caller":"traceutil/trace.go:171","msg":"trace[131919270] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"498.826736ms","start":"2026-07-14T22:58:52.341225Z","end":"2026-07-14T22:58:52.840052Z","steps":["trace[131919270] 'process raft request' (duration: 498.669231ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:58:52.840217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:58:52.3412Z","time spent":"498.945339ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T22:58:53.404686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.06977ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-14T22:58:53.404795Z","caller":"traceutil/trace.go:171","msg":"trace[2106670092] linearizableReadLoop","detail":"{readStateIndex:1048; appliedIndex:1047; }","duration":"292.486917ms","start":"2026-07-14T22:58:53.11229Z","end":"2026-07-14T22:58:53.404777Z","steps":["trace[2106670092] 'read index received' (duration: 183.099977ms)","trace[2106670092] 'applied index is now lower than readState.Index' (duration: 109.38552ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T22:58:53.404914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.257219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T22:58:53.404946Z","caller":"traceutil/trace.go:171","msg":"trace[842876043] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1008; }","duration":"187.31426ms","start":"2026-07-14T22:58:53.217621Z","end":"2026-07-14T22:58:53.404935Z","steps":["trace[842876043] 'agreement among raft nodes before linearized reading' (duration: 187.259278ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T22:58:53.404917Z","caller":"traceutil/trace.go:171","msg":"trace[444513756] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"652.014593ms","start":"2026-07-14T22:58:52.752831Z","end":"2026-07-14T22:58:53.404845Z","steps":["trace[444513756] 'process raft request' (duration: 542.682055ms)","trace[444513756] 'compare' (duration: 108.928765ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T22:58:53.405021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.637804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-14T22:58:53.405047Z","caller":"traceutil/trace.go:171","msg":"trace[726678999] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1008; }","duration":"175.660504ms","start":"2026-07-14T22:58:53.229378Z","end":"2026-07-14T22:58:53.405039Z","steps":["trace[726678999] 'agreement among raft nodes before linearized reading' (duration: 175.604903ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:58:53.405148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:58:52.752793Z","time spent":"652.208329ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T22:58:53.404954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.659643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-14T22:58:53.405258Z","caller":"traceutil/trace.go:171","msg":"trace[1947485432] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1008; }","duration":"292.995974ms","start":"2026-07-14T22:58:53.112254Z","end":"2026-07-14T22:58:53.40525Z","steps":["trace[1947485432] 'agreement among raft nodes before linearized reading' (duration: 292.593621ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T22:58:53.94316Z","caller":"traceutil/trace.go:171","msg":"trace[1284476430] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"533.654421ms","start":"2026-07-14T22:58:53.409485Z","end":"2026-07-14T22:58:53.94314Z","steps":["trace[1284476430] 'process raft request' (duration: 445.897661ms)","trace[1284476430] 'compare' (duration: 87.620285ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T22:58:53.943272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:58:53.409459Z","time spent":"533.757184ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T22:58:53.943376Z","caller":"traceutil/trace.go:171","msg":"trace[2140571218] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"533.846017ms","start":"2026-07-14T22:58:53.409497Z","end":"2026-07-14T22:58:53.943343Z","steps":["trace[2140571218] 'process raft request' (duration: 533.61765ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:58:53.943514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:58:53.40947Z","time spent":"533.968681ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T22:58:53.946712Z","caller":"traceutil/trace.go:171","msg":"trace[1148328510] linearizableReadLoop","detail":"{readStateIndex:1051; appliedIndex:1048; }","duration":"502.230612ms","start":"2026-07-14T22:58:53.444462Z","end":"2026-07-14T22:58:53.946692Z","steps":["trace[1148328510] 'read index received' (duration: 410.919961ms)","trace[1148328510] 'applied index is now lower than readState.Index' (duration: 91.309731ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T22:58:53.946754Z","caller":"traceutil/trace.go:171","msg":"trace[1303317210] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"537.185472ms","start":"2026-07-14T22:58:53.409544Z","end":"2026-07-14T22:58:53.946729Z","steps":["trace[1303317210] 'process raft request' (duration: 537.015826ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T22:58:53.946783Z","caller":"traceutil/trace.go:171","msg":"trace[7454111] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"153.383653ms","start":"2026-07-14T22:58:53.793382Z","end":"2026-07-14T22:58:53.946766Z","steps":["trace[7454111] 'process raft request' (duration: 153.273189ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:58:53.94687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:58:53.409532Z","time spent":"537.277055ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T22:58:53.946894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.419259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-14T22:58:53.946929Z","caller":"traceutil/trace.go:171","msg":"trace[1050170055] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1012; }","duration":"502.486061ms","start":"2026-07-14T22:58:53.444433Z","end":"2026-07-14T22:58:53.946919Z","steps":["trace[1050170055] 'agreement among raft nodes before linearized reading' (duration: 502.344176ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:58:53.946962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:58:53.444423Z","time spent":"502.531062ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-14T22:59:15.138269Z","caller":"traceutil/trace.go:171","msg":"trace[376749528] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"195.514368ms","start":"2026-07-14T22:59:14.942734Z","end":"2026-07-14T22:59:15.138248Z","steps":["trace[376749528] 'process raft request' (duration: 195.405155ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:59:16.587567Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933267186332375829,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-14T22:59:16.891064Z","caller":"traceutil/trace.go:171","msg":"trace[2087240941] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"936.444855ms","start":"2026-07-14T22:59:15.954585Z","end":"2026-07-14T22:59:16.89103Z","steps":["trace[2087240941] 'process raft request' (duration: 936.188487ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:59:16.891267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:59:15.954568Z","time spent":"936.599571ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T22:59:17.674278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.119451ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-14T22:59:17.674371Z","caller":"traceutil/trace.go:171","msg":"trace[126136087] linearizableReadLoop","detail":"{readStateIndex:1126; appliedIndex:1124; }","duration":"1.587599462s","start":"2026-07-14T22:59:16.086738Z","end":"2026-07-14T22:59:17.674337Z","steps":["trace[126136087] 'read index received' (duration: 803.426023ms)","trace[126136087] 'applied index is now lower than readState.Index' (duration: 784.172729ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T22:59:17.674496Z","caller":"traceutil/trace.go:171","msg":"trace[1437072690] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"1.524117626s","start":"2026-07-14T22:59:16.15037Z","end":"2026-07-14T22:59:17.674487Z","steps":["trace[1437072690] 'process raft request' (duration: 1.061712965s)","trace[1437072690] 'compare' (duration: 462.048949ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T22:59:17.674537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:59:16.150315Z","time spent":"1.524202769s","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T22:59:17.674705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.587947622s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-14T22:59:17.674794Z","caller":"traceutil/trace.go:171","msg":"trace[2104939124] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1082; }","duration":"1.588083877s","start":"2026-07-14T22:59:16.08669Z","end":"2026-07-14T22:59:17.674774Z","steps":["trace[2104939124] 'agreement among raft nodes before linearized reading' (duration: 1.587848199s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:59:17.674833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:59:16.086672Z","time spent":"1.588152839s","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-14T22:59:18.046746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.496597ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-14T22:59:18.046959Z","caller":"traceutil/trace.go:171","msg":"trace[1008805197] linearizableReadLoop","detail":"{readStateIndex:1127; appliedIndex:1126; }","duration":"372.552605ms","start":"2026-07-14T22:59:17.674388Z","end":"2026-07-14T22:59:18.046941Z","steps":["trace[1008805197] 'read index received' (duration: 3.775389ms)","trace[1008805197] 'applied index is now lower than readState.Index' (duration: 368.776446ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T22:59:18.047098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.286956789s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-14T22:59:18.047144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.846077829s","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-07-14T22:59:18.04717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"904.957717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-14T22:59:18.047272Z","caller":"traceutil/trace.go:171","msg":"trace[114251601] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1082; }","duration":"905.093211ms","start":"2026-07-14T22:59:17.142156Z","end":"2026-07-14T22:59:18.04725Z","steps":["trace[114251601] 'agreement among raft nodes before linearized reading' (duration: 904.860053ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T22:59:18.047274Z","caller":"traceutil/trace.go:171","msg":"trace[2105338594] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"368.777886ms","start":"2026-07-14T22:59:17.678468Z","end":"2026-07-14T22:59:18.047246Z","steps":["trace[2105338594] 'process raft request' (duration: 368.384123ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:59:18.047321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:59:17.142135Z","time spent":"905.174673ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-14T22:59:18.047403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:59:17.678446Z","time spent":"368.884749ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T22:59:18.047192Z","caller":"traceutil/trace.go:171","msg":"trace[1339170800] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1082; }","duration":"1.287131144s","start":"2026-07-14T22:59:16.760041Z","end":"2026-07-14T22:59:18.047172Z","steps":["trace[1339170800] 'agreement among raft nodes before linearized reading' (duration: 1.286951789s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:59:18.047551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:59:16.760009Z","time spent":"1.287529727s","remote":"127.0.0.1:60822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "} {"level":"warn","ts":"2026-07-14T22:59:18.047096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"901.57302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-14T22:59:18.047196Z","caller":"traceutil/trace.go:171","msg":"trace[1766022194] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1082; }","duration":"1.846176233s","start":"2026-07-14T22:59:16.201003Z","end":"2026-07-14T22:59:18.04718Z","steps":["trace[1766022194] 'agreement among raft nodes before linearized reading' (duration: 1.846001357s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:59:18.047844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:59:16.20098Z","time spent":"1.846840803s","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-14T22:59:18.047753Z","caller":"traceutil/trace.go:171","msg":"trace[1167234850] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1082; }","duration":"902.196709ms","start":"2026-07-14T22:59:17.145456Z","end":"2026-07-14T22:59:18.047652Z","steps":["trace[1167234850] 'agreement among raft nodes before linearized reading' (duration: 901.545589ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:59:18.048029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:59:17.145441Z","time spent":"902.565851ms","remote":"127.0.0.1:60792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":30,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"warn","ts":"2026-07-14T22:59:18.473108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.255326098s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T22:59:18.473218Z","caller":"traceutil/trace.go:171","msg":"trace[2102300136] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1083; }","duration":"2.255460753s","start":"2026-07-14T22:59:16.217725Z","end":"2026-07-14T22:59:18.473186Z","steps":["trace[2102300136] 'agreement among raft nodes before linearized reading' (duration: 1.829476567s)","trace[2102300136] 'range keys from in-memory index tree' (duration: 425.835001ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T22:59:18.47335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:59:16.217714Z","time spent":"2.255624007s","remote":"127.0.0.1:60626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-14T22:59:18.473487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.262597207s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"warn","ts":"2026-07-14T22:59:18.473503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.266244102s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-14T22:59:18.473551Z","caller":"traceutil/trace.go:171","msg":"trace[946239903] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1083; }","duration":"2.266313284s","start":"2026-07-14T22:59:16.207222Z","end":"2026-07-14T22:59:18.473535Z","steps":["trace[946239903] 'agreement among raft nodes before linearized reading' (duration: 1.839947886s)","trace[946239903] 'range keys from in-memory index tree' (duration: 426.233983ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T22:59:18.473548Z","caller":"traceutil/trace.go:171","msg":"trace[1025079675] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1083; }","duration":"2.262689719s","start":"2026-07-14T22:59:16.21084Z","end":"2026-07-14T22:59:18.473529Z","steps":["trace[1025079675] 'agreement among raft nodes before linearized reading' (duration: 1.836333952s)","trace[1025079675] 'range keys from in-memory index tree' (duration: 426.158141ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T22:59:18.473593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:59:16.207209Z","time spent":"2.266373166s","remote":"127.0.0.1:60884","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-07-14T22:59:18.4736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:59:16.210829Z","time spent":"2.262759422s","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-14T22:59:18.473921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.430876ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-14T22:59:18.474124Z","caller":"traceutil/trace.go:171","msg":"trace[747498973] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"422.781554ms","start":"2026-07-14T22:59:18.051312Z","end":"2026-07-14T22:59:18.474094Z","steps":["trace[747498973] 'process raft request' (duration: 185.061619ms)","trace[747498973] 'compare' (duration: 236.754795ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T22:59:18.4742Z","caller":"traceutil/trace.go:171","msg":"trace[1194859756] linearizableReadLoop","detail":"{readStateIndex:1130; appliedIndex:1128; }","duration":"255.787543ms","start":"2026-07-14T22:59:18.218395Z","end":"2026-07-14T22:59:18.474183Z","steps":["trace[1194859756] 'read index received' (duration: 17.987645ms)","trace[1194859756] 'applied index is now lower than readState.Index' (duration: 237.798838ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T22:59:18.474223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:59:18.051294Z","time spent":"422.883578ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T22:59:18.474278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.886007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T22:59:18.474268Z","caller":"traceutil/trace.go:171","msg":"trace[1813130585] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"422.222167ms","start":"2026-07-14T22:59:18.052025Z","end":"2026-07-14T22:59:18.474236Z","steps":["trace[1813130585] 'process raft request' (duration: 422.024681ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T22:59:18.47431Z","caller":"traceutil/trace.go:171","msg":"trace[626836399] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1085; }","duration":"255.98996ms","start":"2026-07-14T22:59:18.218309Z","end":"2026-07-14T22:59:18.474299Z","steps":["trace[626836399] 'agreement among raft nodes before linearized reading' (duration: 255.928808ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:59:18.474442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:59:18.052011Z","time spent":"422.306309ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T22:59:18.68331Z","caller":"traceutil/trace.go:171","msg":"trace[60057681] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"204.048146ms","start":"2026-07-14T22:59:18.479238Z","end":"2026-07-14T22:59:18.683286Z","steps":["trace[60057681] 'process raft request' (duration: 203.887321ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T22:59:18.685041Z","caller":"traceutil/trace.go:171","msg":"trace[1764840902] linearizableReadLoop","detail":"{readStateIndex:1133; appliedIndex:1131; }","duration":"202.442326ms","start":"2026-07-14T22:59:18.48258Z","end":"2026-07-14T22:59:18.685023Z","steps":["trace[1764840902] 'read index received' (duration: 200.891207ms)","trace[1764840902] 'applied index is now lower than readState.Index' (duration: 1.549919ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T22:59:18.685138Z","caller":"traceutil/trace.go:171","msg":"trace[74934721] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"205.846193ms","start":"2026-07-14T22:59:18.479266Z","end":"2026-07-14T22:59:18.685113Z","steps":["trace[74934721] 'process raft request' (duration: 205.712148ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:59:18.685161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.569911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T22:59:18.685305Z","caller":"traceutil/trace.go:171","msg":"trace[1899171998] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1088; }","duration":"202.741015ms","start":"2026-07-14T22:59:18.482552Z","end":"2026-07-14T22:59:18.685293Z","steps":["trace[1899171998] 'agreement among raft nodes before linearized reading' (duration: 202.547339ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T22:59:18.6854Z","caller":"traceutil/trace.go:171","msg":"trace[2036346976] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"205.826122ms","start":"2026-07-14T22:59:18.479255Z","end":"2026-07-14T22:59:18.685081Z","steps":["trace[2036346976] 'process raft request' (duration: 205.646906ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:59:19.189174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.994415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T22:59:19.189277Z","caller":"traceutil/trace.go:171","msg":"trace[1848136463] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1088; }","duration":"274.157291ms","start":"2026-07-14T22:59:18.915096Z","end":"2026-07-14T22:59:19.189253Z","steps":["trace[1848136463] 'count revisions from in-memory index tree' (duration: 273.917084ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:59:35.485727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.870785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T22:59:35.485835Z","caller":"traceutil/trace.go:171","msg":"trace[1973654436] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1190; }","duration":"270.02599ms","start":"2026-07-14T22:59:35.215789Z","end":"2026-07-14T22:59:35.485815Z","steps":["trace[1973654436] 'range keys from in-memory index tree' (duration: 269.761352ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:59:35.485878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"720.389045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-14T22:59:35.485971Z","caller":"traceutil/trace.go:171","msg":"trace[728532551] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1190; }","duration":"720.524319ms","start":"2026-07-14T22:59:34.765417Z","end":"2026-07-14T22:59:35.485941Z","steps":["trace[728532551] 'range keys from in-memory index tree' (duration: 720.138197ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:59:35.48603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:59:34.76539Z","time spent":"720.623473ms","remote":"127.0.0.1:60884","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-07-14T22:59:35.486021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"744.618219ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T22:59:35.486106Z","caller":"traceutil/trace.go:171","msg":"trace[2139863338] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1190; }","duration":"744.721832ms","start":"2026-07-14T22:59:34.74137Z","end":"2026-07-14T22:59:35.486092Z","steps":["trace[2139863338] 'range keys from in-memory index tree' (duration: 744.602569ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:59:35.486189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.323328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T22:59:35.486249Z","caller":"traceutil/trace.go:171","msg":"trace[734031629] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1190; }","duration":"218.416832ms","start":"2026-07-14T22:59:35.267813Z","end":"2026-07-14T22:59:35.48623Z","steps":["trace[734031629] 'count revisions from in-memory index tree' (duration: 218.260426ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:59:35.486252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.83622ms","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-07-14T22:59:35.486297Z","caller":"traceutil/trace.go:171","msg":"trace[1223337185] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1190; }","duration":"282.909812ms","start":"2026-07-14T22:59:35.203374Z","end":"2026-07-14T22:59:35.486284Z","steps":["trace[1223337185] 'count revisions from in-memory index tree' (duration: 282.743077ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:59:35.486324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"720.935792ms","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-07-14T22:59:35.486371Z","caller":"traceutil/trace.go:171","msg":"trace[1271962441] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1190; }","duration":"721.023925ms","start":"2026-07-14T22:59:34.765338Z","end":"2026-07-14T22:59:35.486362Z","steps":["trace[1271962441] 'range keys from in-memory index tree' (duration: 720.706255ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:59:35.486403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:59:34.765317Z","time spent":"721.078177ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-14T22:59:36.313141Z","caller":"traceutil/trace.go:171","msg":"trace[941386709] transaction","detail":"{read_only:false; response_revision:1191; number_of_response:1; }","duration":"822.923082ms","start":"2026-07-14T22:59:35.490193Z","end":"2026-07-14T22:59:36.313116Z","steps":["trace[941386709] 'process raft request' (duration: 822.702835ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:59:36.314399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:59:35.490176Z","time spent":"823.037555ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T22:59:36.336502Z","caller":"traceutil/trace.go:171","msg":"trace[1332381845] linearizableReadLoop","detail":"{readStateIndex:1243; appliedIndex:1240; }","duration":"217.355817ms","start":"2026-07-14T22:59:36.119131Z","end":"2026-07-14T22:59:36.336487Z","steps":["trace[1332381845] 'read index received' (duration: 193.903168ms)","trace[1332381845] 'applied index is now lower than readState.Index' (duration: 23.451969ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T22:59:36.336596Z","caller":"traceutil/trace.go:171","msg":"trace[1139916836] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"845.98756ms","start":"2026-07-14T22:59:35.490602Z","end":"2026-07-14T22:59:36.336589Z","steps":["trace[1139916836] 'process raft request' (duration: 845.711681ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:59:36.336647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.517822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-14T22:59:36.33668Z","caller":"traceutil/trace.go:171","msg":"trace[1365217235] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1193; }","duration":"217.591875ms","start":"2026-07-14T22:59:36.11908Z","end":"2026-07-14T22:59:36.336672Z","steps":["trace[1365217235] 'agreement among raft nodes before linearized reading' (duration: 217.506232ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:59:36.336715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.803917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T22:59:36.33674Z","caller":"traceutil/trace.go:171","msg":"trace[513824128] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1193; }","duration":"118.866629ms","start":"2026-07-14T22:59:36.217868Z","end":"2026-07-14T22:59:36.336734Z","steps":["trace[513824128] 'agreement among raft nodes before linearized reading' (duration: 118.828488ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T22:59:36.336771Z","caller":"traceutil/trace.go:171","msg":"trace[443414768] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"517.949074ms","start":"2026-07-14T22:59:35.818817Z","end":"2026-07-14T22:59:36.336766Z","steps":["trace[443414768] 'process raft request' (duration: 517.633694ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:59:36.336807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:59:35.818797Z","time spent":"517.988196ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T22:59:36.336675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:59:35.490587Z","time spent":"846.03031ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T22:59:42.603104Z","caller":"traceutil/trace.go:171","msg":"trace[78461948] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"206.49089ms","start":"2026-07-14T22:59:42.396591Z","end":"2026-07-14T22:59:42.603082Z","steps":["trace[78461948] 'process raft request' (duration: 146.002927ms)","trace[78461948] 'compare' (duration: 60.09428ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T22:59:48.589334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.578694ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-14T22:59:48.589461Z","caller":"traceutil/trace.go:171","msg":"trace[184713614] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"172.329668ms","start":"2026-07-14T22:59:48.417111Z","end":"2026-07-14T22:59:48.58944Z","steps":["trace[184713614] 'process raft request' (duration: 71.532126ms)","trace[184713614] 'compare' (duration: 100.43025ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T22:59:48.625341Z","caller":"traceutil/trace.go:171","msg":"trace[1525373616] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"187.468951ms","start":"2026-07-14T22:59:48.437845Z","end":"2026-07-14T22:59:48.625314Z","steps":["trace[1525373616] 'process raft request' (duration: 187.316697ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:59:50.898819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.913701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-14T22:59:50.898945Z","caller":"traceutil/trace.go:171","msg":"trace[1053196055] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1240; }","duration":"114.066526ms","start":"2026-07-14T22:59:50.784855Z","end":"2026-07-14T22:59:50.898922Z","steps":["trace[1053196055] 'range keys from in-memory index tree' (duration: 113.763186ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:59:50.899451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.682167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-14T22:59:50.899549Z","caller":"traceutil/trace.go:171","msg":"trace[2031676074] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1240; }","duration":"115.813702ms","start":"2026-07-14T22:59:50.783711Z","end":"2026-07-14T22:59:50.899524Z","steps":["trace[2031676074] 'range keys from in-memory index tree' (duration: 115.525843ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T22:59:51.139436Z","caller":"traceutil/trace.go:171","msg":"trace[1408400709] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"235.973892ms","start":"2026-07-14T22:59:50.90344Z","end":"2026-07-14T22:59:51.139414Z","steps":["trace[1408400709] 'process raft request' (duration: 170.645624ms)","trace[1408400709] 'compare' (duration: 65.238885ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T22:59:52.523002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.452974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T22:59:52.523065Z","caller":"traceutil/trace.go:171","msg":"trace[1825363896] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1244; }","duration":"301.593869ms","start":"2026-07-14T22:59:52.221456Z","end":"2026-07-14T22:59:52.52305Z","steps":["trace[1825363896] 'range keys from in-memory index tree' (duration: 301.362821ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:59:52.523093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:59:52.221439Z","time spent":"301.648331ms","remote":"127.0.0.1:60626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-14T22:59:58.76171Z","caller":"traceutil/trace.go:171","msg":"trace[1071360057] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"140.923464ms","start":"2026-07-14T22:59:58.62073Z","end":"2026-07-14T22:59:58.761654Z","steps":["trace[1071360057] 'process raft request' (duration: 87.778476ms)","trace[1071360057] 'compare' (duration: 52.695344ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T22:59:59.224952Z","caller":"traceutil/trace.go:171","msg":"trace[1829463710] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"112.746793ms","start":"2026-07-14T22:59:59.112183Z","end":"2026-07-14T22:59:59.22493Z","steps":["trace[1829463710] 'process raft request' (duration: 36.052782ms)","trace[1829463710] 'compare' (duration: 76.575538ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:00:00.211909Z","caller":"traceutil/trace.go:171","msg":"trace[138737427] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"168.768594ms","start":"2026-07-14T23:00:00.043107Z","end":"2026-07-14T23:00:00.211876Z","steps":["trace[138737427] 'process raft request' (duration: 168.610209ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:00:01.052868Z","caller":"traceutil/trace.go:171","msg":"trace[1444647489] linearizableReadLoop","detail":"{readStateIndex:1355; appliedIndex:1354; }","duration":"387.294309ms","start":"2026-07-14T23:00:00.665551Z","end":"2026-07-14T23:00:01.052846Z","steps":["trace[1444647489] 'read index received' (duration: 387.071152ms)","trace[1444647489] 'applied index is now lower than readState.Index' (duration: 222.397µs)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:00:01.052964Z","caller":"traceutil/trace.go:171","msg":"trace[1830505008] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"835.894736ms","start":"2026-07-14T23:00:00.21706Z","end":"2026-07-14T23:00:01.052955Z","steps":["trace[1830505008] 'process raft request' (duration: 835.657979ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:01.053046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:00.217031Z","time spent":"835.960678ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-14T23:00:01.053226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.697551ms","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-07-14T23:00:01.053291Z","caller":"traceutil/trace.go:171","msg":"trace[979682856] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1300; }","duration":"387.800554ms","start":"2026-07-14T23:00:00.665474Z","end":"2026-07-14T23:00:01.053274Z","steps":["trace[979682856] 'agreement among raft nodes before linearized reading' (duration: 387.586658ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:01.05336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:00.665455Z","time spent":"387.868687ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-14T23:00:01.257429Z","caller":"traceutil/trace.go:171","msg":"trace[1522741991] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"588.009074ms","start":"2026-07-14T23:00:00.669388Z","end":"2026-07-14T23:00:01.257397Z","steps":["trace[1522741991] 'process raft request' (duration: 533.303595ms)","trace[1522741991] 'compare' (duration: 54.456461ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:00:01.257503Z","caller":"traceutil/trace.go:171","msg":"trace[406521797] linearizableReadLoop","detail":"{readStateIndex:1357; appliedIndex:1355; }","duration":"204.545208ms","start":"2026-07-14T23:00:01.05293Z","end":"2026-07-14T23:00:01.257475Z","steps":["trace[406521797] 'read index received' (duration: 149.901722ms)","trace[406521797] 'applied index is now lower than readState.Index' (duration: 54.641336ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:00:01.257496Z","caller":"traceutil/trace.go:171","msg":"trace[83273546] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"491.149988ms","start":"2026-07-14T23:00:00.766311Z","end":"2026-07-14T23:00:01.257461Z","steps":["trace[83273546] 'process raft request' (duration: 491.020493ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:00:01.257521Z","caller":"traceutil/trace.go:171","msg":"trace[1636392625] transaction","detail":"{read_only:false; response_revision:1304; number_of_response:1; }","duration":"198.405322ms","start":"2026-07-14T23:00:01.059084Z","end":"2026-07-14T23:00:01.257489Z","steps":["trace[1636392625] 'process raft request' (duration: 198.36497ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:01.257569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:00.669356Z","time spent":"588.146678ms","remote":"127.0.0.1:60686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":780,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-14T23:00:01.257685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:00.766289Z","time spent":"491.289332ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T23:00:01.257785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.112654ms","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-07-14T23:00:01.257724Z","caller":"traceutil/trace.go:171","msg":"trace[314189989] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"198.837686ms","start":"2026-07-14T23:00:01.058876Z","end":"2026-07-14T23:00:01.257713Z","steps":["trace[314189989] 'process raft request' (duration: 198.531796ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:00:01.257827Z","caller":"traceutil/trace.go:171","msg":"trace[2086668114] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1304; }","duration":"408.204047ms","start":"2026-07-14T23:00:00.84961Z","end":"2026-07-14T23:00:01.257814Z","steps":["trace[2086668114] 'agreement among raft nodes before linearized reading' (duration: 407.9911ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:01.257867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:00.849593Z","time spent":"408.265978ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-14T23:00:01.258086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.112264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-14T23:00:01.258127Z","caller":"traceutil/trace.go:171","msg":"trace[1943186490] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1304; }","duration":"199.198197ms","start":"2026-07-14T23:00:01.058914Z","end":"2026-07-14T23:00:01.258112Z","steps":["trace[1943186490] 'agreement among raft nodes before linearized reading' (duration: 199.047072ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:01.258294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.329073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-14T23:00:01.258327Z","caller":"traceutil/trace.go:171","msg":"trace[1383007531] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1304; }","duration":"129.399506ms","start":"2026-07-14T23:00:01.12892Z","end":"2026-07-14T23:00:01.25832Z","steps":["trace[1383007531] 'agreement among raft nodes before linearized reading' (duration: 129.299373ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:01.260775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.61741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-14T23:00:01.260838Z","caller":"traceutil/trace.go:171","msg":"trace[443022240] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1304; }","duration":"474.709962ms","start":"2026-07-14T23:00:00.786113Z","end":"2026-07-14T23:00:01.260823Z","steps":["trace[443022240] 'agreement among raft nodes before linearized reading' (duration: 472.070088ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:01.260871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:00.7861Z","time spent":"474.763084ms","remote":"127.0.0.1:60884","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":"info","ts":"2026-07-14T23:00:01.569825Z","caller":"traceutil/trace.go:171","msg":"trace[677491006] transaction","detail":"{read_only:false; response_revision:1305; number_of_response:1; }","duration":"307.27474ms","start":"2026-07-14T23:00:01.262527Z","end":"2026-07-14T23:00:01.569802Z","steps":["trace[677491006] 'process raft request' (duration: 307.135586ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:01.569984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:01.262499Z","time spent":"307.399125ms","remote":"127.0.0.1:60686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":843,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-14T23:00:01.581398Z","caller":"traceutil/trace.go:171","msg":"trace[163776638] transaction","detail":"{read_only:false; response_revision:1306; number_of_response:1; }","duration":"317.116585ms","start":"2026-07-14T23:00:01.264261Z","end":"2026-07-14T23:00:01.581378Z","steps":["trace[163776638] 'process raft request' (duration: 316.753644ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:01.581509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:01.264252Z","time spent":"317.202638ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T23:00:01.581544Z","caller":"traceutil/trace.go:171","msg":"trace[2055655793] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"317.064123ms","start":"2026-07-14T23:00:01.264442Z","end":"2026-07-14T23:00:01.581506Z","steps":["trace[2055655793] 'process raft request' (duration: 316.782954ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:00:01.581602Z","caller":"traceutil/trace.go:171","msg":"trace[134174172] linearizableReadLoop","detail":"{readStateIndex:1365; appliedIndex:1359; }","duration":"196.216742ms","start":"2026-07-14T23:00:01.38536Z","end":"2026-07-14T23:00:01.581577Z","steps":["trace[134174172] 'read index received' (duration: 184.249329ms)","trace[134174172] 'applied index is now lower than readState.Index' (duration: 11.966353ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:00:01.581523Z","caller":"traceutil/trace.go:171","msg":"trace[2029350524] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"316.93596ms","start":"2026-07-14T23:00:01.26448Z","end":"2026-07-14T23:00:01.581416Z","steps":["trace[2029350524] 'process raft request' (duration: 316.845817ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:01.58173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:01.264421Z","time spent":"317.209378ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T23:00:01.581769Z","caller":"traceutil/trace.go:171","msg":"trace[1241776056] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"316.743253ms","start":"2026-07-14T23:00:01.265014Z","end":"2026-07-14T23:00:01.581757Z","steps":["trace[1241776056] 'process raft request' (duration: 316.460264ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:00:01.581736Z","caller":"traceutil/trace.go:171","msg":"trace[31576123] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"317.244589ms","start":"2026-07-14T23:00:01.264478Z","end":"2026-07-14T23:00:01.581723Z","steps":["trace[31576123] 'process raft request' (duration: 316.890028ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:01.581871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:01.265Z","time spent":"316.800605ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T23:00:01.581935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:01.264456Z","time spent":"317.446916ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T23:00:01.582032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:01.264468Z","time spent":"317.343162ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T23:00:01.5821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.723878ms","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-07-14T23:00:01.582157Z","caller":"traceutil/trace.go:171","msg":"trace[619410543] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1310; }","duration":"197.077979ms","start":"2026-07-14T23:00:01.385062Z","end":"2026-07-14T23:00:01.58214Z","steps":["trace[619410543] 'agreement among raft nodes before linearized reading' (duration: 196.926894ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:00:02.031668Z","caller":"traceutil/trace.go:171","msg":"trace[859203607] linearizableReadLoop","detail":"{readStateIndex:1366; appliedIndex:1365; }","duration":"299.061469ms","start":"2026-07-14T23:00:01.732581Z","end":"2026-07-14T23:00:02.031643Z","steps":["trace[859203607] 'read index received' (duration: 298.847442ms)","trace[859203607] 'applied index is now lower than readState.Index' (duration: 212.747µs)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:00:02.031803Z","caller":"traceutil/trace.go:171","msg":"trace[469189669] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"445.509879ms","start":"2026-07-14T23:00:01.586283Z","end":"2026-07-14T23:00:02.031793Z","steps":["trace[469189669] 'process raft request' (duration: 445.175319ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:02.031911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:01.586266Z","time spent":"445.564971ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T23:00:02.032113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.538923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.3\" ","response":"range_response_count:1 size:131"} {"level":"info","ts":"2026-07-14T23:00:02.032142Z","caller":"traceutil/trace.go:171","msg":"trace[723557657] range","detail":"{range_begin:/registry/masterleases/199.204.45.3; range_end:; response_count:1; response_revision:1311; }","duration":"299.607136ms","start":"2026-07-14T23:00:01.732526Z","end":"2026-07-14T23:00:02.032133Z","steps":["trace[723557657] 'agreement among raft nodes before linearized reading' (duration: 299.492213ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:02.032357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.37233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-14T23:00:02.032427Z","caller":"traceutil/trace.go:171","msg":"trace[640091999] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1311; }","duration":"172.496343ms","start":"2026-07-14T23:00:01.859914Z","end":"2026-07-14T23:00:02.03241Z","steps":["trace[640091999] 'agreement among raft nodes before linearized reading' (duration: 172.305847ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:03.252627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"711.302694ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-14T23:00:03.252777Z","caller":"traceutil/trace.go:171","msg":"trace[1765933249] linearizableReadLoop","detail":"{readStateIndex:1368; appliedIndex:1367; }","duration":"1.034310767s","start":"2026-07-14T23:00:02.218451Z","end":"2026-07-14T23:00:03.252761Z","steps":["trace[1765933249] 'read index received' (duration: 322.864049ms)","trace[1765933249] 'applied index is now lower than readState.Index' (duration: 711.445088ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:00:03.252805Z","caller":"traceutil/trace.go:171","msg":"trace[1138373185] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"1.164483357s","start":"2026-07-14T23:00:02.088304Z","end":"2026-07-14T23:00:03.252788Z","steps":["trace[1138373185] 'process raft request' (duration: 452.945247ms)","trace[1138373185] 'compare' (duration: 711.031884ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T23:00:03.252889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:02.08828Z","time spent":"1.164579341s","remote":"127.0.0.1:60638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":116,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T23:00:03.252893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.034440772s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T23:00:03.25296Z","caller":"traceutil/trace.go:171","msg":"trace[1181675663] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1312; }","duration":"1.034547415s","start":"2026-07-14T23:00:02.218405Z","end":"2026-07-14T23:00:03.252953Z","steps":["trace[1181675663] 'agreement among raft nodes before linearized reading' (duration: 1.03441443s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:03.253003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:02.218385Z","time spent":"1.034611447s","remote":"127.0.0.1:60626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-14T23:00:03.774947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.16449ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-14T23:00:03.775067Z","caller":"traceutil/trace.go:171","msg":"trace[808043527] linearizableReadLoop","detail":"{readStateIndex:1370; appliedIndex:1368; }","duration":"422.857575ms","start":"2026-07-14T23:00:03.352198Z","end":"2026-07-14T23:00:03.775056Z","steps":["trace[808043527] 'read index received' (duration: 78.609622ms)","trace[808043527] 'applied index is now lower than readState.Index' (duration: 344.247213ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:00:03.775136Z","caller":"traceutil/trace.go:171","msg":"trace[909658299] transaction","detail":"{read_only:false; response_revision:1314; number_of_response:1; }","duration":"510.274669ms","start":"2026-07-14T23:00:03.264854Z","end":"2026-07-14T23:00:03.775129Z","steps":["trace[909658299] 'process raft request' (duration: 510.167146ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:03.775184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:03.264845Z","time spent":"510.31243ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T23:00:03.775194Z","caller":"traceutil/trace.go:171","msg":"trace[2104626210] transaction","detail":"{read_only:false; response_revision:1313; number_of_response:1; }","duration":"511.534539ms","start":"2026-07-14T23:00:03.263636Z","end":"2026-07-14T23:00:03.77517Z","steps":["trace[2104626210] 'process raft request' (duration: 167.087981ms)","trace[2104626210] 'compare' (duration: 344.080477ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T23:00:03.775314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:03.263625Z","time spent":"511.628362ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T23:00:03.775366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.159124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T23:00:03.775394Z","caller":"traceutil/trace.go:171","msg":"trace[1558519224] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1314; }","duration":"423.226006ms","start":"2026-07-14T23:00:03.352159Z","end":"2026-07-14T23:00:03.775385Z","steps":["trace[1558519224] 'agreement among raft nodes before linearized reading' (duration: 423.172635ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:03.775425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:03.352141Z","time spent":"423.276138ms","remote":"127.0.0.1:41662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-14T23:00:03.775691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.28939ms","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-07-14T23:00:03.775713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.849006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-14T23:00:03.775724Z","caller":"traceutil/trace.go:171","msg":"trace[1901902853] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1314; }","duration":"189.368743ms","start":"2026-07-14T23:00:03.586337Z","end":"2026-07-14T23:00:03.775706Z","steps":["trace[1901902853] 'agreement among raft nodes before linearized reading' (duration: 189.28228ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:00:03.775748Z","caller":"traceutil/trace.go:171","msg":"trace[1311433551] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1314; }","duration":"188.905238ms","start":"2026-07-14T23:00:03.586834Z","end":"2026-07-14T23:00:03.775739Z","steps":["trace[1311433551] 'agreement among raft nodes before linearized reading' (duration: 188.782864ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:03.775698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.819585ms","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":"warn","ts":"2026-07-14T23:00:03.775792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.441984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-14T23:00:03.775863Z","caller":"traceutil/trace.go:171","msg":"trace[2021563170] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1314; }","duration":"189.551738ms","start":"2026-07-14T23:00:03.586294Z","end":"2026-07-14T23:00:03.775846Z","steps":["trace[2021563170] 'agreement among raft nodes before linearized reading' (duration: 189.31245ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:00:03.775822Z","caller":"traceutil/trace.go:171","msg":"trace[1862194584] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1314; }","duration":"188.955849ms","start":"2026-07-14T23:00:03.586859Z","end":"2026-07-14T23:00:03.775815Z","steps":["trace[1862194584] 'agreement among raft nodes before linearized reading' (duration: 188.763003ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:00:04.036874Z","caller":"traceutil/trace.go:171","msg":"trace[794733887] transaction","detail":"{read_only:false; response_revision:1316; number_of_response:1; }","duration":"257.092497ms","start":"2026-07-14T23:00:03.779757Z","end":"2026-07-14T23:00:04.03685Z","steps":["trace[794733887] 'process raft request' (duration: 217.266444ms)","trace[794733887] 'compare' (duration: 39.682399ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:00:04.037184Z","caller":"traceutil/trace.go:171","msg":"trace[1824695922] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"257.318285ms","start":"2026-07-14T23:00:03.77985Z","end":"2026-07-14T23:00:04.037168Z","steps":["trace[1824695922] 'process raft request' (duration: 256.962613ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:00:04.037583Z","caller":"traceutil/trace.go:171","msg":"trace[230327934] transaction","detail":"{read_only:false; response_revision:1318; number_of_response:1; }","duration":"257.250572ms","start":"2026-07-14T23:00:03.779886Z","end":"2026-07-14T23:00:04.037136Z","steps":["trace[230327934] 'process raft request' (duration: 257.138719ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:06.35831Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933267186332376365,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-14T23:00:06.427369Z","caller":"traceutil/trace.go:171","msg":"trace[45181051] transaction","detail":"{read_only:false; response_revision:1321; number_of_response:1; }","duration":"647.065342ms","start":"2026-07-14T23:00:05.780279Z","end":"2026-07-14T23:00:06.427345Z","steps":["trace[45181051] 'process raft request' (duration: 646.929927ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:06.427542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:05.780263Z","time spent":"647.182715ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T23:00:06.791613Z","caller":"traceutil/trace.go:171","msg":"trace[976062413] linearizableReadLoop","detail":"{readStateIndex:1378; appliedIndex:1377; }","duration":"934.362233ms","start":"2026-07-14T23:00:05.857227Z","end":"2026-07-14T23:00:06.79159Z","steps":["trace[976062413] 'read index received' (duration: 570.421042ms)","trace[976062413] 'applied index is now lower than readState.Index' (duration: 363.940021ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:00:06.791738Z","caller":"traceutil/trace.go:171","msg":"trace[666936122] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"1.009148433s","start":"2026-07-14T23:00:05.78255Z","end":"2026-07-14T23:00:06.791698Z","steps":["trace[666936122] 'process raft request' (duration: 1.008893755s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:06.791845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"934.6058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-14T23:00:06.791889Z","caller":"traceutil/trace.go:171","msg":"trace[1149625692] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1322; }","duration":"934.708233ms","start":"2026-07-14T23:00:05.85717Z","end":"2026-07-14T23:00:06.791878Z","steps":["trace[1149625692] 'agreement among raft nodes before linearized reading' (duration: 934.542648ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:06.791887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:05.782528Z","time spent":"1.009281377s","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T23:00:06.791927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:05.857149Z","time spent":"934.769466ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-14T23:00:06.791953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.880781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T23:00:06.792055Z","caller":"traceutil/trace.go:171","msg":"trace[1825448667] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1322; }","duration":"574.044286ms","start":"2026-07-14T23:00:06.21799Z","end":"2026-07-14T23:00:06.792034Z","steps":["trace[1825448667] 'agreement among raft nodes before linearized reading' (duration: 573.819249ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:06.792067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.394343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-14T23:00:06.792106Z","caller":"traceutil/trace.go:171","msg":"trace[1160986830] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1322; }","duration":"204.461405ms","start":"2026-07-14T23:00:06.587631Z","end":"2026-07-14T23:00:06.792093Z","steps":["trace[1160986830] 'agreement among raft nodes before linearized reading' (duration: 204.383483ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:06.792114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:06.21797Z","time spent":"574.13614ms","remote":"127.0.0.1:60626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-14T23:00:06.791975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"749.456713ms","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":"warn","ts":"2026-07-14T23:00:06.792155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"749.860995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-14T23:00:06.792191Z","caller":"traceutil/trace.go:171","msg":"trace[1091352458] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1322; }","duration":"749.68886ms","start":"2026-07-14T23:00:06.042487Z","end":"2026-07-14T23:00:06.792176Z","steps":["trace[1091352458] 'agreement among raft nodes before linearized reading' (duration: 749.348679ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:00:06.792228Z","caller":"traceutil/trace.go:171","msg":"trace[897711265] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1322; }","duration":"749.958049ms","start":"2026-07-14T23:00:06.042253Z","end":"2026-07-14T23:00:06.792211Z","steps":["trace[897711265] 'agreement among raft nodes before linearized reading' (duration: 749.729752ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:06.792237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:06.042482Z","time spent":"749.741301ms","remote":"127.0.0.1:60884","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-07-14T23:00:06.792268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:06.042247Z","time spent":"750.012931ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-14T23:00:06.792382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"750.137844ms","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-07-14T23:00:06.792423Z","caller":"traceutil/trace.go:171","msg":"trace[1436281405] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1322; }","duration":"750.217067ms","start":"2026-07-14T23:00:06.042196Z","end":"2026-07-14T23:00:06.792413Z","steps":["trace[1436281405] 'agreement among raft nodes before linearized reading' (duration: 749.597937ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:06.79245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:06.042177Z","time spent":"750.267018ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-14T23:00:07.222805Z","caller":"traceutil/trace.go:171","msg":"trace[793538911] transaction","detail":"{read_only:false; response_revision:1323; number_of_response:1; }","duration":"426.606715ms","start":"2026-07-14T23:00:06.796176Z","end":"2026-07-14T23:00:07.222782Z","steps":["trace[793538911] 'process raft request' (duration: 333.52424ms)","trace[793538911] 'compare' (duration: 92.916439ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T23:00:07.22294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:06.796164Z","time spent":"426.707069ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T23:00:07.223028Z","caller":"traceutil/trace.go:171","msg":"trace[1898695329] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"425.809049ms","start":"2026-07-14T23:00:06.797206Z","end":"2026-07-14T23:00:07.223015Z","steps":["trace[1898695329] 'process raft request' (duration: 425.52536ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:07.223136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:06.797198Z","time spent":"425.908413ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T23:00:07.223559Z","caller":"traceutil/trace.go:171","msg":"trace[762365151] transaction","detail":"{read_only:false; response_revision:1325; number_of_response:1; }","duration":"426.252134ms","start":"2026-07-14T23:00:06.797264Z","end":"2026-07-14T23:00:07.223516Z","steps":["trace[762365151] 'process raft request' (duration: 425.685556ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:00:07.223703Z","caller":"traceutil/trace.go:171","msg":"trace[40731485] transaction","detail":"{read_only:false; response_revision:1327; number_of_response:1; }","duration":"426.187462ms","start":"2026-07-14T23:00:06.797503Z","end":"2026-07-14T23:00:07.223691Z","steps":["trace[40731485] 'process raft request' (duration: 426.028747ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:07.223718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:06.797248Z","time spent":"426.386788ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T23:00:07.223718Z","caller":"traceutil/trace.go:171","msg":"trace[748476696] linearizableReadLoop","detail":"{readStateIndex:1383; appliedIndex:1378; }","duration":"187.740311ms","start":"2026-07-14T23:00:07.035959Z","end":"2026-07-14T23:00:07.2237Z","steps":["trace[748476696] 'read index received' (duration: 93.751897ms)","trace[748476696] 'applied index is now lower than readState.Index' (duration: 93.987004ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T23:00:07.223805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:06.797497Z","time spent":"426.246933ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T23:00:07.223946Z","caller":"traceutil/trace.go:171","msg":"trace[1225336195] transaction","detail":"{read_only:false; response_revision:1326; number_of_response:1; }","duration":"426.633026ms","start":"2026-07-14T23:00:06.797284Z","end":"2026-07-14T23:00:07.223917Z","steps":["trace[1225336195] 'process raft request' (duration: 426.150321ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:07.224396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:06.797262Z","time spent":"426.75795ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T23:00:07.225828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.865508ms","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-07-14T23:00:07.225898Z","caller":"traceutil/trace.go:171","msg":"trace[215814210] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1327; }","duration":"189.969862ms","start":"2026-07-14T23:00:07.035908Z","end":"2026-07-14T23:00:07.225878Z","steps":["trace[215814210] 'agreement among raft nodes before linearized reading' (duration: 187.886825ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:14.297167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.021801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T23:00:14.297243Z","caller":"traceutil/trace.go:171","msg":"trace[2096282366] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1378; }","duration":"163.143315ms","start":"2026-07-14T23:00:14.134072Z","end":"2026-07-14T23:00:14.297215Z","steps":["trace[2096282366] 'count revisions from in-memory index tree' (duration: 162.871826ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:00:27.380936Z","caller":"traceutil/trace.go:171","msg":"trace[1067434985] linearizableReadLoop","detail":"{readStateIndex:1496; appliedIndex:1495; }","duration":"161.258904ms","start":"2026-07-14T23:00:27.219651Z","end":"2026-07-14T23:00:27.38091Z","steps":["trace[1067434985] 'read index received' (duration: 161.089588ms)","trace[1067434985] 'applied index is now lower than readState.Index' (duration: 168.166µs)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:00:27.381072Z","caller":"traceutil/trace.go:171","msg":"trace[723877266] transaction","detail":"{read_only:false; response_revision:1436; number_of_response:1; }","duration":"237.896404ms","start":"2026-07-14T23:00:27.143139Z","end":"2026-07-14T23:00:27.381036Z","steps":["trace[723877266] 'process raft request' (duration: 237.611525ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:27.381139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.466851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T23:00:27.381176Z","caller":"traceutil/trace.go:171","msg":"trace[1365890532] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1436; }","duration":"161.556274ms","start":"2026-07-14T23:00:27.219609Z","end":"2026-07-14T23:00:27.381165Z","steps":["trace[1365890532] 'agreement among raft nodes before linearized reading' (duration: 161.45381ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:27.479663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.915881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-14T23:00:27.479716Z","caller":"traceutil/trace.go:171","msg":"trace[1710747916] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1436; }","duration":"160.020024ms","start":"2026-07-14T23:00:27.319684Z","end":"2026-07-14T23:00:27.479704Z","steps":["trace[1710747916] 'agreement among raft nodes before linearized reading' (duration: 159.870799ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:27.479694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.512136ms","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-07-14T23:00:27.479761Z","caller":"traceutil/trace.go:171","msg":"trace[1860098102] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1436; }","duration":"158.61632ms","start":"2026-07-14T23:00:27.321131Z","end":"2026-07-14T23:00:27.479748Z","steps":["trace[1860098102] 'agreement among raft nodes before linearized reading' (duration: 158.414753ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:27.479767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.823461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-14T23:00:27.479837Z","caller":"traceutil/trace.go:171","msg":"trace[1984927285] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1436; }","duration":"216.923254ms","start":"2026-07-14T23:00:27.26289Z","end":"2026-07-14T23:00:27.479814Z","steps":["trace[1984927285] 'agreement among raft nodes before linearized reading' (duration: 216.729148ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:27.479906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.77144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-14T23:00:27.479926Z","caller":"traceutil/trace.go:171","msg":"trace[346137191] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1436; }","duration":"161.817692ms","start":"2026-07-14T23:00:27.318103Z","end":"2026-07-14T23:00:27.47992Z","steps":["trace[346137191] 'agreement among raft nodes before linearized reading' (duration: 161.76206ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:27.479992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.37296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"} {"level":"info","ts":"2026-07-14T23:00:27.48004Z","caller":"traceutil/trace.go:171","msg":"trace[772523815] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1436; }","duration":"213.443193ms","start":"2026-07-14T23:00:27.266583Z","end":"2026-07-14T23:00:27.480026Z","steps":["trace[772523815] 'agreement among raft nodes before linearized reading' (duration: 213.287338ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:27.480161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.921239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-14T23:00:27.480235Z","caller":"traceutil/trace.go:171","msg":"trace[680751041] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1436; }","duration":"159.033173ms","start":"2026-07-14T23:00:27.321186Z","end":"2026-07-14T23:00:27.480219Z","steps":["trace[680751041] 'agreement among raft nodes before linearized reading' (duration: 158.767544ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:00:27.748183Z","caller":"traceutil/trace.go:171","msg":"trace[399491232] transaction","detail":"{read_only:false; response_revision:1438; number_of_response:1; }","duration":"263.803571ms","start":"2026-07-14T23:00:27.484356Z","end":"2026-07-14T23:00:27.74816Z","steps":["trace[399491232] 'process raft request' (duration: 263.634236ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:00:27.748562Z","caller":"traceutil/trace.go:171","msg":"trace[365739600] transaction","detail":"{read_only:false; response_revision:1439; number_of_response:1; }","duration":"264.175224ms","start":"2026-07-14T23:00:27.484366Z","end":"2026-07-14T23:00:27.748541Z","steps":["trace[365739600] 'process raft request' (duration: 263.75999ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:00:27.74869Z","caller":"traceutil/trace.go:171","msg":"trace[370348949] transaction","detail":"{read_only:false; response_revision:1440; number_of_response:1; }","duration":"264.264707ms","start":"2026-07-14T23:00:27.484406Z","end":"2026-07-14T23:00:27.748671Z","steps":["trace[370348949] 'process raft request' (duration: 264.002428ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:00:27.748899Z","caller":"traceutil/trace.go:171","msg":"trace[2141790122] transaction","detail":"{read_only:false; response_revision:1441; number_of_response:1; }","duration":"264.444962ms","start":"2026-07-14T23:00:27.484429Z","end":"2026-07-14T23:00:27.748874Z","steps":["trace[2141790122] 'process raft request' (duration: 264.114482ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:00:27.749394Z","caller":"traceutil/trace.go:171","msg":"trace[1995286740] transaction","detail":"{read_only:false; response_revision:1442; number_of_response:1; }","duration":"264.841095ms","start":"2026-07-14T23:00:27.484533Z","end":"2026-07-14T23:00:27.749374Z","steps":["trace[1995286740] 'process raft request' (duration: 264.703741ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:00:27.749788Z","caller":"traceutil/trace.go:171","msg":"trace[1899080922] transaction","detail":"{read_only:false; response_revision:1443; number_of_response:1; }","duration":"264.185503ms","start":"2026-07-14T23:00:27.485569Z","end":"2026-07-14T23:00:27.749755Z","steps":["trace[1899080922] 'process raft request' (duration: 263.76443ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:01:27.822337Z","caller":"traceutil/trace.go:171","msg":"trace[1418754455] transaction","detail":"{read_only:false; response_revision:1713; number_of_response:1; }","duration":"153.705204ms","start":"2026-07-14T23:01:27.668608Z","end":"2026-07-14T23:01:27.822313Z","steps":["trace[1418754455] 'process raft request' (duration: 153.57921ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:01:34.366628Z","caller":"traceutil/trace.go:171","msg":"trace[1289127178] transaction","detail":"{read_only:false; response_revision:1746; number_of_response:1; }","duration":"123.743372ms","start":"2026-07-14T23:01:34.242824Z","end":"2026-07-14T23:01:34.366567Z","steps":["trace[1289127178] 'process raft request' (duration: 97.733758ms)","trace[1289127178] 'compare' (duration: 25.888891ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:01:35.040118Z","caller":"traceutil/trace.go:171","msg":"trace[2013509016] transaction","detail":"{read_only:false; response_revision:1749; number_of_response:1; }","duration":"198.654854ms","start":"2026-07-14T23:01:34.841434Z","end":"2026-07-14T23:01:35.040089Z","steps":["trace[2013509016] 'process raft request' (duration: 152.139737ms)","trace[2013509016] 'compare' (duration: 46.400313ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:03:26.06046Z","caller":"traceutil/trace.go:171","msg":"trace[1045498607] transaction","detail":"{read_only:false; response_revision:2257; number_of_response:1; }","duration":"143.094745ms","start":"2026-07-14T23:03:25.91734Z","end":"2026-07-14T23:03:26.060435Z","steps":["trace[1045498607] 'process raft request' (duration: 142.92485ms)"],"step_count":1}