{"level":"warn","ts":"2026-07-02T05:03:09.158505Z","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-02T05:03:09.158595Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.162: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.162:2380","--initial-cluster=instance=https://199.204.45.162:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.162:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.162: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-02T05:03:09.158672Z","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-02T05:03:09.158689Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.162:2380"]} {"level":"info","ts":"2026-07-02T05:03:09.15872Z","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-02T05:03:09.159466Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"]} {"level":"info","ts":"2026-07-02T05:03:09.159538Z","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.162:2380"],"listen-peer-urls":["https://199.204.45.162:2380"],"advertise-client-urls":["https://199.204.45.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.162: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-02T05:03:09.164096Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.374243ms"} {"level":"info","ts":"2026-07-02T05:03:09.171579Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2d372260bb4c37a","cluster-id":"52bb6ec15e8722ff"} {"level":"info","ts":"2026-07-02T05:03:09.171681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=()"} {"level":"info","ts":"2026-07-02T05:03:09.171717Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became follower at term 0"} {"level":"info","ts":"2026-07-02T05:03:09.171735Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2d372260bb4c37a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-02T05:03:09.171747Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became follower at term 1"} {"level":"info","ts":"2026-07-02T05:03:09.171788Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=(203631915892523898)"} {"level":"warn","ts":"2026-07-02T05:03:09.180005Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-02T05:03:09.181251Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-02T05:03:09.183979Z","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-02T05:03:09.186778Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2d372260bb4c37a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-02T05:03:09.187455Z","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-02T05:03:09.18748Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2d372260bb4c37a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-02T05:03:09.187586Z","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-02T05:03:09.187616Z","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-02T05:03:09.188846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=(203631915892523898)"} {"level":"info","ts":"2026-07-02T05:03:09.189468Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"52bb6ec15e8722ff","local-member-id":"2d372260bb4c37a","added-peer-id":"2d372260bb4c37a","added-peer-peer-urls":["https://199.204.45.162:2380"]} {"level":"info","ts":"2026-07-02T05:03:09.195107Z","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-02T05:03:09.195431Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2d372260bb4c37a","initial-advertise-peer-urls":["https://199.204.45.162:2380"],"listen-peer-urls":["https://199.204.45.162:2380"],"advertise-client-urls":["https://199.204.45.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-02T05:03:09.195237Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.162:2380"} {"level":"info","ts":"2026-07-02T05:03:09.1962Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.162:2380"} {"level":"info","ts":"2026-07-02T05:03:09.195552Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-02T05:03:09.672364Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a is starting a new election at term 1"} {"level":"info","ts":"2026-07-02T05:03:09.672438Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became pre-candidate at term 1"} {"level":"info","ts":"2026-07-02T05:03:09.67246Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a received MsgPreVoteResp from 2d372260bb4c37a at term 1"} {"level":"info","ts":"2026-07-02T05:03:09.672474Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became candidate at term 2"} {"level":"info","ts":"2026-07-02T05:03:09.672482Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a received MsgVoteResp from 2d372260bb4c37a at term 2"} {"level":"info","ts":"2026-07-02T05:03:09.672493Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became leader at term 2"} {"level":"info","ts":"2026-07-02T05:03:09.672502Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2d372260bb4c37a elected leader 2d372260bb4c37a at term 2"} {"level":"info","ts":"2026-07-02T05:03:09.713023Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T05:03:09.717768Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-02T05:03:09.717763Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2d372260bb4c37a","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.162:2379]}","request-path":"/0/members/2d372260bb4c37a/attributes","cluster-id":"52bb6ec15e8722ff","publish-timeout":"7s"} {"level":"info","ts":"2026-07-02T05:03:09.71784Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-02T05:03:09.718341Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-02T05:03:09.718379Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-02T05:03:09.718433Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"52bb6ec15e8722ff","local-member-id":"2d372260bb4c37a","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T05:03:09.718504Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T05:03:09.718533Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T05:03:09.721395Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-02T05:03:09.721403Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.162:2379"} {"level":"warn","ts":"2026-07-02T05:03:09.970109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.790614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:09.970205Z","caller":"traceutil/trace.go:171","msg":"trace[1354565911] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1; }","duration":"150.951456ms","start":"2026-07-02T05:03:09.819235Z","end":"2026-07-02T05:03:09.970186Z","steps":["trace[1354565911] 'count revisions from in-memory index tree' (duration: 150.711943ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:09.97036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.829418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:09.970398Z","caller":"traceutil/trace.go:171","msg":"trace[35249398] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"137.921749ms","start":"2026-07-02T05:03:09.832467Z","end":"2026-07-02T05:03:09.970389Z","steps":["trace[35249398] 'count revisions from in-memory index tree' (duration: 137.754737ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:09.970542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.840968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:09.970576Z","caller":"traceutil/trace.go:171","msg":"trace[1150634674] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"137.950539ms","start":"2026-07-02T05:03:09.832617Z","end":"2026-07-02T05:03:09.970568Z","steps":["trace[1150634674] 'range keys from in-memory index tree' (duration: 137.799318ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:09.970683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.82236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:09.970763Z","caller":"traceutil/trace.go:171","msg":"trace[1717306419] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"125.874491ms","start":"2026-07-02T05:03:09.844834Z","end":"2026-07-02T05:03:09.970708Z","steps":["trace[1717306419] 'range keys from in-memory index tree' (duration: 125.760679ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:09.971047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.051093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:09.971139Z","caller":"traceutil/trace.go:171","msg":"trace[1891095801] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"126.213854ms","start":"2026-07-02T05:03:09.844909Z","end":"2026-07-02T05:03:09.971123Z","steps":["trace[1891095801] 'count revisions from in-memory index tree' (duration: 125.980472ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:09.971326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.693131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:09.971449Z","caller":"traceutil/trace.go:171","msg":"trace[1330033440] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"116.811502ms","start":"2026-07-02T05:03:09.854587Z","end":"2026-07-02T05:03:09.971399Z","steps":["trace[1330033440] 'range keys from in-memory index tree' (duration: 116.60987ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:09.971361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.682521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T05:03:09.971758Z","caller":"traceutil/trace.go:171","msg":"trace[386303953] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"117.095515ms","start":"2026-07-02T05:03:09.854632Z","end":"2026-07-02T05:03:09.971728Z","steps":["trace[386303953] 'count revisions from in-memory index tree' (duration: 116.64835ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:16.252271Z","caller":"traceutil/trace.go:171","msg":"trace[1387960515] linearizableReadLoop","detail":"{readStateIndex:325; appliedIndex:324; }","duration":"123.546499ms","start":"2026-07-02T05:03:16.128675Z","end":"2026-07-02T05:03:16.252221Z","steps":["trace[1387960515] 'read index received' (duration: 93.23588ms)","trace[1387960515] 'applied index is now lower than readState.Index' (duration: 30.309729ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:03:16.25241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.710081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:03:16.252436Z","caller":"traceutil/trace.go:171","msg":"trace[1345588545] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:0; response_revision:315; }","duration":"123.778251ms","start":"2026-07-02T05:03:16.12865Z","end":"2026-07-02T05:03:16.252428Z","steps":["trace[1345588545] 'agreement among raft nodes before linearized reading' (duration: 123.69236ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:16.252439Z","caller":"traceutil/trace.go:171","msg":"trace[2136740237] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"144.330241ms","start":"2026-07-02T05:03:16.108079Z","end":"2026-07-02T05:03:16.252409Z","steps":["trace[2136740237] 'process raft request' (duration: 113.769939ms)","trace[2136740237] 'compare' (duration: 30.266629ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:03:16.374354Z","caller":"traceutil/trace.go:171","msg":"trace[1876599472] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"108.991925ms","start":"2026-07-02T05:03:16.265317Z","end":"2026-07-02T05:03:16.374309Z","steps":["trace[1876599472] 'process raft request' (duration: 88.523576ms)","trace[1876599472] 'compare' (duration: 15.723925ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:03:46.70423Z","caller":"traceutil/trace.go:171","msg":"trace[1568873089] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"103.6312ms","start":"2026-07-02T05:03:46.600564Z","end":"2026-07-02T05:03:46.704196Z","steps":["trace[1568873089] 'process raft request' (duration: 103.463211ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:46.704271Z","caller":"traceutil/trace.go:171","msg":"trace[941281566] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"108.336224ms","start":"2026-07-02T05:03:46.595872Z","end":"2026-07-02T05:03:46.704208Z","steps":["trace[941281566] 'process raft request' (duration: 108.06532ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:47.115808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.239985ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T05:03:47.11622Z","caller":"traceutil/trace.go:171","msg":"trace[1513061199] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"332.897782ms","start":"2026-07-02T05:03:46.783292Z","end":"2026-07-02T05:03:47.11619Z","steps":["trace[1513061199] 'process raft request' (duration: 332.648709ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:47.116369Z","caller":"traceutil/trace.go:171","msg":"trace[1429903401] linearizableReadLoop","detail":"{readStateIndex:579; appliedIndex:573; }","duration":"218.638819ms","start":"2026-07-02T05:03:46.897717Z","end":"2026-07-02T05:03:47.116356Z","steps":["trace[1429903401] 'read index received' (duration: 113.477567ms)","trace[1429903401] 'applied index is now lower than readState.Index' (duration: 105.160532ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:03:47.116333Z","caller":"traceutil/trace.go:171","msg":"trace[405442366] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"332.907852ms","start":"2026-07-02T05:03:46.783385Z","end":"2026-07-02T05:03:47.116293Z","steps":["trace[405442366] 'process raft request' (duration: 332.754564ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:47.116434Z","caller":"traceutil/trace.go:171","msg":"trace[1764189486] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"329.39991ms","start":"2026-07-02T05:03:46.78698Z","end":"2026-07-02T05:03:47.11638Z","steps":["trace[1764189486] 'process raft request' (duration: 329.236201ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:47.116403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:46.783276Z","time spent":"333.05423ms","remote":"127.0.0.1:48740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-02T05:03:47.116501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:46.78338Z","time spent":"333.031328ms","remote":"127.0.0.1:48740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:03:47.116557Z","caller":"traceutil/trace.go:171","msg":"trace[295443998] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"325.148908ms","start":"2026-07-02T05:03:46.791401Z","end":"2026-07-02T05:03:47.11655Z","steps":["trace[295443998] 'process raft request' (duration: 324.875104ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:47.116602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:46.791395Z","time spent":"325.18216ms","remote":"127.0.0.1:48982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:03:47.116604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:46.78697Z","time spent":"329.533757ms","remote":"127.0.0.1:48740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23066,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:03:47.116705Z","caller":"traceutil/trace.go:171","msg":"trace[1215455417] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"316.287368ms","start":"2026-07-02T05:03:46.800392Z","end":"2026-07-02T05:03:47.116679Z","steps":["trace[1215455417] 'process raft request' (duration: 315.921599ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:47.116774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.058682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-02T05:03:47.116797Z","caller":"traceutil/trace.go:171","msg":"trace[1584884530] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:560; }","duration":"219.106414ms","start":"2026-07-02T05:03:46.897684Z","end":"2026-07-02T05:03:47.11679Z","steps":["trace[1584884530] 'agreement among raft nodes before linearized reading' (duration: 219.060211ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:47.116808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:46.800376Z","time spent":"316.380053ms","remote":"127.0.0.1:48740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31102,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:03:47.118184Z","caller":"traceutil/trace.go:171","msg":"trace[1254754002] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"337.556142ms","start":"2026-07-02T05:03:46.780572Z","end":"2026-07-02T05:03:47.118128Z","steps":["trace[1254754002] 'process raft request' (duration: 230.552956ms)","trace[1254754002] 'compare' (duration: 104.135359ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:03:47.118309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:46.780553Z","time spent":"337.70698ms","remote":"127.0.0.1:48740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:03:47.661116Z","caller":"traceutil/trace.go:171","msg":"trace[619866536] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"511.484541ms","start":"2026-07-02T05:03:47.149598Z","end":"2026-07-02T05:03:47.661083Z","steps":["trace[619866536] 'process raft request' (duration: 478.806412ms)","trace[619866536] 'compare' (duration: 32.386284ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:03:47.661281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:47.149573Z","time spent":"511.64195ms","remote":"127.0.0.1:48740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31111,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:03:47.66405Z","caller":"traceutil/trace.go:171","msg":"trace[2136289634] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"495.130212ms","start":"2026-07-02T05:03:47.168901Z","end":"2026-07-02T05:03:47.664031Z","steps":["trace[2136289634] 'process raft request' (duration: 494.939802ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:47.66409Z","caller":"traceutil/trace.go:171","msg":"trace[839641871] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"512.097183ms","start":"2026-07-02T05:03:47.151959Z","end":"2026-07-02T05:03:47.664057Z","steps":["trace[839641871] 'process raft request' (duration: 511.783587ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:47.664141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:47.16886Z","time spent":"495.234137ms","remote":"127.0.0.1:48740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-02T05:03:47.664219Z","caller":"traceutil/trace.go:171","msg":"trace[249020944] linearizableReadLoop","detail":"{readStateIndex:586; appliedIndex:582; }","duration":"290.039713ms","start":"2026-07-02T05:03:47.374163Z","end":"2026-07-02T05:03:47.664203Z","steps":["trace[249020944] 'read index received' (duration: 254.254604ms)","trace[249020944] 'applied index is now lower than readState.Index' (duration: 35.784409ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:03:47.664234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:47.151945Z","time spent":"512.209869ms","remote":"127.0.0.1:48740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10846,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:03:47.664418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.256704ms","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-02T05:03:47.664444Z","caller":"traceutil/trace.go:171","msg":"trace[141633205] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:567; }","duration":"290.328608ms","start":"2026-07-02T05:03:47.374107Z","end":"2026-07-02T05:03:47.664436Z","steps":["trace[141633205] 'agreement among raft nodes before linearized reading' (duration: 290.191841ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:47.664544Z","caller":"traceutil/trace.go:171","msg":"trace[589620535] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"489.012138ms","start":"2026-07-02T05:03:47.17552Z","end":"2026-07-02T05:03:47.664532Z","steps":["trace[589620535] 'process raft request' (duration: 488.407417ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:47.664597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:47.175493Z","time spent":"489.0729ms","remote":"127.0.0.1:48740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:03:47.963447Z","caller":"traceutil/trace.go:171","msg":"trace[262388143] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"134.577275ms","start":"2026-07-02T05:03:47.828832Z","end":"2026-07-02T05:03:47.963409Z","steps":["trace[262388143] 'process raft request' (duration: 119.396205ms)","trace[262388143] 'compare' (duration: 14.511285ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:03:47.963536Z","caller":"traceutil/trace.go:171","msg":"trace[636522096] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"101.533937ms","start":"2026-07-02T05:03:47.861964Z","end":"2026-07-02T05:03:47.963498Z","steps":["trace[636522096] 'process raft request' (duration: 101.336877ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:48.832775Z","caller":"traceutil/trace.go:171","msg":"trace[1660251183] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"196.075094ms","start":"2026-07-02T05:03:48.636681Z","end":"2026-07-02T05:03:48.832756Z","steps":["trace[1660251183] 'process raft request' (duration: 195.894325ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:48.874355Z","caller":"traceutil/trace.go:171","msg":"trace[2009948649] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"225.822605ms","start":"2026-07-02T05:03:48.648506Z","end":"2026-07-02T05:03:48.874328Z","steps":["trace[2009948649] 'process raft request' (duration: 225.599764ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:54.546109Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085745749536766340,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-02T05:03:54.77444Z","caller":"traceutil/trace.go:171","msg":"trace[1765902063] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:648; }","duration":"728.567014ms","start":"2026-07-02T05:03:54.045842Z","end":"2026-07-02T05:03:54.774409Z","steps":["trace[1765902063] 'read index received' (duration: 727.702333ms)","trace[1765902063] 'applied index is now lower than readState.Index' (duration: 863.591µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:03:54.774495Z","caller":"traceutil/trace.go:171","msg":"trace[1389500516] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"944.825248ms","start":"2026-07-02T05:03:53.82965Z","end":"2026-07-02T05:03:54.774475Z","steps":["trace[1389500516] 'process raft request' (duration: 944.171107ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:54.77471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.23789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-cgmfs\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-02T05:03:54.774766Z","caller":"traceutil/trace.go:171","msg":"trace[1409500940] range","detail":"{range_begin:/registry/pods/kube-system/cilium-cgmfs; range_end:; response_count:1; response_revision:628; }","duration":"573.338604ms","start":"2026-07-02T05:03:54.201412Z","end":"2026-07-02T05:03:54.774751Z","steps":["trace[1409500940] 'agreement among raft nodes before linearized reading' (duration: 573.150006ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:54.774759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"728.888279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-07-02T05:03:54.774814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:54.201394Z","time spent":"573.409238ms","remote":"127.0.0.1:48898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-cgmfs\" "} {"level":"warn","ts":"2026-07-02T05:03:54.77472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:53.82962Z","time spent":"945.021197ms","remote":"127.0.0.1:48808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036109,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:03:54.774931Z","caller":"traceutil/trace.go:171","msg":"trace[1835763235] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:628; }","duration":"729.054297ms","start":"2026-07-02T05:03:54.045786Z","end":"2026-07-02T05:03:54.77484Z","steps":["trace[1835763235] 'agreement among raft nodes before linearized reading' (duration: 728.745682ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:54.775152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:54.045764Z","time spent":"729.359981ms","remote":"127.0.0.1:48982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-02T05:03:55.552763Z","caller":"traceutil/trace.go:171","msg":"trace[1545031530] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"772.752134ms","start":"2026-07-02T05:03:54.779983Z","end":"2026-07-02T05:03:55.552735Z","steps":["trace[1545031530] 'process raft request' (duration: 742.622826ms)","trace[1545031530] 'compare' (duration: 29.95977ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:03:55.552896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:54.779957Z","time spent":"772.868259ms","remote":"127.0.0.1:48982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:03:55.957867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.033238ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T05:03:55.958012Z","caller":"traceutil/trace.go:171","msg":"trace[1505476756] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:649; }","duration":"859.216722ms","start":"2026-07-02T05:03:55.09878Z","end":"2026-07-02T05:03:55.957996Z","steps":["trace[1505476756] 'read index received' (duration: 423.839321ms)","trace[1505476756] 'applied index is now lower than readState.Index' (duration: 435.376571ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:03:55.958103Z","caller":"traceutil/trace.go:171","msg":"trace[12045842] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"1.169405791s","start":"2026-07-02T05:03:54.788686Z","end":"2026-07-02T05:03:55.958092Z","steps":["trace[12045842] 'process raft request' (duration: 947.071048ms)","trace[12045842] 'compare' (duration: 221.877421ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:03:55.958198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"859.420822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:03:55.958223Z","caller":"traceutil/trace.go:171","msg":"trace[462987334] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"1.125669732s","start":"2026-07-02T05:03:54.832531Z","end":"2026-07-02T05:03:55.958201Z","steps":["trace[462987334] 'process raft request' (duration: 1.12541562s)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:55.958248Z","caller":"traceutil/trace.go:171","msg":"trace[739033996] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:631; }","duration":"859.510206ms","start":"2026-07-02T05:03:55.098726Z","end":"2026-07-02T05:03:55.958236Z","steps":["trace[739033996] 'agreement among raft nodes before linearized reading' (duration: 859.421052ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:55.958289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:55.098696Z","time spent":"859.586019ms","remote":"127.0.0.1:48688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-02T05:03:55.958317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.473215ms","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-02T05:03:55.9583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"759.0287ms","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-02T05:03:55.958326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:54.832503Z","time spent":"1.125777836s","remote":"127.0.0.1:48920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-02T05:03:55.958347Z","caller":"traceutil/trace.go:171","msg":"trace[817164644] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:631; }","duration":"254.537748ms","start":"2026-07-02T05:03:55.7038Z","end":"2026-07-02T05:03:55.958337Z","steps":["trace[817164644] 'agreement among raft nodes before linearized reading' (duration: 254.422433ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:55.958363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"754.806622ms","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-02T05:03:55.958375Z","caller":"traceutil/trace.go:171","msg":"trace[981960737] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:631; }","duration":"759.137275ms","start":"2026-07-02T05:03:55.199217Z","end":"2026-07-02T05:03:55.958354Z","steps":["trace[981960737] 'agreement among raft nodes before linearized reading' (duration: 758.980327ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:55.958425Z","caller":"traceutil/trace.go:171","msg":"trace[142386467] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:631; }","duration":"754.898266ms","start":"2026-07-02T05:03:55.203504Z","end":"2026-07-02T05:03:55.958402Z","steps":["trace[142386467] 'agreement among raft nodes before linearized reading' (duration: 754.734948ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:55.95842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:55.199198Z","time spent":"759.214259ms","remote":"127.0.0.1:48982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-02T05:03:55.958487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:55.20348Z","time spent":"754.99134ms","remote":"127.0.0.1:48982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-02T05:03:55.958172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:54.788667Z","time spent":"1.169475733s","remote":"127.0.0.1:48898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:03:56.472097Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085745749536766350,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T05:03:56.973256Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085745749536766350,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T05:03:57.454678Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.490715388s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-02T05:03:58.298231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999918839s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-02T05:03:58.298385Z","caller":"traceutil/trace.go:171","msg":"trace[861002002] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000117508s","start":"2026-07-02T05:03:56.298245Z","end":"2026-07-02T05:03:58.298362Z","steps":["trace[861002002] 'agreement among raft nodes before linearized reading' (duration: 1.999955201s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:58.29845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:56.29822Z","time spent":"2.000215553s","remote":"127.0.0.1:48688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-02T05:03:58.29863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"843.583432ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T05:03:58.299089Z","caller":"traceutil/trace.go:171","msg":"trace[2134200480] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:652; }","duration":"2.32770832s","start":"2026-07-02T05:03:55.971362Z","end":"2026-07-02T05:03:58.29907Z","steps":["trace[2134200480] 'read index received' (duration: 1.483554442s)","trace[2134200480] 'applied index is now lower than readState.Index' (duration: 844.152908ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:03:58.29922Z","caller":"traceutil/trace.go:171","msg":"trace[2060080207] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"2.335353517s","start":"2026-07-02T05:03:55.963853Z","end":"2026-07-02T05:03:58.299206Z","steps":["trace[2060080207] 'process raft request' (duration: 1.491051903s)","trace[2060080207] 'compare' (duration: 843.191684ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:03:58.299239Z","caller":"traceutil/trace.go:171","msg":"trace[1002380674] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"2.334929078s","start":"2026-07-02T05:03:55.964288Z","end":"2026-07-02T05:03:58.299217Z","steps":["trace[1002380674] 'process raft request' (duration: 2.334666526s)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:58.299235Z","caller":"traceutil/trace.go:171","msg":"trace[239609362] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"2.321791233s","start":"2026-07-02T05:03:55.977428Z","end":"2026-07-02T05:03:58.29922Z","steps":["trace[239609362] 'process raft request' (duration: 2.321600214s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:58.299307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.32793261s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:03:58.299363Z","caller":"traceutil/trace.go:171","msg":"trace[120002954] range","detail":"{range_begin:/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:635; }","duration":"2.328022715s","start":"2026-07-02T05:03:55.971325Z","end":"2026-07-02T05:03:58.299348Z","steps":["trace[120002954] 'agreement among raft nodes before linearized reading' (duration: 2.32791624s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:58.299332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:55.963831Z","time spent":"2.335458682s","remote":"127.0.0.1:48982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:03:58.299398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:55.971312Z","time spent":"2.328078637s","remote":"127.0.0.1:49026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":0,"response size":27,"request content":"key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-07-02T05:03:58.299372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:55.964277Z","time spent":"2.335013931s","remote":"127.0.0.1:48982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:03:58.299481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:55.977417Z","time spent":"2.32192384s","remote":"127.0.0.1:48982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:03:58.299531Z","caller":"traceutil/trace.go:171","msg":"trace[543593091] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"2.335343456s","start":"2026-07-02T05:03:55.964169Z","end":"2026-07-02T05:03:58.299512Z","steps":["trace[543593091] 'process raft request' (duration: 2.334635094s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:58.299802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:55.964146Z","time spent":"2.33562122s","remote":"127.0.0.1:48982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:03:58.356137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.258185518s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:03:58.356209Z","caller":"traceutil/trace.go:171","msg":"trace[920373131] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:636; }","duration":"1.258297822s","start":"2026-07-02T05:03:57.097894Z","end":"2026-07-02T05:03:58.356192Z","steps":["trace[920373131] 'agreement among raft nodes before linearized reading' (duration: 1.258152146s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:58.356208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"799.424935ms","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-02T05:03:58.356283Z","caller":"traceutil/trace.go:171","msg":"trace[1546209516] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:636; }","duration":"799.541591ms","start":"2026-07-02T05:03:57.556729Z","end":"2026-07-02T05:03:58.356271Z","steps":["trace[1546209516] 'agreement among raft nodes before linearized reading' (duration: 799.329221ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:58.356317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:57.556701Z","time spent":"799.608193ms","remote":"127.0.0.1:48982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-02T05:03:58.356327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:57.097875Z","time spent":"1.258433238s","remote":"127.0.0.1:48690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-02T05:04:00.675868Z","caller":"traceutil/trace.go:171","msg":"trace[499186751] linearizableReadLoop","detail":"{readStateIndex:691; appliedIndex:689; }","duration":"230.295182ms","start":"2026-07-02T05:04:00.445549Z","end":"2026-07-02T05:04:00.675845Z","steps":["trace[499186751] 'read index received' (duration: 211.389157ms)","trace[499186751] 'applied index is now lower than readState.Index' (duration: 18.905085ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:04:00.676319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.752112ms","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-02T05:04:00.676359Z","caller":"traceutil/trace.go:171","msg":"trace[952754702] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"115.258996ms","start":"2026-07-02T05:04:00.561073Z","end":"2026-07-02T05:04:00.676332Z","steps":["trace[952754702] 'process raft request' (duration: 114.740893ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:00.676367Z","caller":"traceutil/trace.go:171","msg":"trace[1558634551] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"315.098174ms","start":"2026-07-02T05:04:00.361233Z","end":"2026-07-02T05:04:00.676331Z","steps":["trace[1558634551] 'process raft request' (duration: 314.499528ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:00.676404Z","caller":"traceutil/trace.go:171","msg":"trace[865257336] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"321.650074ms","start":"2026-07-02T05:04:00.354712Z","end":"2026-07-02T05:04:00.676362Z","steps":["trace[865257336] 'process raft request' (duration: 302.207186ms)","trace[865257336] 'compare' (duration: 18.412052ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:04:00.676548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:00.354697Z","time spent":"321.787409ms","remote":"127.0.0.1:49060","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-02T05:04:00.676562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:00.361225Z","time spent":"315.269511ms","remote":"127.0.0.1:48740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-02T05:04:00.676807Z","caller":"traceutil/trace.go:171","msg":"trace[1329884822] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:670; }","duration":"230.908689ms","start":"2026-07-02T05:04:00.445502Z","end":"2026-07-02T05:04:00.676411Z","steps":["trace[1329884822] 'agreement among raft nodes before linearized reading' (duration: 230.539542ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:03.946835Z","caller":"traceutil/trace.go:171","msg":"trace[686616232] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"159.469192ms","start":"2026-07-02T05:04:03.787331Z","end":"2026-07-02T05:04:03.9468Z","steps":["trace[686616232] 'process raft request' (duration: 159.149238ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:04.134313Z","caller":"traceutil/trace.go:171","msg":"trace[1373966841] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"117.192313ms","start":"2026-07-02T05:04:04.017092Z","end":"2026-07-02T05:04:04.134284Z","steps":["trace[1373966841] 'process raft request' (duration: 116.814477ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:04.32773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.984564ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T05:04:04.327929Z","caller":"traceutil/trace.go:171","msg":"trace[774665682] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"138.386897ms","start":"2026-07-02T05:04:04.189522Z","end":"2026-07-02T05:04:04.327909Z","steps":["trace[774665682] 'process raft request' (duration: 30.132861ms)","trace[774665682] 'compare' (duration: 107.87596ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:04:04.330438Z","caller":"traceutil/trace.go:171","msg":"trace[1001357886] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"119.612534ms","start":"2026-07-02T05:04:04.210793Z","end":"2026-07-02T05:04:04.330406Z","steps":["trace[1001357886] 'process raft request' (duration: 119.420466ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:04.330414Z","caller":"traceutil/trace.go:171","msg":"trace[2113299298] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"140.115479ms","start":"2026-07-02T05:04:04.190241Z","end":"2026-07-02T05:04:04.330356Z","steps":["trace[2113299298] 'process raft request' (duration: 139.787455ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:09.536834Z","caller":"traceutil/trace.go:171","msg":"trace[1321907962] transaction","detail":"{read_only:false; response_revision:770; number_of_response:1; }","duration":"145.909792ms","start":"2026-07-02T05:04:09.390895Z","end":"2026-07-02T05:04:09.536805Z","steps":["trace[1321907962] 'process raft request' (duration: 145.691054ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:14.872834Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085745749536766681,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-02T05:04:14.937524Z","caller":"traceutil/trace.go:171","msg":"trace[817294879] linearizableReadLoop","detail":"{readStateIndex:834; appliedIndex:833; }","duration":"564.839585ms","start":"2026-07-02T05:04:14.37265Z","end":"2026-07-02T05:04:14.93749Z","steps":["trace[817294879] 'read index received' (duration: 517.257366ms)","trace[817294879] 'applied index is now lower than readState.Index' (duration: 47.581139ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:04:14.937659Z","caller":"traceutil/trace.go:171","msg":"trace[1153103949] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"623.44335ms","start":"2026-07-02T05:04:14.314205Z","end":"2026-07-02T05:04:14.937648Z","steps":["trace[1153103949] 'process raft request' (duration: 575.792458ms)","trace[1153103949] 'compare' (duration: 47.270177ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:04:14.937776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:14.314166Z","time spent":"623.521273ms","remote":"127.0.0.1:48958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:04:14.93798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.584899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-07-02T05:04:14.938027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.112902ms","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-02T05:04:14.938036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.380365ms","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-02T05:04:14.93808Z","caller":"traceutil/trace.go:171","msg":"trace[1258649583] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:808; }","duration":"516.185215ms","start":"2026-07-02T05:04:14.421876Z","end":"2026-07-02T05:04:14.938061Z","steps":["trace[1258649583] 'agreement among raft nodes before linearized reading' (duration: 516.070901ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:14.938083Z","caller":"traceutil/trace.go:171","msg":"trace[162171749] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:808; }","duration":"565.448428ms","start":"2026-07-02T05:04:14.372618Z","end":"2026-07-02T05:04:14.938066Z","steps":["trace[162171749] 'agreement among raft nodes before linearized reading' (duration: 565.302202ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:14.938117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:14.421857Z","time spent":"516.253117ms","remote":"127.0.0.1:48982","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-02T05:04:14.93817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:14.3726Z","time spent":"565.521671ms","remote":"127.0.0.1:48982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-02T05:04:14.938219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.551884ms","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-02T05:04:14.938073Z","caller":"traceutil/trace.go:171","msg":"trace[565434198] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:808; }","duration":"539.709235ms","start":"2026-07-02T05:04:14.398338Z","end":"2026-07-02T05:04:14.938047Z","steps":["trace[565434198] 'agreement among raft nodes before linearized reading' (duration: 539.417784ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:14.938265Z","caller":"traceutil/trace.go:171","msg":"trace[1443079749] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:808; }","duration":"523.633576ms","start":"2026-07-02T05:04:14.414618Z","end":"2026-07-02T05:04:14.938251Z","steps":["trace[1443079749] 'agreement among raft nodes before linearized reading' (duration: 523.499431ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:14.938281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:14.398262Z","time spent":"540.012335ms","remote":"127.0.0.1:48982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-02T05:04:14.938315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:14.414597Z","time spent":"523.705439ms","remote":"127.0.0.1:48982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-02T05:04:14.938349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.460047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:04:14.938378Z","caller":"traceutil/trace.go:171","msg":"trace[228723499] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:808; }","duration":"260.530339ms","start":"2026-07-02T05:04:14.677839Z","end":"2026-07-02T05:04:14.938369Z","steps":["trace[228723499] 'agreement among raft nodes before linearized reading' (duration: 260.482027ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:14.937877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.457917ms","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-02T05:04:14.938567Z","caller":"traceutil/trace.go:171","msg":"trace[1128706286] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:808; }","duration":"156.178945ms","start":"2026-07-02T05:04:14.782368Z","end":"2026-07-02T05:04:14.938547Z","steps":["trace[1128706286] 'agreement among raft nodes before linearized reading' (duration: 155.382125ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:21.861561Z","caller":"traceutil/trace.go:171","msg":"trace[1097326787] transaction","detail":"{read_only:false; response_revision:883; number_of_response:1; }","duration":"162.678795ms","start":"2026-07-02T05:04:21.698862Z","end":"2026-07-02T05:04:21.861541Z","steps":["trace[1097326787] 'process raft request' (duration: 66.219216ms)","trace[1097326787] 'compare' (duration: 96.345915ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:04:22.189485Z","caller":"traceutil/trace.go:171","msg":"trace[588291670] linearizableReadLoop","detail":"{readStateIndex:913; appliedIndex:911; }","duration":"260.263687ms","start":"2026-07-02T05:04:21.9292Z","end":"2026-07-02T05:04:22.189464Z","steps":["trace[588291670] 'read index received' (duration: 200.731587ms)","trace[588291670] 'applied index is now lower than readState.Index' (duration: 59.53098ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:04:22.189807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.865709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-07-02T05:04:22.189842Z","caller":"traceutil/trace.go:171","msg":"trace[267470617] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:885; }","duration":"159.941841ms","start":"2026-07-02T05:04:22.029888Z","end":"2026-07-02T05:04:22.18983Z","steps":["trace[267470617] 'agreement among raft nodes before linearized reading' (duration: 159.89328ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:22.189561Z","caller":"traceutil/trace.go:171","msg":"trace[1694697442] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"448.442648ms","start":"2026-07-02T05:04:21.741085Z","end":"2026-07-02T05:04:22.189527Z","steps":["trace[1694697442] 'process raft request' (duration: 388.865956ms)","trace[1694697442] 'compare' (duration: 59.348694ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:04:22.189972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:21.741067Z","time spent":"448.837842ms","remote":"127.0.0.1:48898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4762,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:04:22.189581Z","caller":"traceutil/trace.go:171","msg":"trace[1315402523] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"321.130625ms","start":"2026-07-02T05:04:21.868421Z","end":"2026-07-02T05:04:22.189552Z","steps":["trace[1315402523] 'process raft request' (duration: 320.9929ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:22.190146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:21.868408Z","time spent":"321.722006ms","remote":"127.0.0.1:48780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":719,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-02T05:04:22.189659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.450754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-07-02T05:04:22.190276Z","caller":"traceutil/trace.go:171","msg":"trace[644856531] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:885; }","duration":"261.120696ms","start":"2026-07-02T05:04:21.929143Z","end":"2026-07-02T05:04:22.190264Z","steps":["trace[644856531] 'agreement among raft nodes before linearized reading' (duration: 260.436483ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:23.762503Z","caller":"traceutil/trace.go:171","msg":"trace[1041662241] transaction","detail":"{read_only:false; response_revision:902; number_of_response:1; }","duration":"370.015726ms","start":"2026-07-02T05:04:23.392457Z","end":"2026-07-02T05:04:23.762473Z","steps":["trace[1041662241] 'process raft request' (duration: 341.595938ms)","trace[1041662241] 'compare' (duration: 28.260903ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:04:23.762732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:23.392442Z","time spent":"370.210502ms","remote":"127.0.0.1:48898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5071,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:04:23.778864Z","caller":"traceutil/trace.go:171","msg":"trace[1871959589] transaction","detail":"{read_only:false; response_revision:903; number_of_response:1; }","duration":"315.486218ms","start":"2026-07-02T05:04:23.463354Z","end":"2026-07-02T05:04:23.77884Z","steps":["trace[1871959589] 'process raft request' (duration: 315.342503ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:23.779013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:23.463328Z","time spent":"315.634464ms","remote":"127.0.0.1:48982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:04:23.971251Z","caller":"traceutil/trace.go:171","msg":"trace[1300410259] transaction","detail":"{read_only:false; response_revision:910; number_of_response:1; }","duration":"129.86881ms","start":"2026-07-02T05:04:23.841354Z","end":"2026-07-02T05:04:23.971223Z","steps":["trace[1300410259] 'process raft request' (duration: 127.333323ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:24.266704Z","caller":"traceutil/trace.go:171","msg":"trace[1675202959] transaction","detail":"{read_only:false; response_revision:911; number_of_response:1; }","duration":"289.37672ms","start":"2026-07-02T05:04:23.977307Z","end":"2026-07-02T05:04:24.266683Z","steps":["trace[1675202959] 'process raft request' (duration: 216.539738ms)","trace[1675202959] 'compare' (duration: 72.748659ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:04:24.354193Z","caller":"traceutil/trace.go:171","msg":"trace[1095364697] transaction","detail":"{read_only:false; response_revision:912; number_of_response:1; }","duration":"376.486927ms","start":"2026-07-02T05:04:23.977667Z","end":"2026-07-02T05:04:24.354154Z","steps":["trace[1095364697] 'process raft request' (duration: 376.212207ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:24.354505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:23.977648Z","time spent":"376.644222ms","remote":"127.0.0.1:49156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4213,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:04:24.35481Z","caller":"traceutil/trace.go:171","msg":"trace[1492713163] linearizableReadLoop","detail":"{readStateIndex:942; appliedIndex:939; }","duration":"257.263215ms","start":"2026-07-02T05:04:24.09752Z","end":"2026-07-02T05:04:24.354783Z","steps":["trace[1492713163] 'read index received' (duration: 96.209478ms)","trace[1492713163] 'applied index is now lower than readState.Index' (duration: 161.051767ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:04:24.354923Z","caller":"traceutil/trace.go:171","msg":"trace[69634300] transaction","detail":"{read_only:false; response_revision:913; number_of_response:1; }","duration":"376.659013ms","start":"2026-07-02T05:04:23.978256Z","end":"2026-07-02T05:04:24.354915Z","steps":["trace[69634300] 'process raft request' (duration: 375.765872ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:24.355031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:23.978247Z","time spent":"376.703174ms","remote":"127.0.0.1:48898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4866,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:04:24.355228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.706821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:04:24.355295Z","caller":"traceutil/trace.go:171","msg":"trace[353931411] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:913; }","duration":"257.825235ms","start":"2026-07-02T05:04:24.097453Z","end":"2026-07-02T05:04:24.355279Z","steps":["trace[353931411] 'agreement among raft nodes before linearized reading' (duration: 257.741432ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:24.644264Z","caller":"traceutil/trace.go:171","msg":"trace[43482646] transaction","detail":"{read_only:false; response_revision:923; number_of_response:1; }","duration":"129.167171ms","start":"2026-07-02T05:04:24.515057Z","end":"2026-07-02T05:04:24.644224Z","steps":["trace[43482646] 'process raft request' (duration: 128.051393ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:24.787365Z","caller":"traceutil/trace.go:171","msg":"trace[1476466508] linearizableReadLoop","detail":"{readStateIndex:953; appliedIndex:951; }","duration":"183.921716ms","start":"2026-07-02T05:04:24.603417Z","end":"2026-07-02T05:04:24.787338Z","steps":["trace[1476466508] 'read index received' (duration: 39.710042ms)","trace[1476466508] 'applied index is now lower than readState.Index' (duration: 144.210784ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:04:24.78753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.095622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:04:24.787566Z","caller":"traceutil/trace.go:171","msg":"trace[1081217903] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:0; response_revision:924; }","duration":"184.198696ms","start":"2026-07-02T05:04:24.603355Z","end":"2026-07-02T05:04:24.787554Z","steps":["trace[1081217903] 'agreement among raft nodes before linearized reading' (duration: 184.095463ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:24.787729Z","caller":"traceutil/trace.go:171","msg":"trace[861821966] transaction","detail":"{read_only:false; response_revision:924; number_of_response:1; }","duration":"272.049419ms","start":"2026-07-02T05:04:24.515654Z","end":"2026-07-02T05:04:24.787703Z","steps":["trace[861821966] 'process raft request' (duration: 270.471266ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:24.981762Z","caller":"traceutil/trace.go:171","msg":"trace[1557453842] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"329.518407ms","start":"2026-07-02T05:04:24.652215Z","end":"2026-07-02T05:04:24.981733Z","steps":["trace[1557453842] 'process raft request' (duration: 298.080616ms)","trace[1557453842] 'compare' (duration: 31.300117ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:04:24.981922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:24.652198Z","time spent":"329.644501ms","remote":"127.0.0.1:49156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4213,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:04:25.061844Z","caller":"traceutil/trace.go:171","msg":"trace[895686352] linearizableReadLoop","detail":"{readStateIndex:957; appliedIndex:953; }","duration":"177.441467ms","start":"2026-07-02T05:04:24.884379Z","end":"2026-07-02T05:04:25.061821Z","steps":["trace[895686352] 'read index received' (duration: 65.896276ms)","trace[895686352] 'applied index is now lower than readState.Index' (duration: 111.543801ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:04:25.061863Z","caller":"traceutil/trace.go:171","msg":"trace[712627894] transaction","detail":"{read_only:false; response_revision:926; number_of_response:1; }","duration":"268.135496ms","start":"2026-07-02T05:04:24.79368Z","end":"2026-07-02T05:04:25.061815Z","steps":["trace[712627894] 'process raft request' (duration: 267.867147ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:25.06197Z","caller":"traceutil/trace.go:171","msg":"trace[1025251432] transaction","detail":"{read_only:false; response_revision:927; number_of_response:1; }","duration":"268.085944ms","start":"2026-07-02T05:04:24.793818Z","end":"2026-07-02T05:04:25.061904Z","steps":["trace[1025251432] 'process raft request' (duration: 267.863007ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:25.062086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.691035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:04:25.062132Z","caller":"traceutil/trace.go:171","msg":"trace[1609767301] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:0; response_revision:928; }","duration":"177.780578ms","start":"2026-07-02T05:04:24.88434Z","end":"2026-07-02T05:04:25.06212Z","steps":["trace[1609767301] 'agreement among raft nodes before linearized reading' (duration: 177.696105ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:25.062014Z","caller":"traceutil/trace.go:171","msg":"trace[2128616115] transaction","detail":"{read_only:false; response_revision:928; number_of_response:1; }","duration":"265.051742ms","start":"2026-07-02T05:04:24.796947Z","end":"2026-07-02T05:04:25.061999Z","steps":["trace[2128616115] 'process raft request' (duration: 264.805413ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:25.253888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.630516ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T05:04:25.254159Z","caller":"traceutil/trace.go:171","msg":"trace[481168293] linearizableReadLoop","detail":"{readStateIndex:959; appliedIndex:957; }","duration":"183.943084ms","start":"2026-07-02T05:04:25.070198Z","end":"2026-07-02T05:04:25.254141Z","steps":["trace[481168293] 'read index received' (duration: 20.943576ms)","trace[481168293] 'applied index is now lower than readState.Index' (duration: 162.997918ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:04:25.254257Z","caller":"traceutil/trace.go:171","msg":"trace[416994209] transaction","detail":"{read_only:false; response_revision:931; number_of_response:1; }","duration":"182.63684ms","start":"2026-07-02T05:04:25.07161Z","end":"2026-07-02T05:04:25.254247Z","steps":["trace[416994209] 'process raft request' (duration: 182.486815ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:25.254421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.218223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:04:25.254458Z","caller":"traceutil/trace.go:171","msg":"trace[886488707] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:0; response_revision:931; }","duration":"184.288846ms","start":"2026-07-02T05:04:25.070158Z","end":"2026-07-02T05:04:25.254447Z","steps":["trace[886488707] 'agreement among raft nodes before linearized reading' (duration: 184.226694ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:25.254604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.270286ms","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-02T05:04:25.254597Z","caller":"traceutil/trace.go:171","msg":"trace[1943263381] transaction","detail":"{read_only:false; response_revision:930; number_of_response:1; }","duration":"184.718191ms","start":"2026-07-02T05:04:25.069845Z","end":"2026-07-02T05:04:25.254563Z","steps":["trace[1943263381] 'process raft request' (duration: 184.189493ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:25.254645Z","caller":"traceutil/trace.go:171","msg":"trace[984498296] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:931; }","duration":"117.358178ms","start":"2026-07-02T05:04:25.137277Z","end":"2026-07-02T05:04:25.254635Z","steps":["trace[984498296] 'agreement among raft nodes before linearized reading' (duration: 117.171232ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:25.254609Z","caller":"traceutil/trace.go:171","msg":"trace[1237174903] transaction","detail":"{read_only:false; response_revision:929; number_of_response:1; }","duration":"186.444208ms","start":"2026-07-02T05:04:25.068147Z","end":"2026-07-02T05:04:25.254591Z","steps":["trace[1237174903] 'process raft request' (duration: 23.008626ms)","trace[1237174903] 'compare' (duration: 162.528012ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:04:25.254718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.064999ms","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-02T05:04:25.254794Z","caller":"traceutil/trace.go:171","msg":"trace[1460951671] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:931; }","duration":"117.167292ms","start":"2026-07-02T05:04:25.137607Z","end":"2026-07-02T05:04:25.254775Z","steps":["trace[1460951671] 'agreement among raft nodes before linearized reading' (duration: 116.951294ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:25.254812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.480323ms","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-02T05:04:25.254846Z","caller":"traceutil/trace.go:171","msg":"trace[1551148492] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:931; }","duration":"117.559245ms","start":"2026-07-02T05:04:25.137277Z","end":"2026-07-02T05:04:25.254836Z","steps":["trace[1551148492] 'agreement among raft nodes before linearized reading' (duration: 117.462061ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:29.907502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.427214ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T05:04:29.907613Z","caller":"traceutil/trace.go:171","msg":"trace[1968797250] linearizableReadLoop","detail":"{readStateIndex:1007; appliedIndex:1006; }","duration":"552.294342ms","start":"2026-07-02T05:04:29.355296Z","end":"2026-07-02T05:04:29.90759Z","steps":["trace[1968797250] 'read index received' (duration: 402.653302ms)","trace[1968797250] 'applied index is now lower than readState.Index' (duration: 149.63945ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:04:29.907692Z","caller":"traceutil/trace.go:171","msg":"trace[9264055] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"557.78117ms","start":"2026-07-02T05:04:29.349867Z","end":"2026-07-02T05:04:29.907648Z","steps":["trace[9264055] 'process raft request' (duration: 408.126959ms)","trace[9264055] 'compare' (duration: 149.198387ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:04:29.907801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.503409ms","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-02T05:04:29.907838Z","caller":"traceutil/trace.go:171","msg":"trace[1223993899] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:977; }","duration":"552.582231ms","start":"2026-07-02T05:04:29.355246Z","end":"2026-07-02T05:04:29.907828Z","steps":["trace[1223993899] 'agreement among raft nodes before linearized reading' (duration: 552.435356ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:29.907848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:29.34985Z","time spent":"557.919874ms","remote":"127.0.0.1:48982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:04:29.907878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:29.355226Z","time spent":"552.643374ms","remote":"127.0.0.1:48982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-02T05:04:29.908614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.457409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-02T05:04:29.908688Z","caller":"traceutil/trace.go:171","msg":"trace[1086252542] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:978; }","duration":"474.582614ms","start":"2026-07-02T05:04:29.434089Z","end":"2026-07-02T05:04:29.908672Z","steps":["trace[1086252542] 'agreement among raft nodes before linearized reading' (duration: 474.454849ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:29.908728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:29.434068Z","time spent":"474.651275ms","remote":"127.0.0.1:48874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":3,"response size":29,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "} {"level":"warn","ts":"2026-07-02T05:04:29.908743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.834739ms","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-02T05:04:29.908821Z","caller":"traceutil/trace.go:171","msg":"trace[1554398852] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:978; }","duration":"552.931713ms","start":"2026-07-02T05:04:29.355846Z","end":"2026-07-02T05:04:29.908778Z","steps":["trace[1554398852] 'agreement among raft nodes before linearized reading' (duration: 552.626453ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:29.908899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:29.355839Z","time spent":"553.015885ms","remote":"127.0.0.1:48982","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":"info","ts":"2026-07-02T05:04:31.452801Z","caller":"traceutil/trace.go:171","msg":"trace[1588842010] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"137.656206ms","start":"2026-07-02T05:04:31.315112Z","end":"2026-07-02T05:04:31.452768Z","steps":["trace[1588842010] 'process raft request' (duration: 39.354411ms)","trace[1588842010] 'compare' (duration: 98.14801ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:04:48.098731Z","caller":"traceutil/trace.go:171","msg":"trace[1884455459] transaction","detail":"{read_only:false; response_revision:1048; number_of_response:1; }","duration":"118.762544ms","start":"2026-07-02T05:04:47.979938Z","end":"2026-07-02T05:04:48.0987Z","steps":["trace[1884455459] 'process raft request' (duration: 118.599529ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:49.740052Z","caller":"traceutil/trace.go:171","msg":"trace[432022186] transaction","detail":"{read_only:false; response_revision:1057; number_of_response:1; }","duration":"116.334565ms","start":"2026-07-02T05:04:49.623689Z","end":"2026-07-02T05:04:49.740024Z","steps":["trace[432022186] 'process raft request' (duration: 116.13188ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:05:02.383423Z","caller":"traceutil/trace.go:171","msg":"trace[237285187] linearizableReadLoop","detail":"{readStateIndex:1134; appliedIndex:1133; }","duration":"129.761362ms","start":"2026-07-02T05:05:02.253641Z","end":"2026-07-02T05:05:02.383402Z","steps":["trace[237285187] 'read index received' (duration: 129.610639ms)","trace[237285187] 'applied index is now lower than readState.Index' (duration: 149.693µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:05:02.383636Z","caller":"traceutil/trace.go:171","msg":"trace[575922312] transaction","detail":"{read_only:false; response_revision:1098; number_of_response:1; }","duration":"143.251089ms","start":"2026-07-02T05:05:02.240342Z","end":"2026-07-02T05:05:02.383593Z","steps":["trace[575922312] 'process raft request' (duration: 142.933551ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:05:02.383711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.049949ms","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-02T05:05:02.383764Z","caller":"traceutil/trace.go:171","msg":"trace[1636510405] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1098; }","duration":"130.141152ms","start":"2026-07-02T05:05:02.253607Z","end":"2026-07-02T05:05:02.383749Z","steps":["trace[1636510405] 'agreement among raft nodes before linearized reading' (duration: 129.956977ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:05:02.383787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.939251ms","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-02T05:05:02.383844Z","caller":"traceutil/trace.go:171","msg":"trace[1691868805] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1098; }","duration":"124.029294ms","start":"2026-07-02T05:05:02.259804Z","end":"2026-07-02T05:05:02.383833Z","steps":["trace[1691868805] 'agreement among raft nodes before linearized reading' (duration: 123.879ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:05:02.498171Z","caller":"traceutil/trace.go:171","msg":"trace[32959082] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"109.790849ms","start":"2026-07-02T05:05:02.388286Z","end":"2026-07-02T05:05:02.498077Z","steps":["trace[32959082] 'process raft request' (duration: 48.221248ms)","trace[32959082] 'compare' (duration: 61.373126ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:05:52.69364Z","caller":"traceutil/trace.go:171","msg":"trace[600804265] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"137.436857ms","start":"2026-07-02T05:05:52.556179Z","end":"2026-07-02T05:05:52.693616Z","steps":["trace[600804265] 'process raft request' (duration: 137.316594ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:05:52.764578Z","caller":"traceutil/trace.go:171","msg":"trace[1663950415] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"163.807962ms","start":"2026-07-02T05:05:52.600743Z","end":"2026-07-02T05:05:52.764551Z","steps":["trace[1663950415] 'process raft request' (duration: 126.448422ms)","trace[1663950415] 'compare' (duration: 37.181607ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:05:57.846749Z","caller":"traceutil/trace.go:171","msg":"trace[210307133] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"200.952265ms","start":"2026-07-02T05:05:57.645773Z","end":"2026-07-02T05:05:57.846725Z","steps":["trace[210307133] 'process raft request' (duration: 200.498757ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:05:58.118394Z","caller":"traceutil/trace.go:171","msg":"trace[1225695733] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"151.952771ms","start":"2026-07-02T05:05:57.966399Z","end":"2026-07-02T05:05:58.118351Z","steps":["trace[1225695733] 'process raft request' (duration: 122.563486ms)","trace[1225695733] 'compare' (duration: 29.021288ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:05:58.319721Z","caller":"traceutil/trace.go:171","msg":"trace[1534814963] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1302; }","duration":"199.574775ms","start":"2026-07-02T05:05:58.120115Z","end":"2026-07-02T05:05:58.319689Z","steps":["trace[1534814963] 'process raft request' (duration: 113.460187ms)","trace[1534814963] 'compare' (duration: 85.993336ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:05:59.041393Z","caller":"traceutil/trace.go:171","msg":"trace[1991603486] transaction","detail":"{read_only:false; response_revision:1313; number_of_response:1; }","duration":"130.303953ms","start":"2026-07-02T05:05:58.911053Z","end":"2026-07-02T05:05:59.041356Z","steps":["trace[1991603486] 'process raft request' (duration: 130.09817ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:05:59.041979Z","caller":"traceutil/trace.go:171","msg":"trace[698702764] linearizableReadLoop","detail":"{readStateIndex:1363; appliedIndex:1361; }","duration":"115.100843ms","start":"2026-07-02T05:05:58.926851Z","end":"2026-07-02T05:05:59.041952Z","steps":["trace[698702764] 'read index received' (duration: 114.293259ms)","trace[698702764] 'applied index is now lower than readState.Index' (duration: 806.434µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:05:59.042064Z","caller":"traceutil/trace.go:171","msg":"trace[1289919749] transaction","detail":"{read_only:false; response_revision:1314; number_of_response:1; }","duration":"130.882394ms","start":"2026-07-02T05:05:58.911152Z","end":"2026-07-02T05:05:59.042035Z","steps":["trace[1289919749] 'process raft request' (duration: 130.66614ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:05:59.04223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.360237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-02T05:05:59.042271Z","caller":"traceutil/trace.go:171","msg":"trace[69697515] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1314; }","duration":"115.445789ms","start":"2026-07-02T05:05:58.926815Z","end":"2026-07-02T05:05:59.042261Z","steps":["trace[69697515] 'agreement among raft nodes before linearized reading' (duration: 115.277286ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:06:09.223999Z","caller":"traceutil/trace.go:171","msg":"trace[1724426767] linearizableReadLoop","detail":"{readStateIndex:1407; appliedIndex:1405; }","duration":"133.350083ms","start":"2026-07-02T05:06:09.090621Z","end":"2026-07-02T05:06:09.223971Z","steps":["trace[1724426767] 'read index received' (duration: 88.372267ms)","trace[1724426767] 'applied index is now lower than readState.Index' (duration: 44.976456ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:06:09.224608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.962863ms","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-02T05:06:09.224697Z","caller":"traceutil/trace.go:171","msg":"trace[428027681] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1356; }","duration":"134.098206ms","start":"2026-07-02T05:06:09.090578Z","end":"2026-07-02T05:06:09.224676Z","steps":["trace[428027681] 'agreement among raft nodes before linearized reading' (duration: 133.489736ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:06:09.224395Z","caller":"traceutil/trace.go:171","msg":"trace[425102188] transaction","detail":"{read_only:false; response_revision:1356; number_of_response:1; }","duration":"134.117285ms","start":"2026-07-02T05:06:09.089918Z","end":"2026-07-02T05:06:09.224035Z","steps":["trace[425102188] 'process raft request' (duration: 119.459115ms)","trace[425102188] 'compare' (duration: 14.458467ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:06:21.1545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.402202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:endpoint-controller\" ","response":"range_response_count:1 size:751"} {"level":"info","ts":"2026-07-02T05:06:21.154892Z","caller":"traceutil/trace.go:171","msg":"trace[2025291780] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:endpoint-controller; range_end:; response_count:1; response_revision:1398; }","duration":"132.841209ms","start":"2026-07-02T05:06:21.022029Z","end":"2026-07-02T05:06:21.15487Z","steps":["trace[2025291780] 'range keys from in-memory index tree' (duration: 132.29743ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:06:21.560285Z","caller":"traceutil/trace.go:171","msg":"trace[1718802063] linearizableReadLoop","detail":"{readStateIndex:1453; appliedIndex:1452; }","duration":"272.483414ms","start":"2026-07-02T05:06:21.287731Z","end":"2026-07-02T05:06:21.560215Z","steps":["trace[1718802063] 'read index received' (duration: 246.152132ms)","trace[1718802063] 'applied index is now lower than readState.Index' (duration: 26.329992ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:06:21.560331Z","caller":"traceutil/trace.go:171","msg":"trace[2014560318] transaction","detail":"{read_only:false; response_revision:1400; number_of_response:1; }","duration":"277.466433ms","start":"2026-07-02T05:06:21.282834Z","end":"2026-07-02T05:06:21.560301Z","steps":["trace[2014560318] 'process raft request' (duration: 251.10299ms)","trace[2014560318] 'compare' (duration: 26.027987ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:06:21.560536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.381633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:endpointslice-controller\" ","response":"range_response_count:1 size:771"} {"level":"warn","ts":"2026-07-02T05:06:21.560574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.83426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-02T05:06:21.560614Z","caller":"traceutil/trace.go:171","msg":"trace[535469777] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:endpointslice-controller; range_end:; response_count:1; response_revision:1400; }","duration":"203.501565ms","start":"2026-07-02T05:06:21.357091Z","end":"2026-07-02T05:06:21.560593Z","steps":["trace[535469777] 'agreement among raft nodes before linearized reading' (duration: 203.376743ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:06:21.56063Z","caller":"traceutil/trace.go:171","msg":"trace[1803993429] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1400; }","duration":"272.90926ms","start":"2026-07-02T05:06:21.287703Z","end":"2026-07-02T05:06:21.560613Z","steps":["trace[1803993429] 'agreement among raft nodes before linearized reading' (duration: 272.716507ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:21.560676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.775038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:service-account-controller\" ","response":"range_response_count:1 size:677"} {"level":"info","ts":"2026-07-02T05:06:21.560816Z","caller":"traceutil/trace.go:171","msg":"trace[1177729820] range","detail":"{range_begin:/registry/clusterroles/system:controller:service-account-controller; range_end:; response_count:1; response_revision:1400; }","duration":"201.94272ms","start":"2026-07-02T05:06:21.358839Z","end":"2026-07-02T05:06:21.560781Z","steps":["trace[1177729820] 'agreement among raft nodes before linearized reading' (duration: 201.694136ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:22.068958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.625272ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T05:06:22.069332Z","caller":"traceutil/trace.go:171","msg":"trace[967136896] transaction","detail":"{read_only:false; response_revision:1402; number_of_response:1; }","duration":"189.232527ms","start":"2026-07-02T05:06:21.880078Z","end":"2026-07-02T05:06:22.06931Z","steps":["trace[967136896] 'process raft request' (duration: 188.993913ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:06:22.069522Z","caller":"traceutil/trace.go:171","msg":"trace[279569328] transaction","detail":"{read_only:false; response_revision:1401; number_of_response:1; }","duration":"503.257502ms","start":"2026-07-02T05:06:21.566233Z","end":"2026-07-02T05:06:22.06949Z","steps":["trace[279569328] 'process raft request' (duration: 246.03172ms)","trace[279569328] 'compare' (duration: 256.329968ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:06:22.069562Z","caller":"traceutil/trace.go:171","msg":"trace[540496153] linearizableReadLoop","detail":"{readStateIndex:1454; appliedIndex:1453; }","duration":"415.856104ms","start":"2026-07-02T05:06:21.653654Z","end":"2026-07-02T05:06:22.06951Z","steps":["trace[540496153] 'read index received' (duration: 158.547191ms)","trace[540496153] 'applied index is now lower than readState.Index' (duration: 257.305623ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:06:22.069683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:21.566215Z","time spent":"503.392094ms","remote":"127.0.0.1:48982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:06:22.069711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.048967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:endpointslicemirroring-controller\" ","response":"range_response_count:1 size:807"} {"level":"info","ts":"2026-07-02T05:06:22.069791Z","caller":"traceutil/trace.go:171","msg":"trace[631116166] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:endpointslicemirroring-controller; range_end:; response_count:1; response_revision:1402; }","duration":"416.133888ms","start":"2026-07-02T05:06:21.653634Z","end":"2026-07-02T05:06:22.069768Z","steps":["trace[631116166] 'agreement among raft nodes before linearized reading' (duration: 415.965716ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:22.069847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:21.653573Z","time spent":"416.26464ms","remote":"127.0.0.1:49060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":829,"request content":"key:\"/registry/clusterrolebindings/system:controller:endpointslicemirroring-controller\" "} {"level":"warn","ts":"2026-07-02T05:06:22.069855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.366281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:service-controller\" ","response":"range_response_count:1 size:724"} {"level":"info","ts":"2026-07-02T05:06:22.069904Z","caller":"traceutil/trace.go:171","msg":"trace[1250454402] range","detail":"{range_begin:/registry/clusterroles/system:controller:service-controller; range_end:; response_count:1; response_revision:1402; }","duration":"414.457012ms","start":"2026-07-02T05:06:21.655431Z","end":"2026-07-02T05:06:22.069888Z","steps":["trace[1250454402] 'agreement among raft nodes before linearized reading' (duration: 414.31189ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:22.069951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:21.655423Z","time spent":"414.518663ms","remote":"127.0.0.1:49044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":746,"request content":"key:\"/registry/clusterroles/system:controller:service-controller\" "} {"level":"warn","ts":"2026-07-02T05:06:22.385906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.080101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:statefulset-controller\" ","response":"range_response_count:1 size:990"} {"level":"info","ts":"2026-07-02T05:06:22.386049Z","caller":"traceutil/trace.go:171","msg":"trace[196619140] range","detail":"{range_begin:/registry/clusterroles/system:controller:statefulset-controller; range_end:; response_count:1; response_revision:1403; }","duration":"143.312715ms","start":"2026-07-02T05:06:22.242703Z","end":"2026-07-02T05:06:22.386016Z","steps":["trace[196619140] 'range keys from in-memory index tree' (duration: 142.848858ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:22.386072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.093475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:ephemeral-volume-controller\" ","response":"range_response_count:1 size:783"} {"level":"info","ts":"2026-07-02T05:06:22.386159Z","caller":"traceutil/trace.go:171","msg":"trace[880706438] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:ephemeral-volume-controller; range_end:; response_count:1; response_revision:1403; }","duration":"140.236747ms","start":"2026-07-02T05:06:22.245899Z","end":"2026-07-02T05:06:22.386136Z","steps":["trace[880706438] 'range keys from in-memory index tree' (duration: 139.951053ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:22.939402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.776373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:06:22.939496Z","caller":"traceutil/trace.go:171","msg":"trace[1319724182] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1404; }","duration":"111.927875ms","start":"2026-07-02T05:06:22.827547Z","end":"2026-07-02T05:06:22.939475Z","steps":["trace[1319724182] 'count revisions from in-memory index tree' (duration: 111.634581ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:22.939546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.00182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:ttl-controller\" ","response":"range_response_count:1 size:663"} {"level":"info","ts":"2026-07-02T05:06:22.939654Z","caller":"traceutil/trace.go:171","msg":"trace[1657944203] range","detail":"{range_begin:/registry/clusterroles/system:controller:ttl-controller; range_end:; response_count:1; response_revision:1404; }","duration":"143.129672ms","start":"2026-07-02T05:06:22.796505Z","end":"2026-07-02T05:06:22.939635Z","steps":["trace[1657944203] 'range keys from in-memory index tree' (duration: 142.869398ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:06:23.136841Z","caller":"traceutil/trace.go:171","msg":"trace[1009844413] linearizableReadLoop","detail":"{readStateIndex:1458; appliedIndex:1457; }","duration":"110.795652ms","start":"2026-07-02T05:06:23.026017Z","end":"2026-07-02T05:06:23.136813Z","steps":["trace[1009844413] 'read index received' (duration: 110.546968ms)","trace[1009844413] 'applied index is now lower than readState.Index' (duration: 247.464µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:06:23.137013Z","caller":"traceutil/trace.go:171","msg":"trace[610101355] transaction","detail":"{read_only:false; response_revision:1405; number_of_response:1; }","duration":"113.595186ms","start":"2026-07-02T05:06:23.023353Z","end":"2026-07-02T05:06:23.136948Z","steps":["trace[610101355] 'process raft request' (duration: 113.289941ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:23.137149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.875042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:coredns\" ","response":"range_response_count:1 size:388"} {"level":"warn","ts":"2026-07-02T05:06:23.137086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.038166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:775"} {"level":"info","ts":"2026-07-02T05:06:23.137322Z","caller":"traceutil/trace.go:171","msg":"trace[340511609] range","detail":"{range_begin:/registry/clusterroles/system:coredns; range_end:; response_count:1; response_revision:1405; }","duration":"107.072915ms","start":"2026-07-02T05:06:23.030229Z","end":"2026-07-02T05:06:23.137302Z","steps":["trace[340511609] 'agreement among raft nodes before linearized reading' (duration: 106.837841ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:06:23.137433Z","caller":"traceutil/trace.go:171","msg":"trace[205428834] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:1405; }","duration":"111.357021ms","start":"2026-07-02T05:06:23.026012Z","end":"2026-07-02T05:06:23.137369Z","steps":["trace[205428834] 'agreement among raft nodes before linearized reading' (duration: 110.959124ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:23.521865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.682559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:job-controller\" ","response":"range_response_count:1 size:731"} {"level":"info","ts":"2026-07-02T05:06:23.52195Z","caller":"traceutil/trace.go:171","msg":"trace[2000838211] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:job-controller; range_end:; response_count:1; response_revision:1407; }","duration":"126.771581ms","start":"2026-07-02T05:06:23.395155Z","end":"2026-07-02T05:06:23.521926Z","steps":["trace[2000838211] 'range keys from in-memory index tree' (duration: 126.600508ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:23.848567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.781736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:discovery\" ","response":"range_response_count:1 size:647"} {"level":"info","ts":"2026-07-02T05:06:23.848677Z","caller":"traceutil/trace.go:171","msg":"trace[1104544985] range","detail":"{range_begin:/registry/clusterroles/system:discovery; range_end:; response_count:1; response_revision:1408; }","duration":"100.932998ms","start":"2026-07-02T05:06:23.747718Z","end":"2026-07-02T05:06:23.848651Z","steps":["trace[1104544985] 'range keys from in-memory index tree' (duration: 100.619843ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:24.633034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.039086ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T05:06:24.633166Z","caller":"traceutil/trace.go:171","msg":"trace[997665683] linearizableReadLoop","detail":"{readStateIndex:1464; appliedIndex:1463; }","duration":"407.633513ms","start":"2026-07-02T05:06:24.225508Z","end":"2026-07-02T05:06:24.633142Z","steps":["trace[997665683] 'read index received' (duration: 25.287542ms)","trace[997665683] 'applied index is now lower than readState.Index' (duration: 382.343911ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:06:24.633317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.02409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:pv-protection-controller\" ","response":"range_response_count:1 size:771"} {"level":"info","ts":"2026-07-02T05:06:24.633356Z","caller":"traceutil/trace.go:171","msg":"trace[1977371033] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:pv-protection-controller; range_end:; response_count:1; response_revision:1410; }","duration":"399.125621ms","start":"2026-07-02T05:06:24.234214Z","end":"2026-07-02T05:06:24.63334Z","steps":["trace[1977371033] 'agreement among raft nodes before linearized reading' (duration: 399.04332ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:24.633402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:24.234173Z","time spent":"399.218622ms","remote":"127.0.0.1:49060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":793,"request content":"key:\"/registry/clusterrolebindings/system:controller:pv-protection-controller\" "} {"level":"warn","ts":"2026-07-02T05:06:24.633518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.907867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:06:24.633561Z","caller":"traceutil/trace.go:171","msg":"trace[1262680781] transaction","detail":"{read_only:false; response_revision:1410; number_of_response:1; }","duration":"474.788683ms","start":"2026-07-02T05:06:24.158738Z","end":"2026-07-02T05:06:24.633527Z","steps":["trace[1262680781] 'process raft request' (duration: 92.114837ms)","trace[1262680781] 'compare' (duration: 381.899174ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:06:24.633605Z","caller":"traceutil/trace.go:171","msg":"trace[1533971074] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1410; }","duration":"224.040169ms","start":"2026-07-02T05:06:24.409542Z","end":"2026-07-02T05:06:24.633582Z","steps":["trace[1533971074] 'agreement among raft nodes before linearized reading' (duration: 223.887057ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:24.633699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.184122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:pod-garbage-collector\" ","response":"range_response_count:1 size:759"} {"level":"info","ts":"2026-07-02T05:06:24.633734Z","caller":"traceutil/trace.go:171","msg":"trace[970257149] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:pod-garbage-collector; range_end:; response_count:1; response_revision:1410; }","duration":"408.264562ms","start":"2026-07-02T05:06:24.22546Z","end":"2026-07-02T05:06:24.633725Z","steps":["trace[970257149] 'agreement among raft nodes before linearized reading' (duration: 408.189081ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:24.633721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:24.158721Z","time spent":"474.909925ms","remote":"127.0.0.1:48982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:06:24.633765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:24.22544Z","time spent":"408.315294ms","remote":"127.0.0.1:49060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":781,"request content":"key:\"/registry/clusterrolebindings/system:controller:pod-garbage-collector\" "} {"level":"info","ts":"2026-07-02T05:06:25.264758Z","caller":"traceutil/trace.go:171","msg":"trace[1294706949] transaction","detail":"{read_only:false; response_revision:1412; number_of_response:1; }","duration":"121.615628ms","start":"2026-07-02T05:06:25.143112Z","end":"2026-07-02T05:06:25.264728Z","steps":["trace[1294706949] 'process raft request' (duration: 121.206721ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:06:25.446818Z","caller":"traceutil/trace.go:171","msg":"trace[1747908113] transaction","detail":"{read_only:false; response_revision:1414; number_of_response:1; }","duration":"106.644246ms","start":"2026-07-02T05:06:25.34014Z","end":"2026-07-02T05:06:25.446784Z","steps":["trace[1747908113] 'process raft request' (duration: 39.103124ms)","trace[1747908113] 'compare' (duration: 67.37733ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:06:30.83483Z","caller":"traceutil/trace.go:171","msg":"trace[328012589] linearizableReadLoop","detail":"{readStateIndex:1484; appliedIndex:1483; }","duration":"162.508449ms","start":"2026-07-02T05:06:30.672298Z","end":"2026-07-02T05:06:30.834807Z","steps":["trace[328012589] 'read index received' (duration: 162.299505ms)","trace[328012589] 'applied index is now lower than readState.Index' (duration: 208.054µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:06:30.834907Z","caller":"traceutil/trace.go:171","msg":"trace[1310604739] transaction","detail":"{read_only:false; response_revision:1429; number_of_response:1; }","duration":"173.982533ms","start":"2026-07-02T05:06:30.660896Z","end":"2026-07-02T05:06:30.834879Z","steps":["trace[1310604739] 'process raft request' (duration: 173.77489ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:30.835069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.748562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-jqjxn\" ","response":"range_response_count:1 size:5487"} {"level":"warn","ts":"2026-07-02T05:06:30.835063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.93673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/default/\" range_end:\"/registry/rolebindings/default0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:06:30.835108Z","caller":"traceutil/trace.go:171","msg":"trace[55304920] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-jqjxn; range_end:; response_count:1; response_revision:1429; }","duration":"162.824683ms","start":"2026-07-02T05:06:30.672273Z","end":"2026-07-02T05:06:30.835097Z","steps":["trace[55304920] 'agreement among raft nodes before linearized reading' (duration: 162.660721ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:06:30.835128Z","caller":"traceutil/trace.go:171","msg":"trace[132808662] range","detail":"{range_begin:/registry/rolebindings/default/; range_end:/registry/rolebindings/default0; response_count:0; response_revision:1429; }","duration":"135.040851ms","start":"2026-07-02T05:06:30.700073Z","end":"2026-07-02T05:06:30.835114Z","steps":["trace[132808662] 'agreement among raft nodes before linearized reading' (duration: 134.92807ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:30.835323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.515253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:1 size:1465"} {"level":"info","ts":"2026-07-02T05:06:30.835399Z","caller":"traceutil/trace.go:171","msg":"trace[70097609] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:1429; }","duration":"132.616194ms","start":"2026-07-02T05:06:30.702765Z","end":"2026-07-02T05:06:30.835381Z","steps":["trace[70097609] 'agreement among raft nodes before linearized reading' (duration: 132.35722ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:06:43.123047Z","caller":"traceutil/trace.go:171","msg":"trace[524622361] linearizableReadLoop","detail":"{readStateIndex:1526; appliedIndex:1525; }","duration":"121.370716ms","start":"2026-07-02T05:06:43.001651Z","end":"2026-07-02T05:06:43.123022Z","steps":["trace[524622361] 'read index received' (duration: 121.211654ms)","trace[524622361] 'applied index is now lower than readState.Index' (duration: 155.772µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:06:43.123137Z","caller":"traceutil/trace.go:171","msg":"trace[859160346] transaction","detail":"{read_only:false; response_revision:1469; number_of_response:1; }","duration":"241.060852ms","start":"2026-07-02T05:06:42.882047Z","end":"2026-07-02T05:06:43.123108Z","steps":["trace[859160346] 'process raft request' (duration: 240.812219ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:43.123301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.62273ms","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-02T05:06:43.123344Z","caller":"traceutil/trace.go:171","msg":"trace[2128262161] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1469; }","duration":"121.729761ms","start":"2026-07-02T05:06:43.001604Z","end":"2026-07-02T05:06:43.123334Z","steps":["trace[2128262161] 'agreement among raft nodes before linearized reading' (duration: 121.567248ms)"],"step_count":1}