{"level":"warn","ts":"2026-07-08T18:48:54.111333Z","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-08T18:48:54.111471Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.238: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.238:2380","--initial-cluster=instance=https://199.204.45.238:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.238:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.238: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-08T18:48:54.111571Z","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-08T18:48:54.111587Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.238:2380"]} {"level":"info","ts":"2026-07-08T18:48:54.111638Z","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-08T18:48:54.112573Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"]} {"level":"info","ts":"2026-07-08T18:48:54.112676Z","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.238:2380"],"listen-peer-urls":["https://199.204.45.238:2380"],"advertise-client-urls":["https://199.204.45.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.238: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-08T18:48:54.136066Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"23.050098ms"} {"level":"info","ts":"2026-07-08T18:48:54.179304Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d7dbc9f5893cc1f6","cluster-id":"823d1d08ab21430c"} {"level":"info","ts":"2026-07-08T18:48:54.179463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=()"} {"level":"info","ts":"2026-07-08T18:48:54.179514Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 0"} {"level":"info","ts":"2026-07-08T18:48:54.179589Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d7dbc9f5893cc1f6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-08T18:48:54.179617Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 1"} {"level":"info","ts":"2026-07-08T18:48:54.179687Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"} {"level":"warn","ts":"2026-07-08T18:48:54.193691Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-08T18:48:54.196688Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-08T18:48:54.202063Z","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-08T18:48:54.20496Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d7dbc9f5893cc1f6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-08T18:48:54.20517Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d7dbc9f5893cc1f6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-08T18:48:54.205505Z","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-08T18:48:54.205637Z","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-08T18:48:54.205669Z","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-08T18:48:54.207372Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"} {"level":"info","ts":"2026-07-08T18:48:54.207577Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"823d1d08ab21430c","local-member-id":"d7dbc9f5893cc1f6","added-peer-id":"d7dbc9f5893cc1f6","added-peer-peer-urls":["https://199.204.45.238:2380"]} {"level":"info","ts":"2026-07-08T18:48:54.208122Z","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-08T18:48:54.208265Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.238:2380"} {"level":"info","ts":"2026-07-08T18:48:54.208337Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.238:2380"} {"level":"info","ts":"2026-07-08T18:48:54.20853Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d7dbc9f5893cc1f6","initial-advertise-peer-urls":["https://199.204.45.238:2380"],"listen-peer-urls":["https://199.204.45.238:2380"],"advertise-client-urls":["https://199.204.45.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-08T18:48:54.208575Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-08T18:48:54.880868Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 is starting a new election at term 1"} {"level":"info","ts":"2026-07-08T18:48:54.880953Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-08T18:48:54.881016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgPreVoteResp from d7dbc9f5893cc1f6 at term 1"} {"level":"info","ts":"2026-07-08T18:48:54.881038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became candidate at term 2"} {"level":"info","ts":"2026-07-08T18:48:54.881057Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgVoteResp from d7dbc9f5893cc1f6 at term 2"} {"level":"info","ts":"2026-07-08T18:48:54.88107Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became leader at term 2"} {"level":"info","ts":"2026-07-08T18:48:54.881085Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d7dbc9f5893cc1f6 elected leader d7dbc9f5893cc1f6 at term 2"} {"level":"info","ts":"2026-07-08T18:48:54.88246Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T18:48:54.883678Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d7dbc9f5893cc1f6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.238:2379]}","request-path":"/0/members/d7dbc9f5893cc1f6/attributes","cluster-id":"823d1d08ab21430c","publish-timeout":"7s"} {"level":"info","ts":"2026-07-08T18:48:54.883794Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-08T18:48:54.884Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-08T18:48:54.884159Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-08T18:48:54.884208Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-08T18:48:54.888843Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.238:2379"} {"level":"info","ts":"2026-07-08T18:48:54.891469Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"823d1d08ab21430c","local-member-id":"d7dbc9f5893cc1f6","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T18:48:54.891597Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T18:48:54.891636Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T18:48:54.894503Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-08T18:48:57.249587Z","caller":"traceutil/trace.go:171","msg":"trace[1564264048] linearizableReadLoop","detail":"{readStateIndex:123; appliedIndex:121; }","duration":"122.636326ms","start":"2026-07-08T18:48:57.126924Z","end":"2026-07-08T18:48:57.24956Z","steps":["trace[1564264048] 'read index received' (duration: 29.773555ms)","trace[1564264048] 'applied index is now lower than readState.Index' (duration: 92.861721ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T18:48:57.249778Z","caller":"traceutil/trace.go:171","msg":"trace[1131902223] transaction","detail":"{read_only:false; response_revision:119; number_of_response:1; }","duration":"137.31394ms","start":"2026-07-08T18:48:57.112432Z","end":"2026-07-08T18:48:57.249746Z","steps":["trace[1131902223] 'process raft request' (duration: 102.347358ms)","trace[1131902223] 'compare' (duration: 34.575895ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T18:48:57.24987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.929499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-08T18:48:57.249933Z","caller":"traceutil/trace.go:171","msg":"trace[1829002196] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:119; }","duration":"123.029993ms","start":"2026-07-08T18:48:57.12689Z","end":"2026-07-08T18:48:57.24992Z","steps":["trace[1829002196] 'agreement among raft nodes before linearized reading' (duration: 122.826004ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:48:57.764409Z","caller":"traceutil/trace.go:171","msg":"trace[1188799617] transaction","detail":"{read_only:false; response_revision:145; number_of_response:1; }","duration":"350.325593ms","start":"2026-07-08T18:48:57.414055Z","end":"2026-07-08T18:48:57.76438Z","steps":["trace[1188799617] 'process raft request' (duration: 344.619254ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:48:57.765025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:48:57.414035Z","time spent":"350.458749ms","remote":"127.0.0.1:55160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":687,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T18:48:58.120579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.449128ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-08T18:48:58.120685Z","caller":"traceutil/trace.go:171","msg":"trace[2043864212] transaction","detail":"{read_only:false; response_revision:150; number_of_response:1; }","duration":"281.081273ms","start":"2026-07-08T18:48:57.839587Z","end":"2026-07-08T18:48:58.120668Z","steps":["trace[2043864212] 'process raft request' (duration: 105.295812ms)","trace[2043864212] 'compare' (duration: 175.300751ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T18:48:58.576272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.461921ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-08T18:48:58.576432Z","caller":"traceutil/trace.go:171","msg":"trace[64247141] transaction","detail":"{read_only:false; response_revision:153; number_of_response:1; }","duration":"364.569161ms","start":"2026-07-08T18:48:58.211834Z","end":"2026-07-08T18:48:58.576403Z","steps":["trace[64247141] 'process raft request' (duration: 49.902882ms)","trace[64247141] 'compare' (duration: 314.336996ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T18:48:58.576408Z","caller":"traceutil/trace.go:171","msg":"trace[1905693368] linearizableReadLoop","detail":"{readStateIndex:157; appliedIndex:156; }","duration":"349.419036ms","start":"2026-07-08T18:48:58.226972Z","end":"2026-07-08T18:48:58.576391Z","steps":["trace[1905693368] 'read index received' (duration: 34.684873ms)","trace[1905693368] 'applied index is now lower than readState.Index' (duration: 314.732843ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T18:48:58.576644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.670206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T18:48:58.576763Z","caller":"traceutil/trace.go:171","msg":"trace[413182942] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:153; }","duration":"349.833083ms","start":"2026-07-08T18:48:58.226916Z","end":"2026-07-08T18:48:58.576749Z","steps":["trace[413182942] 'agreement among raft nodes before linearized reading' (duration: 349.648985ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:48:58.576834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:48:58.226893Z","time spent":"349.931427ms","remote":"127.0.0.1:54836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-08T18:48:58.576966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.222009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"warn","ts":"2026-07-08T18:48:58.576556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:48:58.211817Z","time spent":"364.688216ms","remote":"127.0.0.1:55160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":945,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T18:48:58.577029Z","caller":"traceutil/trace.go:171","msg":"trace[1041519580] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:153; }","duration":"342.326903ms","start":"2026-07-08T18:48:58.234688Z","end":"2026-07-08T18:48:58.577015Z","steps":["trace[1041519580] 'agreement among raft nodes before linearized reading' (duration: 342.197587ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:48:58.577194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:48:58.234671Z","time spent":"342.50614ms","remote":"127.0.0.1:55076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-08T18:48:58.577304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.802858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-07-08T18:48:58.577399Z","caller":"traceutil/trace.go:171","msg":"trace[1076213098] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:153; }","duration":"339.968905ms","start":"2026-07-08T18:48:58.237412Z","end":"2026-07-08T18:48:58.577381Z","steps":["trace[1076213098] 'agreement among raft nodes before linearized reading' (duration: 339.631611ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:48:58.577474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:48:58.237387Z","time spent":"340.074739ms","remote":"127.0.0.1:55076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-08T18:48:58.741865Z","caller":"traceutil/trace.go:171","msg":"trace[910150304] transaction","detail":"{read_only:false; response_revision:156; number_of_response:1; }","duration":"159.281801ms","start":"2026-07-08T18:48:58.582559Z","end":"2026-07-08T18:48:58.74184Z","steps":["trace[910150304] 'process raft request' (duration: 159.215248ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:48:58.742026Z","caller":"traceutil/trace.go:171","msg":"trace[482207651] transaction","detail":"{read_only:false; response_revision:155; number_of_response:1; }","duration":"159.436067ms","start":"2026-07-08T18:48:58.582478Z","end":"2026-07-08T18:48:58.741914Z","steps":["trace[482207651] 'process raft request' (duration: 142.076179ms)","trace[482207651] 'compare' (duration: 17.086326ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T18:49:05.216328Z","caller":"traceutil/trace.go:171","msg":"trace[1078920612] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"207.015655ms","start":"2026-07-08T18:49:05.009289Z","end":"2026-07-08T18:49:05.216304Z","steps":["trace[1078920612] 'process raft request' (duration: 206.90563ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:06.983391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.656654816s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-08T18:49:06.983537Z","caller":"traceutil/trace.go:171","msg":"trace[289131594] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"1.758500204s","start":"2026-07-08T18:49:05.225006Z","end":"2026-07-08T18:49:06.983506Z","steps":["trace[289131594] 'process raft request' (duration: 101.651072ms)","trace[289131594] 'compare' (duration: 1.656196898s)"],"step_count":2} {"level":"warn","ts":"2026-07-08T18:49:06.983667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:05.224983Z","time spent":"1.758622509s","remote":"127.0.0.1:55012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":194,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T18:49:06.983492Z","caller":"traceutil/trace.go:171","msg":"trace[850326826] linearizableReadLoop","detail":"{readStateIndex:348; appliedIndex:347; }","duration":"1.207035428s","start":"2026-07-08T18:49:05.776441Z","end":"2026-07-08T18:49:06.983477Z","steps":["trace[850326826] 'read index received' (duration: 35.722µs)","trace[850326826] 'applied index is now lower than readState.Index' (duration: 1.206998416s)"],"step_count":2} {"level":"warn","ts":"2026-07-08T18:49:06.984199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.207742274s","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-08T18:49:06.984243Z","caller":"traceutil/trace.go:171","msg":"trace[616656709] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:336; }","duration":"1.207826027s","start":"2026-07-08T18:49:05.776403Z","end":"2026-07-08T18:49:06.984229Z","steps":["trace[616656709] 'agreement among raft nodes before linearized reading' (duration: 1.207711383s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:06.984275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:05.776386Z","time spent":"1.20788248s","remote":"127.0.0.1:55076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-08T18:49:06.99288Z","caller":"traceutil/trace.go:171","msg":"trace[1308184216] transaction","detail":"{read_only:false; response_revision:337; number_of_response:1; }","duration":"634.460485ms","start":"2026-07-08T18:49:06.358398Z","end":"2026-07-08T18:49:06.992859Z","steps":["trace[1308184216] 'process raft request' (duration: 634.355571ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:06.992967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.320686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-07-08T18:49:06.993006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.436384ms","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-08T18:49:06.993034Z","caller":"traceutil/trace.go:171","msg":"trace[1179163220] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:337; }","duration":"311.397669ms","start":"2026-07-08T18:49:06.681624Z","end":"2026-07-08T18:49:06.993022Z","steps":["trace[1179163220] 'agreement among raft nodes before linearized reading' (duration: 311.238933ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:06.993047Z","caller":"traceutil/trace.go:171","msg":"trace[896812453] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:337; }","duration":"399.511696ms","start":"2026-07-08T18:49:06.593524Z","end":"2026-07-08T18:49:06.993035Z","steps":["trace[896812453] 'agreement among raft nodes before linearized reading' (duration: 399.447304ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:06.993062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:06.681579Z","time spent":"311.477202ms","remote":"127.0.0.1:55076","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-08T18:49:06.993072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:06.593503Z","time spent":"399.563588ms","remote":"127.0.0.1:55076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-08T18:49:06.99312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:06.358373Z","time spent":"634.557719ms","remote":"127.0.0.1:55076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T18:49:06.993168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.44772ms","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-08T18:49:06.993187Z","caller":"traceutil/trace.go:171","msg":"trace[756859938] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:337; }","duration":"217.489152ms","start":"2026-07-08T18:49:06.775692Z","end":"2026-07-08T18:49:06.993181Z","steps":["trace[756859938] 'agreement among raft nodes before linearized reading' (duration: 217.45392ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:07.493853Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976533603966952962,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-08T18:49:07.994602Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976533603966952962,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-08T18:49:08.033171Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.040385718s","expected-duration":"1s"} {"level":"info","ts":"2026-07-08T18:49:08.033559Z","caller":"traceutil/trace.go:171","msg":"trace[380332280] transaction","detail":"{read_only:false; response_revision:338; number_of_response:1; }","duration":"1.04551715s","start":"2026-07-08T18:49:06.988006Z","end":"2026-07-08T18:49:08.033524Z","steps":["trace[380332280] 'process raft request' (duration: 1.045396616s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:08.033697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:06.987995Z","time spent":"1.045633075s","remote":"127.0.0.1:55076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T18:49:08.085528Z","caller":"traceutil/trace.go:171","msg":"trace[918284717] transaction","detail":"{read_only:false; response_revision:339; number_of_response:1; }","duration":"1.089330948s","start":"2026-07-08T18:49:06.996174Z","end":"2026-07-08T18:49:08.085505Z","steps":["trace[918284717] 'process raft request' (duration: 1.089171192s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:08.085677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:06.996154Z","time spent":"1.089450571s","remote":"127.0.0.1:55076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T18:49:08.085789Z","caller":"traceutil/trace.go:171","msg":"trace[1662339632] linearizableReadLoop","detail":"{readStateIndex:353; appliedIndex:349; }","duration":"1.092926372s","start":"2026-07-08T18:49:06.992839Z","end":"2026-07-08T18:49:08.085766Z","steps":["trace[1662339632] 'read index received' (duration: 1.040611545s)","trace[1662339632] 'applied index is now lower than readState.Index' (duration: 52.313887ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T18:49:08.085813Z","caller":"traceutil/trace.go:171","msg":"trace[598325973] transaction","detail":"{read_only:false; response_revision:341; number_of_response:1; }","duration":"1.08860632s","start":"2026-07-08T18:49:06.997197Z","end":"2026-07-08T18:49:08.085803Z","steps":["trace[598325973] 'process raft request' (duration: 1.088481705s)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:08.085856Z","caller":"traceutil/trace.go:171","msg":"trace[443579190] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"1.089568636s","start":"2026-07-08T18:49:06.996263Z","end":"2026-07-08T18:49:08.085832Z","steps":["trace[443579190] 'process raft request' (duration: 1.089200812s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:08.085904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.098740401s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cronjob-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T18:49:08.085938Z","caller":"traceutil/trace.go:171","msg":"trace[1399564320] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cronjob-controller; range_end:; response_count:0; response_revision:341; }","duration":"1.098799233s","start":"2026-07-08T18:49:06.987129Z","end":"2026-07-08T18:49:08.085929Z","steps":["trace[1399564320] 'agreement among raft nodes before linearized reading' (duration: 1.098747052s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:08.085958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:06.997164Z","time spent":"1.088710613s","remote":"127.0.0.1:55076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T18:49:08.085975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:06.987115Z","time spent":"1.098852436s","remote":"127.0.0.1:55012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":29,"request content":"key:\"/registry/serviceaccounts/kube-system/cronjob-controller\" "} {"level":"warn","ts":"2026-07-08T18:49:08.085975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:06.996252Z","time spent":"1.08966216s","remote":"127.0.0.1:55076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T18:49:08.586963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.8106ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T18:49:08.587118Z","caller":"traceutil/trace.go:171","msg":"trace[831653519] linearizableReadLoop","detail":"{readStateIndex:376; appliedIndex:374; }","duration":"121.758253ms","start":"2026-07-08T18:49:08.465344Z","end":"2026-07-08T18:49:08.587103Z","steps":["trace[831653519] 'read index received' (duration: 72.748538ms)","trace[831653519] 'applied index is now lower than readState.Index' (duration: 49.008665ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T18:49:08.587202Z","caller":"traceutil/trace.go:171","msg":"trace[690744182] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"230.873711ms","start":"2026-07-08T18:49:08.35632Z","end":"2026-07-08T18:49:08.587193Z","steps":["trace[690744182] 'process raft request' (duration: 230.735425ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:08.587226Z","caller":"traceutil/trace.go:171","msg":"trace[942621139] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"247.789384ms","start":"2026-07-08T18:49:08.339408Z","end":"2026-07-08T18:49:08.587197Z","steps":["trace[942621139] 'process raft request' (duration: 95.675503ms)","trace[942621139] 'compare' (duration: 151.678245ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T18:49:08.588185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.810822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-07-08T18:49:08.58846Z","caller":"traceutil/trace.go:171","msg":"trace[1899317587] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:364; }","duration":"123.077322ms","start":"2026-07-08T18:49:08.465339Z","end":"2026-07-08T18:49:08.588416Z","steps":["trace[1899317587] 'agreement among raft nodes before linearized reading' (duration: 121.978981ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:08.588571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.314399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"warn","ts":"2026-07-08T18:49:08.588721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.955197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-07-08T18:49:08.588746Z","caller":"traceutil/trace.go:171","msg":"trace[106084600] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:364; }","duration":"117.502037ms","start":"2026-07-08T18:49:08.471183Z","end":"2026-07-08T18:49:08.588685Z","steps":["trace[106084600] 'agreement among raft nodes before linearized reading' (duration: 117.04381ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:08.588811Z","caller":"traceutil/trace.go:171","msg":"trace[1938365542] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:364; }","duration":"101.060731ms","start":"2026-07-08T18:49:08.487729Z","end":"2026-07-08T18:49:08.58879Z","steps":["trace[1938365542] 'agreement among raft nodes before linearized reading' (duration: 100.671567ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:08.588332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.381736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6965"} {"level":"warn","ts":"2026-07-08T18:49:08.588574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.475149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-07-08T18:49:08.588999Z","caller":"traceutil/trace.go:171","msg":"trace[2004822155] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:364; }","duration":"123.053471ms","start":"2026-07-08T18:49:08.465911Z","end":"2026-07-08T18:49:08.588965Z","steps":["trace[2004822155] 'agreement among raft nodes before linearized reading' (duration: 122.20605ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:08.589026Z","caller":"traceutil/trace.go:171","msg":"trace[1114581790] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:364; }","duration":"122.931246ms","start":"2026-07-08T18:49:08.466076Z","end":"2026-07-08T18:49:08.589007Z","steps":["trace[1114581790] 'agreement among raft nodes before linearized reading' (duration: 122.290103ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:08.588336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.187904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-07-08T18:49:08.589141Z","caller":"traceutil/trace.go:171","msg":"trace[1078240423] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:364; }","duration":"111.982084ms","start":"2026-07-08T18:49:08.477091Z","end":"2026-07-08T18:49:08.589073Z","steps":["trace[1078240423] 'agreement among raft nodes before linearized reading' (duration: 111.010708ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:08.732951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.153667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"warn","ts":"2026-07-08T18:49:08.733021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.093585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-07-08T18:49:08.732973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.870906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-07-08T18:49:08.733031Z","caller":"traceutil/trace.go:171","msg":"trace[80391929] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"133.34907ms","start":"2026-07-08T18:49:08.599664Z","end":"2026-07-08T18:49:08.733013Z","steps":["trace[80391929] 'process raft request' (duration: 133.07251ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:08.73307Z","caller":"traceutil/trace.go:171","msg":"trace[1137541280] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:366; }","duration":"137.987901ms","start":"2026-07-08T18:49:08.595074Z","end":"2026-07-08T18:49:08.733062Z","steps":["trace[1137541280] 'agreement among raft nodes before linearized reading' (duration: 137.824745ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:08.733075Z","caller":"traceutil/trace.go:171","msg":"trace[857285943] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:366; }","duration":"138.157967ms","start":"2026-07-08T18:49:08.594903Z","end":"2026-07-08T18:49:08.733061Z","steps":["trace[857285943] 'agreement among raft nodes before linearized reading' (duration: 138.056423ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:08.733036Z","caller":"traceutil/trace.go:171","msg":"trace[596241070] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:366; }","duration":"138.263031ms","start":"2026-07-08T18:49:08.594758Z","end":"2026-07-08T18:49:08.733021Z","steps":["trace[596241070] 'agreement among raft nodes before linearized reading' (duration: 138.115185ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:08.73339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.265111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-07-08T18:49:08.733498Z","caller":"traceutil/trace.go:171","msg":"trace[1815239557] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:366; }","duration":"138.596793ms","start":"2026-07-08T18:49:08.594879Z","end":"2026-07-08T18:49:08.733476Z","steps":["trace[1815239557] 'agreement among raft nodes before linearized reading' (duration: 138.201199ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:11.926892Z","caller":"traceutil/trace.go:171","msg":"trace[828972430] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"142.634789ms","start":"2026-07-08T18:49:11.784225Z","end":"2026-07-08T18:49:11.926859Z","steps":["trace[828972430] 'process raft request' (duration: 142.415211ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:12.202998Z","caller":"traceutil/trace.go:171","msg":"trace[360907218] linearizableReadLoop","detail":"{readStateIndex:418; appliedIndex:417; }","duration":"155.582609ms","start":"2026-07-08T18:49:12.047385Z","end":"2026-07-08T18:49:12.202968Z","steps":["trace[360907218] 'read index received' (duration: 155.371341ms)","trace[360907218] 'applied index is now lower than readState.Index' (duration: 209.987µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T18:49:12.203046Z","caller":"traceutil/trace.go:171","msg":"trace[2146587928] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"265.351559ms","start":"2026-07-08T18:49:11.937663Z","end":"2026-07-08T18:49:12.203015Z","steps":["trace[2146587928] 'process raft request' (duration: 265.130391ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:12.203255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.839057ms","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-08T18:49:12.203367Z","caller":"traceutil/trace.go:171","msg":"trace[1291576624] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:405; }","duration":"156.001473ms","start":"2026-07-08T18:49:12.047339Z","end":"2026-07-08T18:49:12.203341Z","steps":["trace[1291576624] 'agreement among raft nodes before linearized reading' (duration: 155.785315ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:12.243495Z","caller":"traceutil/trace.go:171","msg":"trace[1104820374] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"175.929385ms","start":"2026-07-08T18:49:12.067537Z","end":"2026-07-08T18:49:12.243466Z","steps":["trace[1104820374] 'process raft request' (duration: 174.856937ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:12.243902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.851631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-08T18:49:12.243975Z","caller":"traceutil/trace.go:171","msg":"trace[1058921090] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:407; }","duration":"123.973385ms","start":"2026-07-08T18:49:12.11999Z","end":"2026-07-08T18:49:12.243963Z","steps":["trace[1058921090] 'agreement among raft nodes before linearized reading' (duration: 123.83549ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:12.24416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.921334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-07-08T18:49:12.244213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.1038ms","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-08T18:49:12.244263Z","caller":"traceutil/trace.go:171","msg":"trace[1020668668] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:407; }","duration":"124.192533ms","start":"2026-07-08T18:49:12.120061Z","end":"2026-07-08T18:49:12.244253Z","steps":["trace[1020668668] 'agreement among raft nodes before linearized reading' (duration: 124.116381ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:12.244358Z","caller":"traceutil/trace.go:171","msg":"trace[516764367] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:407; }","duration":"124.370089ms","start":"2026-07-08T18:49:12.11997Z","end":"2026-07-08T18:49:12.24434Z","steps":["trace[516764367] 'agreement among raft nodes before linearized reading' (duration: 123.928804ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:13.974304Z","caller":"traceutil/trace.go:171","msg":"trace[266543172] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"105.999521ms","start":"2026-07-08T18:49:13.868274Z","end":"2026-07-08T18:49:13.974273Z","steps":["trace[266543172] 'process raft request' (duration: 86.16234ms)","trace[266543172] 'compare' (duration: 19.700406ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T18:49:16.516758Z","caller":"traceutil/trace.go:171","msg":"trace[1434639289] transaction","detail":"{read_only:false; response_revision:423; number_of_response:1; }","duration":"228.924726ms","start":"2026-07-08T18:49:16.28781Z","end":"2026-07-08T18:49:16.516735Z","steps":["trace[1434639289] 'process raft request' (duration: 228.788401ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:16.519362Z","caller":"traceutil/trace.go:171","msg":"trace[1668120994] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"231.508412ms","start":"2026-07-08T18:49:16.287828Z","end":"2026-07-08T18:49:16.519336Z","steps":["trace[1668120994] 'process raft request' (duration: 231.294545ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:16.519604Z","caller":"traceutil/trace.go:171","msg":"trace[465576505] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"231.7333ms","start":"2026-07-08T18:49:16.287851Z","end":"2026-07-08T18:49:16.519584Z","steps":["trace[465576505] 'process raft request' (duration: 231.369157ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:19.025971Z","caller":"traceutil/trace.go:171","msg":"trace[1654328044] linearizableReadLoop","detail":"{readStateIndex:444; appliedIndex:442; }","duration":"499.433082ms","start":"2026-07-08T18:49:18.526514Z","end":"2026-07-08T18:49:19.025947Z","steps":["trace[1654328044] 'read index received' (duration: 50.607409ms)","trace[1654328044] 'applied index is now lower than readState.Index' (duration: 448.824493ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T18:49:19.026019Z","caller":"traceutil/trace.go:171","msg":"trace[1595459396] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"499.841996ms","start":"2026-07-08T18:49:18.526146Z","end":"2026-07-08T18:49:19.025988Z","steps":["trace[1595459396] 'process raft request' (duration: 499.650809ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:19.026111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.582838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-08T18:49:19.026158Z","caller":"traceutil/trace.go:171","msg":"trace[1342114754] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:429; }","duration":"499.64609ms","start":"2026-07-08T18:49:18.526497Z","end":"2026-07-08T18:49:19.026143Z","steps":["trace[1342114754] 'agreement among raft nodes before linearized reading' (duration: 499.553747ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:19.026174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:18.526133Z","time spent":"499.95492ms","remote":"127.0.0.1:55076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T18:49:19.0262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:18.526434Z","time spent":"499.756563ms","remote":"127.0.0.1:55076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-08T18:49:19.224385Z","caller":"traceutil/trace.go:171","msg":"trace[544435875] linearizableReadLoop","detail":"{readStateIndex:445; appliedIndex:444; }","duration":"117.66967ms","start":"2026-07-08T18:49:19.106688Z","end":"2026-07-08T18:49:19.224358Z","steps":["trace[544435875] 'read index received' (duration: 114.418564ms)","trace[544435875] 'applied index is now lower than readState.Index' (duration: 3.250106ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T18:49:19.224495Z","caller":"traceutil/trace.go:171","msg":"trace[1894095122] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"193.833215ms","start":"2026-07-08T18:49:19.03063Z","end":"2026-07-08T18:49:19.224463Z","steps":["trace[1894095122] 'process raft request' (duration: 190.492586ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:19.224561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.861317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T18:49:19.224601Z","caller":"traceutil/trace.go:171","msg":"trace[1099621563] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:430; }","duration":"117.915338ms","start":"2026-07-08T18:49:19.106673Z","end":"2026-07-08T18:49:19.224589Z","steps":["trace[1099621563] 'agreement among raft nodes before linearized reading' (duration: 117.836666ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:21.169861Z","caller":"traceutil/trace.go:171","msg":"trace[213518530] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"136.946575ms","start":"2026-07-08T18:49:21.032886Z","end":"2026-07-08T18:49:21.169832Z","steps":["trace[213518530] 'process raft request' (duration: 136.705577ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:22.179084Z","caller":"traceutil/trace.go:171","msg":"trace[1776123300] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"136.490825ms","start":"2026-07-08T18:49:22.042557Z","end":"2026-07-08T18:49:22.179047Z","steps":["trace[1776123300] 'process raft request' (duration: 136.316759ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:27.480525Z","caller":"traceutil/trace.go:171","msg":"trace[828396870] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"101.073973ms","start":"2026-07-08T18:49:27.379433Z","end":"2026-07-08T18:49:27.480507Z","steps":["trace[828396870] 'process raft request' (duration: 100.97128ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:36.611205Z","caller":"traceutil/trace.go:171","msg":"trace[1149589301] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"156.04854ms","start":"2026-07-08T18:49:36.455126Z","end":"2026-07-08T18:49:36.611174Z","steps":["trace[1149589301] 'process raft request' (duration: 155.711131ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:39.866132Z","caller":"traceutil/trace.go:171","msg":"trace[1246169153] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"480.73936ms","start":"2026-07-08T18:49:39.385366Z","end":"2026-07-08T18:49:39.866105Z","steps":["trace[1246169153] 'process raft request' (duration: 480.482033ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:39.866362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:39.385339Z","time spent":"480.939476ms","remote":"127.0.0.1:55076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T18:49:40.020269Z","caller":"traceutil/trace.go:171","msg":"trace[1389212900] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"507.949953ms","start":"2026-07-08T18:49:39.51227Z","end":"2026-07-08T18:49:40.02022Z","steps":["trace[1389212900] 'process raft request' (duration: 507.648225ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:40.020485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:39.512251Z","time spent":"508.115497ms","remote":"127.0.0.1:54868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T18:49:40.020717Z","caller":"traceutil/trace.go:171","msg":"trace[640622175] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"492.44745ms","start":"2026-07-08T18:49:39.528255Z","end":"2026-07-08T18:49:40.020702Z","steps":["trace[640622175] 'process raft request' (duration: 492.024339ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:40.020778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:39.528247Z","time spent":"492.504781ms","remote":"127.0.0.1:54868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T18:49:40.020957Z","caller":"traceutil/trace.go:171","msg":"trace[1225903659] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"502.479407ms","start":"2026-07-08T18:49:39.518455Z","end":"2026-07-08T18:49:40.020935Z","steps":["trace[1225903659] 'process raft request' (duration: 501.715877ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:40.021011Z","caller":"traceutil/trace.go:171","msg":"trace[984752495] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"492.812969ms","start":"2026-07-08T18:49:39.528187Z","end":"2026-07-08T18:49:40.021Z","steps":["trace[984752495] 'process raft request' (duration: 492.033278ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:40.021064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:39.52817Z","time spent":"492.870061ms","remote":"127.0.0.1:54868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T18:49:40.02113Z","caller":"traceutil/trace.go:171","msg":"trace[1514854201] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"506.314439ms","start":"2026-07-08T18:49:39.514806Z","end":"2026-07-08T18:49:40.02112Z","steps":["trace[1514854201] 'process raft request' (duration: 505.307942ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:40.021088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:39.518437Z","time spent":"502.592219ms","remote":"127.0.0.1:54868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T18:49:40.022105Z","caller":"traceutil/trace.go:171","msg":"trace[1276330954] linearizableReadLoop","detail":"{readStateIndex:569; appliedIndex:561; }","duration":"488.941305ms","start":"2026-07-08T18:49:39.533112Z","end":"2026-07-08T18:49:40.022053Z","steps":["trace[1276330954] 'read index received' (duration: 332.8457ms)","trace[1276330954] 'applied index is now lower than readState.Index' (duration: 156.055144ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T18:49:40.023011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.86636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.238\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-08T18:49:40.023122Z","caller":"traceutil/trace.go:171","msg":"trace[736004342] range","detail":"{range_begin:/registry/masterleases/199.204.45.238; range_end:; response_count:1; response_revision:553; }","duration":"490.010814ms","start":"2026-07-08T18:49:39.533088Z","end":"2026-07-08T18:49:40.023099Z","steps":["trace[736004342] 'agreement among raft nodes before linearized reading' (duration: 489.323846ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:40.02215Z","caller":"traceutil/trace.go:171","msg":"trace[1203941470] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"492.873331ms","start":"2026-07-08T18:49:39.529265Z","end":"2026-07-08T18:49:40.022138Z","steps":["trace[1203941470] 'process raft request' (duration: 491.065023ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:40.023181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:39.53308Z","time spent":"490.083666ms","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.204.45.238\" "} {"level":"warn","ts":"2026-07-08T18:49:40.023337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:39.529245Z","time spent":"494.00292ms","remote":"127.0.0.1:54868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T18:49:40.023478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.597302ms","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-08T18:49:40.023548Z","caller":"traceutil/trace.go:171","msg":"trace[1011786527] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:553; }","duration":"471.678544ms","start":"2026-07-08T18:49:39.551853Z","end":"2026-07-08T18:49:40.023532Z","steps":["trace[1011786527] 'agreement among raft nodes before linearized reading' (duration: 471.366856ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:40.0236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:39.551801Z","time spent":"471.788008ms","remote":"127.0.0.1:55076","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-08T18:49:40.022203Z","caller":"traceutil/trace.go:171","msg":"trace[7203180] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"489.242243ms","start":"2026-07-08T18:49:39.532948Z","end":"2026-07-08T18:49:40.02219Z","steps":["trace[7203180] 'process raft request' (duration: 487.432255ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:40.024365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:39.53293Z","time spent":"491.40119ms","remote":"127.0.0.1:54868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T18:49:40.024726Z","caller":"traceutil/trace.go:171","msg":"trace[1032615504] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"351.244186ms","start":"2026-07-08T18:49:39.671024Z","end":"2026-07-08T18:49:40.022268Z","steps":["trace[1032615504] 'process raft request' (duration: 350.091156ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:40.024867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:39.671007Z","time spent":"353.779972ms","remote":"127.0.0.1:54868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T18:49:40.022104Z","caller":"traceutil/trace.go:171","msg":"trace[1479077434] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"461.036062ms","start":"2026-07-08T18:49:39.561047Z","end":"2026-07-08T18:49:40.022083Z","steps":["trace[1479077434] 'process raft request' (duration: 459.664286ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:40.028666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:39.561036Z","time spent":"467.596135ms","remote":"127.0.0.1:54868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T18:49:40.022458Z","caller":"traceutil/trace.go:171","msg":"trace[69496989] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"477.85744ms","start":"2026-07-08T18:49:39.544376Z","end":"2026-07-08T18:49:40.022233Z","steps":["trace[69496989] 'process raft request' (duration: 476.058993ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:40.028805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:39.544356Z","time spent":"484.419703ms","remote":"127.0.0.1:54868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T18:49:40.022545Z","caller":"traceutil/trace.go:171","msg":"trace[436159206] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"448.515048ms","start":"2026-07-08T18:49:39.573733Z","end":"2026-07-08T18:49:40.022248Z","steps":["trace[436159206] 'process raft request' (duration: 447.142572ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:40.028963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:39.573709Z","time spent":"455.223915ms","remote":"127.0.0.1:54868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T18:49:40.022579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:39.514794Z","time spent":"506.35692ms","remote":"127.0.0.1:54868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T18:49:40.0227Z","caller":"traceutil/trace.go:171","msg":"trace[1353369004] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"467.452063ms","start":"2026-07-08T18:49:39.555039Z","end":"2026-07-08T18:49:40.022491Z","steps":["trace[1353369004] 'process raft request' (duration: 465.517562ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:40.029175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:39.555026Z","time spent":"474.126839ms","remote":"127.0.0.1:54868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T18:49:40.266794Z","caller":"traceutil/trace.go:171","msg":"trace[532353781] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"236.653017ms","start":"2026-07-08T18:49:40.030112Z","end":"2026-07-08T18:49:40.266765Z","steps":["trace[532353781] 'process raft request' (duration: 212.448398ms)","trace[532353781] 'compare' (duration: 24.012554ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T18:49:40.268007Z","caller":"traceutil/trace.go:171","msg":"trace[302654119] transaction","detail":"{read_only:false; number_of_response:1; response_revision:557; }","duration":"222.071152ms","start":"2026-07-08T18:49:40.045908Z","end":"2026-07-08T18:49:40.267979Z","steps":["trace[302654119] 'process raft request' (duration: 221.62489ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:40.26823Z","caller":"traceutil/trace.go:171","msg":"trace[458126202] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"164.731469ms","start":"2026-07-08T18:49:40.103463Z","end":"2026-07-08T18:49:40.268194Z","steps":["trace[458126202] 'process raft request' (duration: 164.679707ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:40.268304Z","caller":"traceutil/trace.go:171","msg":"trace[1013578333] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"236.989095ms","start":"2026-07-08T18:49:40.031265Z","end":"2026-07-08T18:49:40.268254Z","steps":["trace[1013578333] 'process raft request' (duration: 235.991219ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:40.268447Z","caller":"traceutil/trace.go:171","msg":"trace[1317356218] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"236.428471ms","start":"2026-07-08T18:49:40.032008Z","end":"2026-07-08T18:49:40.268436Z","steps":["trace[1317356218] 'process raft request' (duration: 235.427405ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:40.268712Z","caller":"traceutil/trace.go:171","msg":"trace[585662699] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"222.698139ms","start":"2026-07-08T18:49:40.046Z","end":"2026-07-08T18:49:40.268698Z","steps":["trace[585662699] 'process raft request' (duration: 221.579669ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:40.268867Z","caller":"traceutil/trace.go:171","msg":"trace[1974735981] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"222.029451ms","start":"2026-07-08T18:49:40.046824Z","end":"2026-07-08T18:49:40.268853Z","steps":["trace[1974735981] 'process raft request' (duration: 221.099967ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:40.268983Z","caller":"traceutil/trace.go:171","msg":"trace[1437919962] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"222.943555ms","start":"2026-07-08T18:49:40.046032Z","end":"2026-07-08T18:49:40.268976Z","steps":["trace[1437919962] 'process raft request' (duration: 221.638731ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:40.269119Z","caller":"traceutil/trace.go:171","msg":"trace[1111494148] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"221.840226ms","start":"2026-07-08T18:49:40.04726Z","end":"2026-07-08T18:49:40.2691Z","steps":["trace[1111494148] 'process raft request' (duration: 220.785118ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:40.269244Z","caller":"traceutil/trace.go:171","msg":"trace[1308470954] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"222.873723ms","start":"2026-07-08T18:49:40.046356Z","end":"2026-07-08T18:49:40.269229Z","steps":["trace[1308470954] 'process raft request' (duration: 221.350883ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:40.269274Z","caller":"traceutil/trace.go:171","msg":"trace[1271516792] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"222.467213ms","start":"2026-07-08T18:49:40.046795Z","end":"2026-07-08T18:49:40.269262Z","steps":["trace[1271516792] 'process raft request' (duration: 221.006044ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:40.26939Z","caller":"traceutil/trace.go:171","msg":"trace[530026526] transaction","detail":"{read_only:false; number_of_response:0; response_revision:564; }","duration":"210.723002ms","start":"2026-07-08T18:49:40.058657Z","end":"2026-07-08T18:49:40.26938Z","steps":["trace[530026526] 'process raft request' (duration: 209.453069ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:40.269382Z","caller":"traceutil/trace.go:171","msg":"trace[147041922] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"222.679978ms","start":"2026-07-08T18:49:40.046674Z","end":"2026-07-08T18:49:40.269354Z","steps":["trace[147041922] 'process raft request' (duration: 221.073566ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:40.794729Z","caller":"traceutil/trace.go:171","msg":"trace[356514379] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"362.901109ms","start":"2026-07-08T18:49:40.431799Z","end":"2026-07-08T18:49:40.7947Z","steps":["trace[356514379] 'process raft request' (duration: 353.716867ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:40.79488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:40.431773Z","time spent":"363.032953ms","remote":"127.0.0.1:54868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31121,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T18:49:40.795033Z","caller":"traceutil/trace.go:171","msg":"trace[1607775146] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:609; }","duration":"172.131643ms","start":"2026-07-08T18:49:40.62287Z","end":"2026-07-08T18:49:40.795002Z","steps":["trace[1607775146] 'read index received' (duration: 162.656153ms)","trace[1607775146] 'applied index is now lower than readState.Index' (duration: 9.47448ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T18:49:40.795074Z","caller":"traceutil/trace.go:171","msg":"trace[282619118] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"353.120721ms","start":"2026-07-08T18:49:40.441902Z","end":"2026-07-08T18:49:40.795023Z","steps":["trace[282619118] 'process raft request' (duration: 352.854244ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:40.79525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:40.441881Z","time spent":"353.294116ms","remote":"127.0.0.1:54868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64392,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T18:49:40.795319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.434892ms","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-08T18:49:40.795091Z","caller":"traceutil/trace.go:171","msg":"trace[2134651558] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"348.679884ms","start":"2026-07-08T18:49:40.446385Z","end":"2026-07-08T18:49:40.795065Z","steps":["trace[2134651558] 'process raft request' (duration: 348.509589ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:40.795372Z","caller":"traceutil/trace.go:171","msg":"trace[662523524] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:586; }","duration":"172.534864ms","start":"2026-07-08T18:49:40.62282Z","end":"2026-07-08T18:49:40.795355Z","steps":["trace[662523524] 'agreement among raft nodes before linearized reading' (duration: 172.328019ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:40.795434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:40.446374Z","time spent":"349.014532ms","remote":"127.0.0.1:54868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T18:49:41.508693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.732145ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T18:49:41.508801Z","caller":"traceutil/trace.go:171","msg":"trace[494649263] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"289.13199ms","start":"2026-07-08T18:49:41.219652Z","end":"2026-07-08T18:49:41.508784Z","steps":["trace[494649263] 'process raft request' (duration: 144.22483ms)","trace[494649263] 'compare' (duration: 144.55585ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T18:49:41.51049Z","caller":"traceutil/trace.go:171","msg":"trace[753648516] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"214.375176ms","start":"2026-07-08T18:49:41.296102Z","end":"2026-07-08T18:49:41.510477Z","steps":["trace[753648516] 'process raft request' (duration: 213.970585ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:42.230217Z","caller":"traceutil/trace.go:171","msg":"trace[676146451] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"489.461793ms","start":"2026-07-08T18:49:41.740726Z","end":"2026-07-08T18:49:42.230188Z","steps":["trace[676146451] 'process raft request' (duration: 487.368159ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:42.230399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:41.740708Z","time spent":"489.601666ms","remote":"127.0.0.1:54868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570081,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T18:49:42.423472Z","caller":"traceutil/trace.go:171","msg":"trace[1598169993] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:639; }","duration":"552.240967ms","start":"2026-07-08T18:49:41.871201Z","end":"2026-07-08T18:49:42.423442Z","steps":["trace[1598169993] 'read index received' (duration: 356.372383ms)","trace[1598169993] 'applied index is now lower than readState.Index' (duration: 195.867994ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T18:49:42.42352Z","caller":"traceutil/trace.go:171","msg":"trace[543122920] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"640.033092ms","start":"2026-07-08T18:49:41.783451Z","end":"2026-07-08T18:49:42.423484Z","steps":["trace[543122920] 'process raft request' (duration: 639.858668ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:42.423632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.422362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-07-08T18:49:42.423632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:41.783422Z","time spent":"640.161286ms","remote":"127.0.0.1:54868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":207462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T18:49:42.423655Z","caller":"traceutil/trace.go:171","msg":"trace[1974977591] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:615; }","duration":"552.495894ms","start":"2026-07-08T18:49:41.871152Z","end":"2026-07-08T18:49:42.423648Z","steps":["trace[1974977591] 'agreement among raft nodes before linearized reading' (duration: 552.387022ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:42.423675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:41.871132Z","time spent":"552.539075ms","remote":"127.0.0.1:55076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-08T18:49:42.63049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.208067ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T18:49:42.630925Z","caller":"traceutil/trace.go:171","msg":"trace[218375041] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"209.859646ms","start":"2026-07-08T18:49:42.421052Z","end":"2026-07-08T18:49:42.630911Z","steps":["trace[218375041] 'process raft request' (duration: 209.602029ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:42.630954Z","caller":"traceutil/trace.go:171","msg":"trace[816051338] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:641; }","duration":"207.402833ms","start":"2026-07-08T18:49:42.423525Z","end":"2026-07-08T18:49:42.630928Z","steps":["trace[816051338] 'read index received' (duration: 99.718243ms)","trace[816051338] 'applied index is now lower than readState.Index' (duration: 107.681529ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T18:49:42.630914Z","caller":"traceutil/trace.go:171","msg":"trace[269751744] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"354.243276ms","start":"2026-07-08T18:49:42.276619Z","end":"2026-07-08T18:49:42.630862Z","steps":["trace[269751744] 'process raft request' (duration: 246.608608ms)","trace[269751744] 'compare' (duration: 107.119744ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T18:49:42.631259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.528259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:29570"} {"level":"info","ts":"2026-07-08T18:49:42.631283Z","caller":"traceutil/trace.go:171","msg":"trace[1891463285] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:618; }","duration":"172.585881ms","start":"2026-07-08T18:49:42.45869Z","end":"2026-07-08T18:49:42.631276Z","steps":["trace[1891463285] 'agreement among raft nodes before linearized reading' (duration: 172.482558ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:42.631238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:42.276599Z","time spent":"354.525004ms","remote":"127.0.0.1:54868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15664,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T18:49:42.631353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.280986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T18:49:42.63137Z","caller":"traceutil/trace.go:171","msg":"trace[1668548408] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:618; }","duration":"525.324457ms","start":"2026-07-08T18:49:42.106042Z","end":"2026-07-08T18:49:42.631366Z","steps":["trace[1668548408] 'agreement among raft nodes before linearized reading' (duration: 525.027009ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:42.631382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:42.106026Z","time spent":"525.352768ms","remote":"127.0.0.1:54836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-08T18:49:42.631319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.889331ms","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-08T18:49:42.631462Z","caller":"traceutil/trace.go:171","msg":"trace[1583690538] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"202.484715ms","start":"2026-07-08T18:49:42.428965Z","end":"2026-07-08T18:49:42.63145Z","steps":["trace[1583690538] 'process raft request' (duration: 201.91503ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:42.631486Z","caller":"traceutil/trace.go:171","msg":"trace[1264596452] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:618; }","duration":"353.080776ms","start":"2026-07-08T18:49:42.278401Z","end":"2026-07-08T18:49:42.631482Z","steps":["trace[1264596452] 'agreement among raft nodes before linearized reading' (duration: 352.651245ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:42.631501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:42.278395Z","time spent":"353.102356ms","remote":"127.0.0.1:55076","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-08T18:49:47.831092Z","caller":"traceutil/trace.go:171","msg":"trace[2030043340] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"257.447858ms","start":"2026-07-08T18:49:47.573617Z","end":"2026-07-08T18:49:47.831065Z","steps":["trace[2030043340] 'process raft request' (duration: 257.292964ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:48.589376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.699664ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T18:49:48.589641Z","caller":"traceutil/trace.go:171","msg":"trace[300686451] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"1.00665889s","start":"2026-07-08T18:49:47.582947Z","end":"2026-07-08T18:49:48.589606Z","steps":["trace[300686451] 'process raft request' (duration: 711.648928ms)","trace[300686451] 'compare' (duration: 294.598892ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T18:49:48.58984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:47.582939Z","time spent":"1.006774383s","remote":"127.0.0.1:55076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T18:49:48.591024Z","caller":"traceutil/trace.go:171","msg":"trace[1540110764] linearizableReadLoop","detail":"{readStateIndex:680; appliedIndex:678; }","duration":"484.017935ms","start":"2026-07-08T18:49:48.10696Z","end":"2026-07-08T18:49:48.590978Z","steps":["trace[1540110764] 'read index received' (duration: 187.65592ms)","trace[1540110764] 'applied index is now lower than readState.Index' (duration: 296.15807ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T18:49:48.591121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.156389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T18:49:48.591231Z","caller":"traceutil/trace.go:171","msg":"trace[271195752] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:653; }","duration":"484.236431ms","start":"2026-07-08T18:49:48.106911Z","end":"2026-07-08T18:49:48.591148Z","steps":["trace[271195752] 'agreement among raft nodes before linearized reading' (duration: 484.150239ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:48.591273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:48.106891Z","time spent":"484.370484ms","remote":"127.0.0.1:54832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-08T18:49:48.591589Z","caller":"traceutil/trace.go:171","msg":"trace[601905684] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"867.076397ms","start":"2026-07-08T18:49:47.724488Z","end":"2026-07-08T18:49:48.591564Z","steps":["trace[601905684] 'process raft request' (duration: 865.235132ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:48.591673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:47.724455Z","time spent":"867.16527ms","remote":"127.0.0.1:54932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T18:49:49.081759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.089483ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T18:49:49.081925Z","caller":"traceutil/trace.go:171","msg":"trace[1639127024] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"405.76348ms","start":"2026-07-08T18:49:48.676142Z","end":"2026-07-08T18:49:49.081905Z","steps":["trace[1639127024] 'process raft request' (duration: 40.439802ms)","trace[1639127024] 'compare' (duration: 364.931278ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T18:49:49.082059Z","caller":"traceutil/trace.go:171","msg":"trace[1646759102] linearizableReadLoop","detail":"{readStateIndex:683; appliedIndex:681; }","duration":"400.359917ms","start":"2026-07-08T18:49:48.681681Z","end":"2026-07-08T18:49:49.082041Z","steps":["trace[1646759102] 'read index received' (duration: 34.918516ms)","trace[1646759102] 'applied index is now lower than readState.Index' (duration: 365.440341ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T18:49:49.08214Z","caller":"traceutil/trace.go:171","msg":"trace[1198636703] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"405.071852ms","start":"2026-07-08T18:49:48.677055Z","end":"2026-07-08T18:49:49.082127Z","steps":["trace[1198636703] 'process raft request' (duration: 404.805826ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:49.08218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.49328ms","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":"info","ts":"2026-07-08T18:49:49.082221Z","caller":"traceutil/trace.go:171","msg":"trace[1124948629] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:656; }","duration":"400.567982ms","start":"2026-07-08T18:49:48.68164Z","end":"2026-07-08T18:49:49.082208Z","steps":["trace[1124948629] 'agreement among raft nodes before linearized reading' (duration: 400.504991ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:49.082223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:48.677036Z","time spent":"405.146635ms","remote":"127.0.0.1:55076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T18:49:49.082259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:48.681624Z","time spent":"400.626853ms","remote":"127.0.0.1:55062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-07-08T18:49:49.082591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.197335ms","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-08T18:49:49.082673Z","caller":"traceutil/trace.go:171","msg":"trace[160929683] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:656; }","duration":"241.315088ms","start":"2026-07-08T18:49:48.841337Z","end":"2026-07-08T18:49:49.082652Z","steps":["trace[160929683] 'agreement among raft nodes before linearized reading' (duration: 240.938419ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:49.0827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.346709ms","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-08T18:49:49.082987Z","caller":"traceutil/trace.go:171","msg":"trace[1851900476] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:656; }","duration":"241.743119ms","start":"2026-07-08T18:49:48.841222Z","end":"2026-07-08T18:49:49.082965Z","steps":["trace[1851900476] 'agreement among raft nodes before linearized reading' (duration: 241.013821ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:49.08285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:48.676117Z","time spent":"406.541988ms","remote":"127.0.0.1:55076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T18:49:49.242368Z","caller":"traceutil/trace.go:171","msg":"trace[604022123] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"155.312153ms","start":"2026-07-08T18:49:49.087031Z","end":"2026-07-08T18:49:49.242343Z","steps":["trace[604022123] 'process raft request' (duration: 155.170889ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:49.252651Z","caller":"traceutil/trace.go:171","msg":"trace[184726802] linearizableReadLoop","detail":"{readStateIndex:685; appliedIndex:683; }","duration":"145.400512ms","start":"2026-07-08T18:49:49.107215Z","end":"2026-07-08T18:49:49.252615Z","steps":["trace[184726802] 'read index received' (duration: 135.095402ms)","trace[184726802] 'applied index is now lower than readState.Index' (duration: 10.3037ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T18:49:49.252775Z","caller":"traceutil/trace.go:171","msg":"trace[435383484] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"165.535021ms","start":"2026-07-08T18:49:49.087196Z","end":"2026-07-08T18:49:49.252731Z","steps":["trace[435383484] 'process raft request' (duration: 165.258854ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:49.252789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.554596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T18:49:49.253075Z","caller":"traceutil/trace.go:171","msg":"trace[960446726] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:658; }","duration":"145.866744ms","start":"2026-07-08T18:49:49.107183Z","end":"2026-07-08T18:49:49.25305Z","steps":["trace[960446726] 'agreement among raft nodes before linearized reading' (duration: 145.556086ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:50.033904Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976533603966953566,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-08T18:49:50.123657Z","caller":"traceutil/trace.go:171","msg":"trace[453453348] linearizableReadLoop","detail":"{readStateIndex:686; appliedIndex:685; }","duration":"590.08504ms","start":"2026-07-08T18:49:49.533551Z","end":"2026-07-08T18:49:50.123636Z","steps":["trace[453453348] 'read index received' (duration: 589.592378ms)","trace[453453348] 'applied index is now lower than readState.Index' (duration: 491.962µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T18:49:50.123726Z","caller":"traceutil/trace.go:171","msg":"trace[1052025820] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"631.947777ms","start":"2026-07-08T18:49:49.491736Z","end":"2026-07-08T18:49:50.123684Z","steps":["trace[1052025820] 'process raft request' (duration: 631.453825ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:50.123889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.299515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.238\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-07-08T18:49:50.123885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:49.491709Z","time spent":"632.08749ms","remote":"127.0.0.1:54932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036317,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T18:49:50.123926Z","caller":"traceutil/trace.go:171","msg":"trace[1823935331] range","detail":"{range_begin:/registry/masterleases/199.204.45.238; range_end:; response_count:1; response_revision:659; }","duration":"590.415188ms","start":"2026-07-08T18:49:49.5335Z","end":"2026-07-08T18:49:50.123916Z","steps":["trace[1823935331] 'agreement among raft nodes before linearized reading' (duration: 590.214683ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:50.124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:49.533479Z","time spent":"590.51307ms","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.204.45.238\" "} {"level":"warn","ts":"2026-07-08T18:49:51.588202Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976533603966953568,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-08T18:49:52.088748Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976533603966953568,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-08T18:49:52.215395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.242569598s","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-08T18:49:52.215493Z","caller":"traceutil/trace.go:171","msg":"trace[1195031141] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:659; }","duration":"1.242679691s","start":"2026-07-08T18:49:50.9728Z","end":"2026-07-08T18:49:52.21548Z","steps":["trace[1195031141] 'range keys from in-memory index tree' (duration: 1.242555298s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:52.215731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.77674531s","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"warn","ts":"2026-07-08T18:49:52.215789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:50.125027Z","time spent":"2.09075946s","remote":"127.0.0.1:54864","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-07-08T18:49:52.233967Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.795137565s","expected-duration":"1s"} {"level":"info","ts":"2026-07-08T18:49:52.234369Z","caller":"traceutil/trace.go:171","msg":"trace[325479151] linearizableReadLoop","detail":"{readStateIndex:688; appliedIndex:687; }","duration":"1.147275413s","start":"2026-07-08T18:49:51.087071Z","end":"2026-07-08T18:49:52.234346Z","steps":["trace[325479151] 'read index received' (duration: 1.14714535s)","trace[325479151] 'applied index is now lower than readState.Index' (duration: 128.363µs)"],"step_count":2} {"level":"warn","ts":"2026-07-08T18:49:52.234596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.147502438s","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-08T18:49:52.234579Z","caller":"traceutil/trace.go:171","msg":"trace[40267135] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"2.055189227s","start":"2026-07-08T18:49:50.17933Z","end":"2026-07-08T18:49:52.234519Z","steps":["trace[40267135] 'process raft request' (duration: 2.054832569s)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:52.234634Z","caller":"traceutil/trace.go:171","msg":"trace[111157514] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:660; }","duration":"1.147585841s","start":"2026-07-08T18:49:51.087039Z","end":"2026-07-08T18:49:52.234625Z","steps":["trace[111157514] 'agreement among raft nodes before linearized reading' (duration: 1.147420347s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:52.234671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:51.087022Z","time spent":"1.147641011s","remote":"127.0.0.1:55076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-08T18:49:52.234742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:50.179305Z","time spent":"2.055363161s","remote":"127.0.0.1:55062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T18:49:52.238209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.151088993s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-07-08T18:49:52.238377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"981.415184ms","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-08T18:49:52.238327Z","caller":"traceutil/trace.go:171","msg":"trace[724522876] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:661; }","duration":"1.151237887s","start":"2026-07-08T18:49:51.087071Z","end":"2026-07-08T18:49:52.238308Z","steps":["trace[724522876] 'agreement among raft nodes before linearized reading' (duration: 1.150895019s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:52.238482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:51.087056Z","time spent":"1.151412141s","remote":"127.0.0.1:55076","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-08T18:49:52.238432Z","caller":"traceutil/trace.go:171","msg":"trace[792160336] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:661; }","duration":"981.501775ms","start":"2026-07-08T18:49:51.256917Z","end":"2026-07-08T18:49:52.238418Z","steps":["trace[792160336] 'agreement among raft nodes before linearized reading' (duration: 981.322891ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:52.238607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:51.256905Z","time spent":"981.69403ms","remote":"127.0.0.1:55076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-08T18:49:52.23861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.131491396s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T18:49:52.238687Z","caller":"traceutil/trace.go:171","msg":"trace[1246239673] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:661; }","duration":"1.131588767s","start":"2026-07-08T18:49:51.107076Z","end":"2026-07-08T18:49:52.238665Z","steps":["trace[1246239673] 'agreement among raft nodes before linearized reading' (duration: 1.131492755s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:52.238756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:51.107018Z","time spent":"1.131721551s","remote":"127.0.0.1:54836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-08T18:49:52.238772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"991.458934ms","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-08T18:49:52.238801Z","caller":"traceutil/trace.go:171","msg":"trace[123806223] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:661; }","duration":"991.526775ms","start":"2026-07-08T18:49:51.247266Z","end":"2026-07-08T18:49:52.238793Z","steps":["trace[123806223] 'agreement among raft nodes before linearized reading' (duration: 991.444423ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:52.238828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:51.247244Z","time spent":"991.578206ms","remote":"127.0.0.1:55076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-08T18:49:53.970427Z","caller":"traceutil/trace.go:171","msg":"trace[223670167] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"190.287523ms","start":"2026-07-08T18:49:53.780118Z","end":"2026-07-08T18:49:53.970406Z","steps":["trace[223670167] 'process raft request' (duration: 190.1664ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:56.773182Z","caller":"traceutil/trace.go:171","msg":"trace[996888119] transaction","detail":"{read_only:false; response_revision:737; number_of_response:1; }","duration":"148.445612ms","start":"2026-07-08T18:49:56.624706Z","end":"2026-07-08T18:49:56.773152Z","steps":["trace[996888119] 'process raft request' (duration: 106.003152ms)","trace[996888119] 'compare' (duration: 42.274306ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T18:49:57.369552Z","caller":"traceutil/trace.go:171","msg":"trace[2035683092] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"354.062312ms","start":"2026-07-08T18:49:57.01543Z","end":"2026-07-08T18:49:57.369492Z","steps":["trace[2035683092] 'process raft request' (duration: 353.796776ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:49:57.369909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:49:57.015399Z","time spent":"354.325128ms","remote":"127.0.0.1:54868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187455,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T18:49:57.369923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.749092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"} {"level":"info","ts":"2026-07-08T18:49:57.370055Z","caller":"traceutil/trace.go:171","msg":"trace[1963820145] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:739; }","duration":"190.927185ms","start":"2026-07-08T18:49:57.179093Z","end":"2026-07-08T18:49:57.37002Z","steps":["trace[1963820145] 'agreement among raft nodes before linearized reading' (duration: 190.596017ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:57.370044Z","caller":"traceutil/trace.go:171","msg":"trace[1960494045] linearizableReadLoop","detail":"{readStateIndex:769; appliedIndex:768; }","duration":"190.25ms","start":"2026-07-08T18:49:57.179149Z","end":"2026-07-08T18:49:57.369399Z","steps":["trace[1960494045] 'read index received' (duration: 190.017044ms)","trace[1960494045] 'applied index is now lower than readState.Index' (duration: 232.096µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T18:49:57.38508Z","caller":"traceutil/trace.go:171","msg":"trace[1046919443] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"138.479617ms","start":"2026-07-08T18:49:57.246578Z","end":"2026-07-08T18:49:57.385058Z","steps":["trace[1046919443] 'process raft request' (duration: 138.326364ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:59.916022Z","caller":"traceutil/trace.go:171","msg":"trace[361157374] transaction","detail":"{read_only:false; response_revision:769; number_of_response:1; }","duration":"113.761635ms","start":"2026-07-08T18:49:59.802234Z","end":"2026-07-08T18:49:59.915996Z","steps":["trace[361157374] 'process raft request' (duration: 113.55895ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:49:59.925245Z","caller":"traceutil/trace.go:171","msg":"trace[646313417] transaction","detail":"{read_only:false; number_of_response:0; response_revision:769; }","duration":"122.174012ms","start":"2026-07-08T18:49:59.803029Z","end":"2026-07-08T18:49:59.925203Z","steps":["trace[646313417] 'process raft request' (duration: 122.07117ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:50:00.030864Z","caller":"traceutil/trace.go:171","msg":"trace[2063200755] linearizableReadLoop","detail":"{readStateIndex:802; appliedIndex:801; }","duration":"104.422552ms","start":"2026-07-08T18:49:59.926405Z","end":"2026-07-08T18:50:00.030827Z","steps":["trace[2063200755] 'read index received' (duration: 83.758266ms)","trace[2063200755] 'applied index is now lower than readState.Index' (duration: 20.662786ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T18:50:00.031051Z","caller":"traceutil/trace.go:171","msg":"trace[51797322] transaction","detail":"{read_only:false; response_revision:770; number_of_response:1; }","duration":"106.467048ms","start":"2026-07-08T18:49:59.924477Z","end":"2026-07-08T18:50:00.030944Z","steps":["trace[51797322] 'process raft request' (duration: 85.683049ms)","trace[51797322] 'compare' (duration: 20.40595ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T18:50:00.03126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.78134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" ","response":"range_response_count:1 size:1712"} {"level":"info","ts":"2026-07-08T18:50:00.031313Z","caller":"traceutil/trace.go:171","msg":"trace[2143324195] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:1; response_revision:770; }","duration":"104.952514ms","start":"2026-07-08T18:49:59.926349Z","end":"2026-07-08T18:50:00.031301Z","steps":["trace[2143324195] 'agreement among raft nodes before linearized reading' (duration: 104.625366ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:50:02.008193Z","caller":"traceutil/trace.go:171","msg":"trace[1896118223] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"139.901645ms","start":"2026-07-08T18:50:01.868267Z","end":"2026-07-08T18:50:02.008169Z","steps":["trace[1896118223] 'process raft request' (duration: 139.743272ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:50:02.484051Z","caller":"traceutil/trace.go:171","msg":"trace[330351458] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"112.747641ms","start":"2026-07-08T18:50:02.37128Z","end":"2026-07-08T18:50:02.484027Z","steps":["trace[330351458] 'process raft request' (duration: 112.595378ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:50:03.379012Z","caller":"traceutil/trace.go:171","msg":"trace[1084030404] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"103.477141ms","start":"2026-07-08T18:50:03.275511Z","end":"2026-07-08T18:50:03.378988Z","steps":["trace[1084030404] 'process raft request' (duration: 103.327168ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:50:04.889409Z","caller":"traceutil/trace.go:171","msg":"trace[1424078931] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"121.325975ms","start":"2026-07-08T18:50:04.76806Z","end":"2026-07-08T18:50:04.889386Z","steps":["trace[1424078931] 'process raft request' (duration: 121.263824ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:50:04.88948Z","caller":"traceutil/trace.go:171","msg":"trace[1268632558] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"122.822807ms","start":"2026-07-08T18:50:04.766605Z","end":"2026-07-08T18:50:04.889427Z","steps":["trace[1268632558] 'process raft request' (duration: 121.56418ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:50:09.781299Z","caller":"traceutil/trace.go:171","msg":"trace[1485993621] linearizableReadLoop","detail":"{readStateIndex:864; appliedIndex:863; }","duration":"242.170451ms","start":"2026-07-08T18:50:09.539089Z","end":"2026-07-08T18:50:09.78126Z","steps":["trace[1485993621] 'read index received' (duration: 241.900875ms)","trace[1485993621] 'applied index is now lower than readState.Index' (duration: 267.645µs)"],"step_count":2} {"level":"warn","ts":"2026-07-08T18:50:09.781494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.365664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T18:50:09.781593Z","caller":"traceutil/trace.go:171","msg":"trace[1262781540] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:830; }","duration":"242.491677ms","start":"2026-07-08T18:50:09.539078Z","end":"2026-07-08T18:50:09.781569Z","steps":["trace[1262781540] 'agreement among raft nodes before linearized reading' (duration: 242.327294ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:50:09.887559Z","caller":"traceutil/trace.go:171","msg":"trace[386183197] linearizableReadLoop","detail":"{readStateIndex:865; appliedIndex:864; }","duration":"106.136633ms","start":"2026-07-08T18:50:09.781395Z","end":"2026-07-08T18:50:09.887531Z","steps":["trace[386183197] 'read index received' (duration: 80.745021ms)","trace[386183197] 'applied index is now lower than readState.Index' (duration: 25.390622ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T18:50:09.88776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.349052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T18:50:09.887817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.017005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T18:50:09.887835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.443097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T18:50:09.887841Z","caller":"traceutil/trace.go:171","msg":"trace[1297143754] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:831; }","duration":"256.445354ms","start":"2026-07-08T18:50:09.631373Z","end":"2026-07-08T18:50:09.887818Z","steps":["trace[1297143754] 'agreement among raft nodes before linearized reading' (duration: 256.184078ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:50:09.887865Z","caller":"traceutil/trace.go:171","msg":"trace[589537226] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:831; }","duration":"311.109007ms","start":"2026-07-08T18:50:09.576745Z","end":"2026-07-08T18:50:09.887854Z","steps":["trace[589537226] 'agreement among raft nodes before linearized reading' (duration: 311.019946ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:50:09.887858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.698917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T18:50:09.887882Z","caller":"traceutil/trace.go:171","msg":"trace[256028312] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:831; }","duration":"333.507829ms","start":"2026-07-08T18:50:09.554354Z","end":"2026-07-08T18:50:09.887861Z","steps":["trace[256028312] 'agreement among raft nodes before linearized reading' (duration: 333.453237ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:50:09.887902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:50:09.576726Z","time spent":"311.164839ms","remote":"127.0.0.1:58728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 "} {"level":"info","ts":"2026-07-08T18:50:09.88791Z","caller":"traceutil/trace.go:171","msg":"trace[1375171192] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:831; }","duration":"199.767988ms","start":"2026-07-08T18:50:09.688128Z","end":"2026-07-08T18:50:09.887896Z","steps":["trace[1375171192] 'agreement among raft nodes before linearized reading' (duration: 199.674096ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:50:09.887924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.942504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T18:50:09.888007Z","caller":"traceutil/trace.go:171","msg":"trace[446474984] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:831; }","duration":"257.029845ms","start":"2026-07-08T18:50:09.630954Z","end":"2026-07-08T18:50:09.887984Z","steps":["trace[446474984] 'agreement among raft nodes before linearized reading' (duration: 256.950513ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:50:09.888041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.218877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T18:50:09.88805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.20472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T18:50:09.888098Z","caller":"traceutil/trace.go:171","msg":"trace[247985159] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:831; }","duration":"181.286338ms","start":"2026-07-08T18:50:09.706794Z","end":"2026-07-08T18:50:09.88808Z","steps":["trace[247985159] 'agreement among raft nodes before linearized reading' (duration: 181.190366ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:50:09.888096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.002575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T18:50:09.887799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.321926ms","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":"warn","ts":"2026-07-08T18:50:09.88819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.899289ms","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-08T18:50:09.888202Z","caller":"traceutil/trace.go:171","msg":"trace[1366943866] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:831; }","duration":"284.773146ms","start":"2026-07-08T18:50:09.603419Z","end":"2026-07-08T18:50:09.888192Z","steps":["trace[1366943866] 'agreement among raft nodes before linearized reading' (duration: 284.167504ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:50:09.888206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.078471ms","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":"info","ts":"2026-07-08T18:50:09.888221Z","caller":"traceutil/trace.go:171","msg":"trace[2063901482] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:831; }","duration":"231.93821ms","start":"2026-07-08T18:50:09.656272Z","end":"2026-07-08T18:50:09.888211Z","steps":["trace[2063901482] 'agreement among raft nodes before linearized reading' (duration: 231.897469ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:50:09.888234Z","caller":"traceutil/trace.go:171","msg":"trace[237342687] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:831; }","duration":"213.119533ms","start":"2026-07-08T18:50:09.675106Z","end":"2026-07-08T18:50:09.888225Z","steps":["trace[237342687] 'agreement among raft nodes before linearized reading' (duration: 213.083352ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:50:09.888204Z","caller":"traceutil/trace.go:171","msg":"trace[546358171] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:831; }","duration":"311.129508ms","start":"2026-07-08T18:50:09.577059Z","end":"2026-07-08T18:50:09.888189Z","steps":["trace[546358171] 'agreement among raft nodes before linearized reading' (duration: 310.930284ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:50:09.88828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:50:09.577052Z","time spent":"311.21426ms","remote":"127.0.0.1:58728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 "} {"level":"warn","ts":"2026-07-08T18:50:09.888111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.288628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T18:50:09.888559Z","caller":"traceutil/trace.go:171","msg":"trace[325422124] transaction","detail":"{read_only:false; response_revision:831; number_of_response:1; }","duration":"204.400694ms","start":"2026-07-08T18:50:09.684142Z","end":"2026-07-08T18:50:09.888542Z","steps":["trace[325422124] 'process raft request' (duration: 177.97383ms)","trace[325422124] 'compare' (duration: 25.253939ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T18:50:09.888587Z","caller":"traceutil/trace.go:171","msg":"trace[1319459179] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:831; }","duration":"200.775118ms","start":"2026-07-08T18:50:09.6878Z","end":"2026-07-08T18:50:09.888575Z","steps":["trace[1319459179] 'agreement among raft nodes before linearized reading' (duration: 200.280198ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:50:09.888616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.84614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-08T18:50:09.888651Z","caller":"traceutil/trace.go:171","msg":"trace[1659400618] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:831; }","duration":"182.88635ms","start":"2026-07-08T18:50:09.705751Z","end":"2026-07-08T18:50:09.888637Z","steps":["trace[1659400618] 'agreement among raft nodes before linearized reading' (duration: 182.777128ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:50:09.888113Z","caller":"traceutil/trace.go:171","msg":"trace[1517881711] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:831; }","duration":"311.290151ms","start":"2026-07-08T18:50:09.576803Z","end":"2026-07-08T18:50:09.888093Z","steps":["trace[1517881711] 'agreement among raft nodes before linearized reading' (duration: 311.166789ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:50:09.888705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:50:09.576795Z","time spent":"311.899974ms","remote":"127.0.0.1:58728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-07-08T18:50:09.888154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.36013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T18:50:09.888741Z","caller":"traceutil/trace.go:171","msg":"trace[1815499255] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:831; }","duration":"200.958732ms","start":"2026-07-08T18:50:09.68777Z","end":"2026-07-08T18:50:09.888729Z","steps":["trace[1815499255] 'agreement among raft nodes before linearized reading' (duration: 200.36451ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:50:09.88817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.844448ms","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-08T18:50:09.888794Z","caller":"traceutil/trace.go:171","msg":"trace[877459640] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:831; }","duration":"232.48366ms","start":"2026-07-08T18:50:09.656299Z","end":"2026-07-08T18:50:09.888783Z","steps":["trace[877459640] 'agreement among raft nodes before linearized reading' (duration: 231.846277ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:50:09.88832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.511993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T18:50:09.888846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.521939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T18:50:09.888853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.462901ms","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":"warn","ts":"2026-07-08T18:50:09.888344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.904638ms","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-08T18:50:09.888881Z","caller":"traceutil/trace.go:171","msg":"trace[2145193378] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:831; }","duration":"270.084114ms","start":"2026-07-08T18:50:09.618786Z","end":"2026-07-08T18:50:09.88887Z","steps":["trace[2145193378] 'agreement among raft nodes before linearized reading' (duration: 269.503762ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:50:09.888882Z","caller":"traceutil/trace.go:171","msg":"trace[613867161] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:831; }","duration":"334.57195ms","start":"2026-07-08T18:50:09.554297Z","end":"2026-07-08T18:50:09.888869Z","steps":["trace[613867161] 'agreement among raft nodes before linearized reading' (duration: 334.520669ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:50:09.888894Z","caller":"traceutil/trace.go:171","msg":"trace[35832351] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:831; }","duration":"214.470411ms","start":"2026-07-08T18:50:09.674415Z","end":"2026-07-08T18:50:09.888885Z","steps":["trace[35832351] 'agreement among raft nodes before linearized reading' (duration: 213.909299ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:50:09.888893Z","caller":"traceutil/trace.go:171","msg":"trace[317968150] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:831; }","duration":"285.532652ms","start":"2026-07-08T18:50:09.603349Z","end":"2026-07-08T18:50:09.888881Z","steps":["trace[317968150] 'agreement among raft nodes before linearized reading' (duration: 285.47171ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:50:09.888917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:50:09.554291Z","time spent":"334.617451ms","remote":"127.0.0.1:58726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"warn","ts":"2026-07-08T18:50:09.887777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.634799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T18:50:09.888991Z","caller":"traceutil/trace.go:171","msg":"trace[656060508] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:831; }","duration":"349.921596ms","start":"2026-07-08T18:50:09.539063Z","end":"2026-07-08T18:50:09.888985Z","steps":["trace[656060508] 'agreement among raft nodes before linearized reading' (duration: 348.621499ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:50:09.888363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.511203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T18:50:09.889019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:50:09.539035Z","time spent":"349.976147ms","remote":"127.0.0.1:58714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-07-08T18:50:09.889034Z","caller":"traceutil/trace.go:171","msg":"trace[1841378193] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:831; }","duration":"271.191976ms","start":"2026-07-08T18:50:09.617833Z","end":"2026-07-08T18:50:09.889025Z","steps":["trace[1841378193] 'agreement among raft nodes before linearized reading' (duration: 270.509502ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:50:09.888379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.008241ms","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-08T18:50:09.889103Z","caller":"traceutil/trace.go:171","msg":"trace[32582869] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:831; }","duration":"214.742116ms","start":"2026-07-08T18:50:09.674349Z","end":"2026-07-08T18:50:09.889091Z","steps":["trace[32582869] 'agreement among raft nodes before linearized reading' (duration: 214.012951ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:50:09.889118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.893307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T18:50:09.88915Z","caller":"traceutil/trace.go:171","msg":"trace[267056652] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:831; }","duration":"334.948878ms","start":"2026-07-08T18:50:09.554191Z","end":"2026-07-08T18:50:09.88914Z","steps":["trace[267056652] 'agreement among raft nodes before linearized reading' (duration: 334.898947ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:50:09.888401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.580874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T18:50:09.88918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:50:09.554178Z","time spent":"334.992659ms","remote":"127.0.0.1:58726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 "} {"level":"info","ts":"2026-07-08T18:50:09.889196Z","caller":"traceutil/trace.go:171","msg":"trace[189233260] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:831; }","duration":"271.388351ms","start":"2026-07-08T18:50:09.617798Z","end":"2026-07-08T18:50:09.889186Z","steps":["trace[189233260] 'agreement among raft nodes before linearized reading' (duration: 270.585904ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:50:09.88844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.880188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T18:50:09.889277Z","caller":"traceutil/trace.go:171","msg":"trace[1548626536] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:831; }","duration":"285.727336ms","start":"2026-07-08T18:50:09.603542Z","end":"2026-07-08T18:50:09.889269Z","steps":["trace[1548626536] 'agreement among raft nodes before linearized reading' (duration: 284.875308ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:50:09.888497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.947652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T18:50:09.889345Z","caller":"traceutil/trace.go:171","msg":"trace[1118265927] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:831; }","duration":"182.83429ms","start":"2026-07-08T18:50:09.7065Z","end":"2026-07-08T18:50:09.889335Z","steps":["trace[1118265927] 'agreement among raft nodes before linearized reading' (duration: 181.948162ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:50:09.888432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.945771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T18:50:09.889415Z","caller":"traceutil/trace.go:171","msg":"trace[1193116511] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:831; }","duration":"182.939322ms","start":"2026-07-08T18:50:09.706465Z","end":"2026-07-08T18:50:09.889405Z","steps":["trace[1193116511] 'agreement among raft nodes before linearized reading' (duration: 181.948592ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:50:09.887884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.828762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T18:50:09.8896Z","caller":"traceutil/trace.go:171","msg":"trace[692543723] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:831; }","duration":"258.551847ms","start":"2026-07-08T18:50:09.631038Z","end":"2026-07-08T18:50:09.88959Z","steps":["trace[692543723] 'agreement among raft nodes before linearized reading' (duration: 256.814731ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:50:09.889539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:50:09.554335Z","time spent":"333.57472ms","remote":"127.0.0.1:58726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"info","ts":"2026-07-08T18:50:09.974194Z","caller":"traceutil/trace.go:171","msg":"trace[2042124455] transaction","detail":"{read_only:false; response_revision:832; number_of_response:1; }","duration":"191.560149ms","start":"2026-07-08T18:50:09.782609Z","end":"2026-07-08T18:50:09.974169Z","steps":["trace[2042124455] 'process raft request' (duration: 191.388566ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:50:10.065286Z","caller":"traceutil/trace.go:171","msg":"trace[1522921052] transaction","detail":"{read_only:false; response_revision:833; number_of_response:1; }","duration":"170.869605ms","start":"2026-07-08T18:50:09.894365Z","end":"2026-07-08T18:50:10.065235Z","steps":["trace[1522921052] 'process raft request' (duration: 125.781635ms)","trace[1522921052] 'compare' (duration: 44.881065ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T18:50:14.294892Z","caller":"traceutil/trace.go:171","msg":"trace[1978297668] transaction","detail":"{read_only:false; response_revision:877; number_of_response:1; }","duration":"212.163811ms","start":"2026-07-08T18:50:14.0827Z","end":"2026-07-08T18:50:14.294864Z","steps":["trace[1978297668] 'process raft request' (duration: 212.036969ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:50:14.295022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.648205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T18:50:14.295069Z","caller":"traceutil/trace.go:171","msg":"trace[358712600] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:877; }","duration":"188.751477ms","start":"2026-07-08T18:50:14.106307Z","end":"2026-07-08T18:50:14.295058Z","steps":["trace[358712600] 'agreement among raft nodes before linearized reading' (duration: 188.644155ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:50:14.294901Z","caller":"traceutil/trace.go:171","msg":"trace[932465307] linearizableReadLoop","detail":"{readStateIndex:911; appliedIndex:911; }","duration":"188.510542ms","start":"2026-07-08T18:50:14.106352Z","end":"2026-07-08T18:50:14.294862Z","steps":["trace[932465307] 'read index received' (duration: 188.499052ms)","trace[932465307] 'applied index is now lower than readState.Index' (duration: 9.9µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T18:50:14.518393Z","caller":"traceutil/trace.go:171","msg":"trace[51759304] linearizableReadLoop","detail":"{readStateIndex:912; appliedIndex:911; }","duration":"223.052957ms","start":"2026-07-08T18:50:14.295311Z","end":"2026-07-08T18:50:14.518364Z","steps":["trace[51759304] 'read index received' (duration: 219.821383ms)","trace[51759304] 'applied index is now lower than readState.Index' (duration: 3.229584ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T18:50:14.519312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.246991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T18:50:14.519374Z","caller":"traceutil/trace.go:171","msg":"trace[1151179421] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:878; }","duration":"223.367172ms","start":"2026-07-08T18:50:14.295992Z","end":"2026-07-08T18:50:14.519359Z","steps":["trace[1151179421] 'agreement among raft nodes before linearized reading' (duration: 223.099037ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:50:14.519552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.470214ms","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-08T18:50:14.519601Z","caller":"traceutil/trace.go:171","msg":"trace[1196760252] transaction","detail":"{read_only:false; response_revision:878; number_of_response:1; }","duration":"345.504641ms","start":"2026-07-08T18:50:14.174021Z","end":"2026-07-08T18:50:14.519525Z","steps":["trace[1196760252] 'process raft request' (duration: 341.972241ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:50:14.519644Z","caller":"traceutil/trace.go:171","msg":"trace[712159389] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:878; }","duration":"125.570636ms","start":"2026-07-08T18:50:14.394037Z","end":"2026-07-08T18:50:14.519608Z","steps":["trace[712159389] 'agreement among raft nodes before linearized reading' (duration: 125.098797ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:50:14.519851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:50:14.173991Z","time spent":"345.710855ms","remote":"127.0.0.1:54932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036302,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T18:50:14.520138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.592434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-08T18:50:14.520215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.686961ms","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-08T18:50:14.520317Z","caller":"traceutil/trace.go:171","msg":"trace[425812373] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:878; }","duration":"137.668945ms","start":"2026-07-08T18:50:14.382499Z","end":"2026-07-08T18:50:14.520168Z","steps":["trace[425812373] 'agreement among raft nodes before linearized reading' (duration: 137.537473ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:50:14.520435Z","caller":"traceutil/trace.go:171","msg":"trace[149986902] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:878; }","duration":"113.752722ms","start":"2026-07-08T18:50:14.40649Z","end":"2026-07-08T18:50:14.520242Z","steps":["trace[149986902] 'agreement among raft nodes before linearized reading' (duration: 113.63631ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:50:14.520529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.966102ms","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-08T18:50:14.520623Z","caller":"traceutil/trace.go:171","msg":"trace[131476508] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:878; }","duration":"134.062965ms","start":"2026-07-08T18:50:14.386522Z","end":"2026-07-08T18:50:14.520585Z","steps":["trace[131476508] 'agreement among raft nodes before linearized reading' (duration: 133.502864ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:50:14.52143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.51211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-07-08T18:50:14.521558Z","caller":"traceutil/trace.go:171","msg":"trace[1552725193] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway; range_end:; response_count:1; response_revision:878; }","duration":"401.605802ms","start":"2026-07-08T18:50:14.119872Z","end":"2026-07-08T18:50:14.521478Z","steps":["trace[1552725193] 'agreement among raft nodes before linearized reading' (duration: 401.408758ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:50:14.521656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:50:14.119852Z","time spent":"401.790116ms","remote":"127.0.0.1:55012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":870,"request content":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway\" "} {"level":"info","ts":"2026-07-08T18:50:49.807266Z","caller":"traceutil/trace.go:171","msg":"trace[1850943389] linearizableReadLoop","detail":"{readStateIndex:1134; appliedIndex:1134; }","duration":"249.351624ms","start":"2026-07-08T18:50:49.557888Z","end":"2026-07-08T18:50:49.80724Z","steps":["trace[1850943389] 'read index received' (duration: 249.340004ms)","trace[1850943389] 'applied index is now lower than readState.Index' (duration: 9.43µs)"],"step_count":2} {"level":"warn","ts":"2026-07-08T18:50:49.807578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.565697ms","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":"info","ts":"2026-07-08T18:50:49.807648Z","caller":"traceutil/trace.go:171","msg":"trace[1031184588] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1091; }","duration":"249.76125ms","start":"2026-07-08T18:50:49.557872Z","end":"2026-07-08T18:50:49.807633Z","steps":["trace[1031184588] 'agreement among raft nodes before linearized reading' (duration: 249.493886ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:50:49.812052Z","caller":"traceutil/trace.go:171","msg":"trace[1521511455] transaction","detail":"{read_only:false; response_revision:1092; number_of_response:1; }","duration":"198.741151ms","start":"2026-07-08T18:50:49.613295Z","end":"2026-07-08T18:50:49.812036Z","steps":["trace[1521511455] 'process raft request' (duration: 198.542198ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:51:30.885628Z","caller":"traceutil/trace.go:171","msg":"trace[1403993685] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"110.355228ms","start":"2026-07-08T18:51:30.775255Z","end":"2026-07-08T18:51:30.88561Z","steps":["trace[1403993685] 'process raft request' (duration: 110.243157ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T18:51:51.245757Z","caller":"traceutil/trace.go:171","msg":"trace[1672340667] linearizableReadLoop","detail":"{readStateIndex:1365; appliedIndex:1364; }","duration":"118.518043ms","start":"2026-07-08T18:51:51.127219Z","end":"2026-07-08T18:51:51.245737Z","steps":["trace[1672340667] 'read index received' (duration: 118.253299ms)","trace[1672340667] 'applied index is now lower than readState.Index' (duration: 263.844µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T18:51:51.245861Z","caller":"traceutil/trace.go:171","msg":"trace[1358693790] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1309; }","duration":"127.285472ms","start":"2026-07-08T18:51:51.118566Z","end":"2026-07-08T18:51:51.245851Z","steps":["trace[1358693790] 'process raft request' (duration: 126.920657ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:51:51.246051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.815556ms","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-08T18:51:51.246111Z","caller":"traceutil/trace.go:171","msg":"trace[981864022] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1309; }","duration":"118.914427ms","start":"2026-07-08T18:51:51.127184Z","end":"2026-07-08T18:51:51.246099Z","steps":["trace[981864022] 'agreement among raft nodes before linearized reading' (duration: 118.766615ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:52:04.116687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.918867ms","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-08T18:52:04.11677Z","caller":"traceutil/trace.go:171","msg":"trace[463208991] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1373; }","duration":"510.04312ms","start":"2026-07-08T18:52:03.606712Z","end":"2026-07-08T18:52:04.116755Z","steps":["trace[463208991] 'range keys from in-memory index tree' (duration: 509.740075ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T18:52:04.116801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T18:52:03.606692Z","time spent":"510.10123ms","remote":"127.0.0.1:55076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-08T18:52:14.317786Z","caller":"traceutil/trace.go:171","msg":"trace[1632418745] transaction","detail":"{read_only:false; response_revision:1413; number_of_response:1; }","duration":"117.860692ms","start":"2026-07-08T18:52:14.199901Z","end":"2026-07-08T18:52:14.317761Z","steps":["trace[1632418745] 'process raft request' (duration: 117.731531ms)"],"step_count":1}