{"level":"warn","ts":"2026-06-26T02:10:02.616424Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-26T02:10:02.616631Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.183: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.19.213.183:2380","--initial-cluster=instance=https://199.19.213.183:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.183:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.183: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-06-26T02:10:02.61674Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-26T02:10:02.616783Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.183:2380"]} {"level":"info","ts":"2026-06-26T02:10:02.616826Z","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-06-26T02:10:02.617684Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.183:2379"]} {"level":"info","ts":"2026-06-26T02:10:02.617839Z","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.19.213.183:2380"],"listen-peer-urls":["https://199.19.213.183:2380"],"advertise-client-urls":["https://199.19.213.183:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.183:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.183: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-06-26T02:10:02.623143Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.994496ms"} {"level":"info","ts":"2026-06-26T02:10:02.635523Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d11d60056e8410fb","cluster-id":"524d1f88cdf60208"} {"level":"info","ts":"2026-06-26T02:10:02.635699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d11d60056e8410fb switched to configuration voters=()"} {"level":"info","ts":"2026-06-26T02:10:02.635941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d11d60056e8410fb became follower at term 0"} {"level":"info","ts":"2026-06-26T02:10:02.635981Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d11d60056e8410fb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-26T02:10:02.636071Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d11d60056e8410fb became follower at term 1"} {"level":"info","ts":"2026-06-26T02:10:02.636179Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d11d60056e8410fb switched to configuration voters=(15068305504696799483)"} {"level":"warn","ts":"2026-06-26T02:10:02.647478Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-26T02:10:02.649823Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-26T02:10:02.651554Z","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-06-26T02:10:02.655181Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d11d60056e8410fb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-26T02:10:02.655477Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d11d60056e8410fb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-26T02:10:02.655752Z","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-06-26T02:10:02.656257Z","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-06-26T02:10:02.656331Z","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-06-26T02:10:02.657763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d11d60056e8410fb switched to configuration voters=(15068305504696799483)"} {"level":"info","ts":"2026-06-26T02:10:02.658415Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"524d1f88cdf60208","local-member-id":"d11d60056e8410fb","added-peer-id":"d11d60056e8410fb","added-peer-peer-urls":["https://199.19.213.183:2380"]} {"level":"info","ts":"2026-06-26T02:10:02.660166Z","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-06-26T02:10:02.660379Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d11d60056e8410fb","initial-advertise-peer-urls":["https://199.19.213.183:2380"],"listen-peer-urls":["https://199.19.213.183:2380"],"advertise-client-urls":["https://199.19.213.183:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.183:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-26T02:10:02.660399Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.183:2380"} {"level":"info","ts":"2026-06-26T02:10:02.660429Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.183:2380"} {"level":"info","ts":"2026-06-26T02:10:02.660425Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-26T02:10:03.136479Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d11d60056e8410fb is starting a new election at term 1"} {"level":"info","ts":"2026-06-26T02:10:03.136546Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d11d60056e8410fb became pre-candidate at term 1"} {"level":"info","ts":"2026-06-26T02:10:03.136569Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d11d60056e8410fb received MsgPreVoteResp from d11d60056e8410fb at term 1"} {"level":"info","ts":"2026-06-26T02:10:03.136588Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d11d60056e8410fb became candidate at term 2"} {"level":"info","ts":"2026-06-26T02:10:03.136599Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d11d60056e8410fb received MsgVoteResp from d11d60056e8410fb at term 2"} {"level":"info","ts":"2026-06-26T02:10:03.136617Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d11d60056e8410fb became leader at term 2"} {"level":"info","ts":"2026-06-26T02:10:03.136739Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d11d60056e8410fb elected leader d11d60056e8410fb at term 2"} {"level":"info","ts":"2026-06-26T02:10:03.241995Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T02:10:03.243239Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d11d60056e8410fb","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.183:2379]}","request-path":"/0/members/d11d60056e8410fb/attributes","cluster-id":"524d1f88cdf60208","publish-timeout":"7s"} {"level":"info","ts":"2026-06-26T02:10:03.243248Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-26T02:10:03.243393Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-26T02:10:03.243634Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-26T02:10:03.243688Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-26T02:10:03.244563Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"524d1f88cdf60208","local-member-id":"d11d60056e8410fb","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T02:10:03.244671Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T02:10:03.24471Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T02:10:03.247041Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-26T02:10:03.247071Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.183:2379"} {"level":"info","ts":"2026-06-26T02:10:06.392605Z","caller":"traceutil/trace.go:171","msg":"trace[1963190902] transaction","detail":"{read_only:false; response_revision:183; number_of_response:1; }","duration":"111.617614ms","start":"2026-06-26T02:10:06.280961Z","end":"2026-06-26T02:10:06.392579Z","steps":["trace[1963190902] 'process raft request' (duration: 77.742757ms)","trace[1963190902] 'compare' (duration: 33.741793ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:10:07.12431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.209913ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-26T02:10:07.124623Z","caller":"traceutil/trace.go:171","msg":"trace[1765021987] linearizableReadLoop","detail":"{readStateIndex:193; appliedIndex:192; }","duration":"542.1013ms","start":"2026-06-26T02:10:06.582492Z","end":"2026-06-26T02:10:07.124593Z","steps":["trace[1765021987] 'read index received' (duration: 275.591666ms)","trace[1765021987] 'applied index is now lower than readState.Index' (duration: 266.507433ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:10:07.1247Z","caller":"traceutil/trace.go:171","msg":"trace[426442038] transaction","detail":"{read_only:false; response_revision:189; number_of_response:1; }","duration":"680.567883ms","start":"2026-06-26T02:10:06.444069Z","end":"2026-06-26T02:10:07.124637Z","steps":["trace[426442038] 'process raft request' (duration: 414.114161ms)","trace[426442038] 'compare' (duration: 264.873512ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:10:07.124877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.369729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T02:10:07.124901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:06.444049Z","time spent":"680.75913ms","remote":"127.0.0.1:38090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":841,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T02:10:07.124966Z","caller":"traceutil/trace.go:171","msg":"trace[825364160] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:189; }","duration":"542.513194ms","start":"2026-06-26T02:10:06.582432Z","end":"2026-06-26T02:10:07.124945Z","steps":["trace[825364160] 'agreement among raft nodes before linearized reading' (duration: 542.303447ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:07.125013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:06.582404Z","time spent":"542.597896ms","remote":"127.0.0.1:37758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T02:10:07.125525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.744516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:10:07.125666Z","caller":"traceutil/trace.go:171","msg":"trace[506455585] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:189; }","duration":"508.108898ms","start":"2026-06-26T02:10:06.617531Z","end":"2026-06-26T02:10:07.12564Z","steps":["trace[506455585] 'agreement among raft nodes before linearized reading' (duration: 507.378455ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:07.125784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:06.617516Z","time spent":"508.248163ms","remote":"127.0.0.1:37766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-26T02:10:07.325871Z","caller":"traceutil/trace.go:171","msg":"trace[849868200] transaction","detail":"{read_only:false; response_revision:191; number_of_response:1; }","duration":"136.311507ms","start":"2026-06-26T02:10:07.189529Z","end":"2026-06-26T02:10:07.32584Z","steps":["trace[849868200] 'process raft request' (duration: 94.489379ms)","trace[849868200] 'compare' (duration: 41.693883ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:10:09.305451Z","caller":"traceutil/trace.go:171","msg":"trace[1005255213] transaction","detail":"{read_only:false; response_revision:288; number_of_response:1; }","duration":"141.896205ms","start":"2026-06-26T02:10:09.163533Z","end":"2026-06-26T02:10:09.305429Z","steps":["trace[1005255213] 'process raft request' (duration: 81.578022ms)","trace[1005255213] 'compare' (duration: 60.161268ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:10:09.305555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.295389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cronjob-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:10:09.305646Z","caller":"traceutil/trace.go:171","msg":"trace[1191650834] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cronjob-controller; range_end:; response_count:0; response_revision:288; }","duration":"134.422523ms","start":"2026-06-26T02:10:09.171202Z","end":"2026-06-26T02:10:09.305624Z","steps":["trace[1191650834] 'agreement among raft nodes before linearized reading' (duration: 134.244207ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:09.30592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.683034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:10:09.306Z","caller":"traceutil/trace.go:171","msg":"trace[1089001221] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:289; }","duration":"138.813978ms","start":"2026-06-26T02:10:09.167169Z","end":"2026-06-26T02:10:09.305983Z","steps":["trace[1089001221] 'agreement among raft nodes before linearized reading' (duration: 138.454497ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:09.305395Z","caller":"traceutil/trace.go:171","msg":"trace[467120278] linearizableReadLoop","detail":"{readStateIndex:294; appliedIndex:293; }","duration":"130.120689ms","start":"2026-06-26T02:10:09.175253Z","end":"2026-06-26T02:10:09.305373Z","steps":["trace[467120278] 'read index received' (duration: 69.867208ms)","trace[467120278] 'applied index is now lower than readState.Index' (duration: 60.251351ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:10:09.305752Z","caller":"traceutil/trace.go:171","msg":"trace[794893327] transaction","detail":"{read_only:false; response_revision:289; number_of_response:1; }","duration":"128.000883ms","start":"2026-06-26T02:10:09.177733Z","end":"2026-06-26T02:10:09.305734Z","steps":["trace[794893327] 'process raft request' (duration: 127.687384ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:09.33447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.035834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-06-26T02:10:09.334639Z","caller":"traceutil/trace.go:171","msg":"trace[1227665714] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:290; }","duration":"157.23083ms","start":"2026-06-26T02:10:09.177383Z","end":"2026-06-26T02:10:09.334614Z","steps":["trace[1227665714] 'agreement among raft nodes before linearized reading' (duration: 156.977873ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:13.885425Z","caller":"traceutil/trace.go:171","msg":"trace[1890407598] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"148.789088ms","start":"2026-06-26T02:10:13.736605Z","end":"2026-06-26T02:10:13.885394Z","steps":["trace[1890407598] 'process raft request' (duration: 108.670267ms)","trace[1890407598] 'compare' (duration: 39.989067ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:10:13.885904Z","caller":"traceutil/trace.go:171","msg":"trace[33656953] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"147.051616ms","start":"2026-06-26T02:10:13.738827Z","end":"2026-06-26T02:10:13.885879Z","steps":["trace[33656953] 'process raft request' (duration: 146.86524ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:13.886097Z","caller":"traceutil/trace.go:171","msg":"trace[1093468031] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"147.150149ms","start":"2026-06-26T02:10:13.738925Z","end":"2026-06-26T02:10:13.886075Z","steps":["trace[1093468031] 'process raft request' (duration: 146.906052ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:13.886389Z","caller":"traceutil/trace.go:171","msg":"trace[891763310] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"147.416337ms","start":"2026-06-26T02:10:13.738943Z","end":"2026-06-26T02:10:13.886359Z","steps":["trace[891763310] 'process raft request' (duration: 147.087397ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:13.886477Z","caller":"traceutil/trace.go:171","msg":"trace[945061937] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"147.091597ms","start":"2026-06-26T02:10:13.739373Z","end":"2026-06-26T02:10:13.886464Z","steps":["trace[945061937] 'process raft request' (duration: 146.880471ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:13.886833Z","caller":"traceutil/trace.go:171","msg":"trace[379234030] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"140.056409ms","start":"2026-06-26T02:10:13.746748Z","end":"2026-06-26T02:10:13.886804Z","steps":["trace[379234030] 'process raft request' (duration: 140.006768ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:13.887028Z","caller":"traceutil/trace.go:171","msg":"trace[961876879] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"146.334335ms","start":"2026-06-26T02:10:13.740676Z","end":"2026-06-26T02:10:13.88701Z","steps":["trace[961876879] 'process raft request' (duration: 145.649915ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:14.110373Z","caller":"traceutil/trace.go:171","msg":"trace[597396580] linearizableReadLoop","detail":"{readStateIndex:402; appliedIndex:401; }","duration":"110.62227ms","start":"2026-06-26T02:10:13.999699Z","end":"2026-06-26T02:10:14.110322Z","steps":["trace[597396580] 'read index received' (duration: 87.354457ms)","trace[597396580] 'applied index is now lower than readState.Index' (duration: 23.266363ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:10:14.110541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.814336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-06-26T02:10:14.110528Z","caller":"traceutil/trace.go:171","msg":"trace[170657813] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"158.444611ms","start":"2026-06-26T02:10:13.952053Z","end":"2026-06-26T02:10:14.110498Z","steps":["trace[170657813] 'process raft request' (duration: 135.085815ms)","trace[170657813] 'compare' (duration: 22.832161ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:10:14.110574Z","caller":"traceutil/trace.go:171","msg":"trace[93184009] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:389; }","duration":"110.894668ms","start":"2026-06-26T02:10:13.999671Z","end":"2026-06-26T02:10:14.110566Z","steps":["trace[93184009] 'agreement among raft nodes before linearized reading' (duration: 110.778294ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:14.335196Z","caller":"traceutil/trace.go:171","msg":"trace[646084440] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"120.251052ms","start":"2026-06-26T02:10:14.21491Z","end":"2026-06-26T02:10:14.335161Z","steps":["trace[646084440] 'process raft request' (duration: 119.309835ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:14.656487Z","caller":"traceutil/trace.go:171","msg":"trace[623518312] linearizableReadLoop","detail":"{readStateIndex:406; appliedIndex:405; }","duration":"206.176747ms","start":"2026-06-26T02:10:14.45024Z","end":"2026-06-26T02:10:14.656417Z","steps":["trace[623518312] 'read index received' (duration: 201.409847ms)","trace[623518312] 'applied index is now lower than readState.Index' (duration: 4.76572ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:10:14.656722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.448745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:10:14.65683Z","caller":"traceutil/trace.go:171","msg":"trace[1107050494] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:393; }","duration":"206.594019ms","start":"2026-06-26T02:10:14.450211Z","end":"2026-06-26T02:10:14.656805Z","steps":["trace[1107050494] 'agreement among raft nodes before linearized reading' (duration: 206.413524ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:14.656589Z","caller":"traceutil/trace.go:171","msg":"trace[1717753798] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"231.953254ms","start":"2026-06-26T02:10:14.424599Z","end":"2026-06-26T02:10:14.656552Z","steps":["trace[1717753798] 'process raft request' (duration: 227.145062ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:14.657162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.968876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-26T02:10:14.657457Z","caller":"traceutil/trace.go:171","msg":"trace[1332605677] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:393; }","duration":"180.339466ms","start":"2026-06-26T02:10:14.477092Z","end":"2026-06-26T02:10:14.657431Z","steps":["trace[1332605677] 'agreement among raft nodes before linearized reading' (duration: 179.944215ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:16.347672Z","caller":"traceutil/trace.go:171","msg":"trace[574713826] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"123.881211ms","start":"2026-06-26T02:10:16.223767Z","end":"2026-06-26T02:10:16.347648Z","steps":["trace[574713826] 'process raft request' (duration: 123.668565ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:16.568401Z","caller":"traceutil/trace.go:171","msg":"trace[126111654] linearizableReadLoop","detail":"{readStateIndex:416; appliedIndex:415; }","duration":"164.437417ms","start":"2026-06-26T02:10:16.403938Z","end":"2026-06-26T02:10:16.568376Z","steps":["trace[126111654] 'read index received' (duration: 143.721731ms)","trace[126111654] 'applied index is now lower than readState.Index' (duration: 20.714836ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:10:16.568435Z","caller":"traceutil/trace.go:171","msg":"trace[2043070730] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"213.044394ms","start":"2026-06-26T02:10:16.355371Z","end":"2026-06-26T02:10:16.568415Z","steps":["trace[2043070730] 'process raft request' (duration: 192.360669ms)","trace[2043070730] 'compare' (duration: 20.528881ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:10:16.568566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.616922ms","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-06-26T02:10:16.568646Z","caller":"traceutil/trace.go:171","msg":"trace[935757022] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:402; }","duration":"164.752765ms","start":"2026-06-26T02:10:16.403883Z","end":"2026-06-26T02:10:16.568636Z","steps":["trace[935757022] 'agreement among raft nodes before linearized reading' (duration: 164.605501ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:16.568819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.146775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:10:16.568866Z","caller":"traceutil/trace.go:171","msg":"trace[767618437] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:402; }","duration":"119.228788ms","start":"2026-06-26T02:10:16.449625Z","end":"2026-06-26T02:10:16.568854Z","steps":["trace[767618437] 'agreement among raft nodes before linearized reading' (duration: 119.152966ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:16.840322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.409782ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T02:10:16.840441Z","caller":"traceutil/trace.go:171","msg":"trace[480840054] linearizableReadLoop","detail":"{readStateIndex:418; appliedIndex:417; }","duration":"171.936443ms","start":"2026-06-26T02:10:16.668479Z","end":"2026-06-26T02:10:16.840416Z","steps":["trace[480840054] 'read index received' (duration: 20.120988ms)","trace[480840054] 'applied index is now lower than readState.Index' (duration: 151.813945ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:10:16.840523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.036055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-26T02:10:16.840675Z","caller":"traceutil/trace.go:171","msg":"trace[1069003647] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"175.318949ms","start":"2026-06-26T02:10:16.66533Z","end":"2026-06-26T02:10:16.840649Z","steps":["trace[1069003647] 'process raft request' (duration: 23.331321ms)","trace[1069003647] 'compare' (duration: 151.292099ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:10:16.840735Z","caller":"traceutil/trace.go:171","msg":"trace[924114931] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:404; }","duration":"172.272842ms","start":"2026-06-26T02:10:16.668442Z","end":"2026-06-26T02:10:16.840715Z","steps":["trace[924114931] 'agreement among raft nodes before linearized reading' (duration: 172.035045ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:17.600107Z","caller":"traceutil/trace.go:171","msg":"trace[1286093470] linearizableReadLoop","detail":"{readStateIndex:420; appliedIndex:419; }","duration":"149.689078ms","start":"2026-06-26T02:10:17.450391Z","end":"2026-06-26T02:10:17.60008Z","steps":["trace[1286093470] 'read index received' (duration: 149.591495ms)","trace[1286093470] 'applied index is now lower than readState.Index' (duration: 96.613µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:10:17.600171Z","caller":"traceutil/trace.go:171","msg":"trace[1625743879] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"403.72721ms","start":"2026-06-26T02:10:17.19641Z","end":"2026-06-26T02:10:17.600137Z","steps":["trace[1625743879] 'process raft request' (duration: 403.501694ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:17.600835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:17.196384Z","time spent":"404.368719ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:10:17.600309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.891133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:10:17.601005Z","caller":"traceutil/trace.go:171","msg":"trace[1033630055] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:406; }","duration":"150.681475ms","start":"2026-06-26T02:10:17.450299Z","end":"2026-06-26T02:10:17.60098Z","steps":["trace[1033630055] 'agreement among raft nodes before linearized reading' (duration: 149.930054ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:17.766584Z","caller":"traceutil/trace.go:171","msg":"trace[42165464] linearizableReadLoop","detail":"{readStateIndex:421; appliedIndex:420; }","duration":"164.480816ms","start":"2026-06-26T02:10:17.602083Z","end":"2026-06-26T02:10:17.766564Z","steps":["trace[42165464] 'read index received' (duration: 137.331275ms)","trace[42165464] 'applied index is now lower than readState.Index' (duration: 27.145671ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:10:17.76684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.699822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:10:17.767384Z","caller":"traceutil/trace.go:171","msg":"trace[583242761] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:406; }","duration":"164.945639ms","start":"2026-06-26T02:10:17.602052Z","end":"2026-06-26T02:10:17.766997Z","steps":["trace[583242761] 'agreement among raft nodes before linearized reading' (duration: 164.680192ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:28.233494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.111051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4420"} {"level":"info","ts":"2026-06-26T02:10:28.233586Z","caller":"traceutil/trace.go:171","msg":"trace[1948750860] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:431; }","duration":"315.249604ms","start":"2026-06-26T02:10:27.918315Z","end":"2026-06-26T02:10:28.233565Z","steps":["trace[1948750860] 'range keys from in-memory index tree' (duration: 314.988518ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:28.233576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"713.670439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.183\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-06-26T02:10:28.233634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:27.918299Z","time spent":"315.325617ms","remote":"127.0.0.1:37942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4443,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-06-26T02:10:28.233605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"783.150119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:10:28.233684Z","caller":"traceutil/trace.go:171","msg":"trace[2059504489] range","detail":"{range_begin:/registry/masterleases/199.19.213.183; range_end:; response_count:1; response_revision:431; }","duration":"713.841203ms","start":"2026-06-26T02:10:27.51981Z","end":"2026-06-26T02:10:28.233651Z","steps":["trace[2059504489] 'range keys from in-memory index tree' (duration: 713.489935ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:28.233697Z","caller":"traceutil/trace.go:171","msg":"trace[1926530764] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:431; }","duration":"783.319933ms","start":"2026-06-26T02:10:27.450357Z","end":"2026-06-26T02:10:28.233677Z","steps":["trace[1926530764] 'range keys from in-memory index tree' (duration: 783.067246ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:28.233743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:27.450334Z","time spent":"783.399085ms","remote":"127.0.0.1:37758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T02:10:28.233741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:27.519795Z","time spent":"713.933535ms","remote":"127.0.0.1:37802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.183\" "} {"level":"warn","ts":"2026-06-26T02:10:28.233768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"591.295314ms","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-06-26T02:10:28.233892Z","caller":"traceutil/trace.go:171","msg":"trace[907704730] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:431; }","duration":"591.511639ms","start":"2026-06-26T02:10:27.642352Z","end":"2026-06-26T02:10:28.233863Z","steps":["trace[907704730] 'range keys from in-memory index tree' (duration: 591.12894ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:28.233958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:27.642327Z","time spent":"591.618323ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-26T02:10:28.376063Z","caller":"traceutil/trace.go:171","msg":"trace[98971045] linearizableReadLoop","detail":"{readStateIndex:448; appliedIndex:447; }","duration":"140.953064ms","start":"2026-06-26T02:10:28.235084Z","end":"2026-06-26T02:10:28.376037Z","steps":["trace[98971045] 'read index received' (duration: 140.82857ms)","trace[98971045] 'applied index is now lower than readState.Index' (duration: 120.154µs)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:10:28.376286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:10:28.376428Z","caller":"traceutil/trace.go:171","msg":"trace[516124158] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:431; }","duration":"141.361744ms","start":"2026-06-26T02:10:28.235028Z","end":"2026-06-26T02:10:28.37639Z","steps":["trace[516124158] 'agreement among raft nodes before linearized reading' (duration: 141.134328ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:28.37743Z","caller":"traceutil/trace.go:171","msg":"trace[1053017431] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"139.169138ms","start":"2026-06-26T02:10:28.238232Z","end":"2026-06-26T02:10:28.377402Z","steps":["trace[1053017431] 'process raft request' (duration: 138.972944ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:29.330842Z","caller":"traceutil/trace.go:171","msg":"trace[948127820] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"305.682842ms","start":"2026-06-26T02:10:29.025124Z","end":"2026-06-26T02:10:29.330807Z","steps":["trace[948127820] 'process raft request' (duration: 243.064771ms)","trace[948127820] 'compare' (duration: 62.300444ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:10:29.330995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:29.025102Z","time spent":"305.816126ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:10:29.401704Z","caller":"traceutil/trace.go:171","msg":"trace[2138254456] transaction","detail":"{read_only:false; response_revision:437; number_of_response:1; }","duration":"366.968091ms","start":"2026-06-26T02:10:29.034712Z","end":"2026-06-26T02:10:29.40168Z","steps":["trace[2138254456] 'process raft request' (duration: 366.831708ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:29.402151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:29.034701Z","time spent":"367.236997ms","remote":"127.0.0.1:38230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4180,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:10:29.567723Z","caller":"traceutil/trace.go:171","msg":"trace[1436318285] linearizableReadLoop","detail":"{readStateIndex:455; appliedIndex:454; }","duration":"119.111871ms","start":"2026-06-26T02:10:29.448583Z","end":"2026-06-26T02:10:29.567695Z","steps":["trace[1436318285] 'read index received' (duration: 100.324229ms)","trace[1436318285] 'applied index is now lower than readState.Index' (duration: 18.785862ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:10:29.567792Z","caller":"traceutil/trace.go:171","msg":"trace[1639907241] transaction","detail":"{read_only:false; response_revision:438; number_of_response:1; }","duration":"158.766666ms","start":"2026-06-26T02:10:29.409004Z","end":"2026-06-26T02:10:29.567771Z","steps":["trace[1639907241] 'process raft request' (duration: 139.766168ms)","trace[1639907241] 'compare' (duration: 18.793492ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:10:29.567922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.322696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:10:29.567972Z","caller":"traceutil/trace.go:171","msg":"trace[1733042819] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:438; }","duration":"119.424808ms","start":"2026-06-26T02:10:29.448537Z","end":"2026-06-26T02:10:29.567962Z","steps":["trace[1733042819] 'agreement among raft nodes before linearized reading' (duration: 119.265834ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:35.276226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.966029ms","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-06-26T02:10:35.276301Z","caller":"traceutil/trace.go:171","msg":"trace[1942188657] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:476; }","duration":"230.072972ms","start":"2026-06-26T02:10:35.046198Z","end":"2026-06-26T02:10:35.276271Z","steps":["trace[1942188657] 'range keys from in-memory index tree' (duration: 229.883198ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:35.475976Z","caller":"traceutil/trace.go:171","msg":"trace[1241700424] linearizableReadLoop","detail":"{readStateIndex:495; appliedIndex:494; }","duration":"104.769918ms","start":"2026-06-26T02:10:35.371187Z","end":"2026-06-26T02:10:35.475957Z","steps":["trace[1241700424] 'read index received' (duration: 104.568453ms)","trace[1241700424] 'applied index is now lower than readState.Index' (duration: 200.555µs)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:10:35.476418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.215808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-26T02:10:35.476503Z","caller":"traceutil/trace.go:171","msg":"trace[1225703567] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:477; }","duration":"105.360222ms","start":"2026-06-26T02:10:35.371102Z","end":"2026-06-26T02:10:35.476462Z","steps":["trace[1225703567] 'agreement among raft nodes before linearized reading' (duration: 105.216898ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:35.476892Z","caller":"traceutil/trace.go:171","msg":"trace[1536164503] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"195.281138ms","start":"2026-06-26T02:10:35.281597Z","end":"2026-06-26T02:10:35.476878Z","steps":["trace[1536164503] 'process raft request' (duration: 194.209963ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:37.713784Z","caller":"traceutil/trace.go:171","msg":"trace[1758735534] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"188.807132ms","start":"2026-06-26T02:10:37.524956Z","end":"2026-06-26T02:10:37.713763Z","steps":["trace[1758735534] 'process raft request' (duration: 168.630204ms)","trace[1758735534] 'compare' (duration: 19.969073ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:10:37.713951Z","caller":"traceutil/trace.go:171","msg":"trace[708296506] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"184.926291ms","start":"2026-06-26T02:10:37.529008Z","end":"2026-06-26T02:10:37.713934Z","steps":["trace[708296506] 'process raft request' (duration: 184.714226ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:43.700725Z","caller":"traceutil/trace.go:171","msg":"trace[1957719891] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"152.231887ms","start":"2026-06-26T02:10:43.548475Z","end":"2026-06-26T02:10:43.700707Z","steps":["trace[1957719891] 'process raft request' (duration: 152.124325ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:44.173852Z","caller":"traceutil/trace.go:171","msg":"trace[1499180595] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"568.504681ms","start":"2026-06-26T02:10:43.605308Z","end":"2026-06-26T02:10:44.173813Z","steps":["trace[1499180595] 'process raft request' (duration: 568.306347ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:44.173935Z","caller":"traceutil/trace.go:171","msg":"trace[1093485133] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"564.474632ms","start":"2026-06-26T02:10:43.609411Z","end":"2026-06-26T02:10:44.173886Z","steps":["trace[1093485133] 'process raft request' (duration: 564.330389ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:44.174024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:43.60528Z","time spent":"568.651734ms","remote":"127.0.0.1:37808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T02:10:44.174082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:43.609405Z","time spent":"564.607906ms","remote":"127.0.0.1:37808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T02:10:44.174216Z","caller":"traceutil/trace.go:171","msg":"trace[330930638] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"554.386082ms","start":"2026-06-26T02:10:43.619808Z","end":"2026-06-26T02:10:44.174194Z","steps":["trace[330930638] 'process raft request' (duration: 554.108536ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:44.174238Z","caller":"traceutil/trace.go:171","msg":"trace[445646918] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"552.95391ms","start":"2026-06-26T02:10:43.621273Z","end":"2026-06-26T02:10:44.174227Z","steps":["trace[445646918] 'process raft request' (duration: 552.758885ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:44.174305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:43.621266Z","time spent":"553.014921ms","remote":"127.0.0.1:37808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T02:10:44.174315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:43.6198Z","time spent":"554.465793ms","remote":"127.0.0.1:37808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T02:10:44.174392Z","caller":"traceutil/trace.go:171","msg":"trace[2032578222] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"553.142454ms","start":"2026-06-26T02:10:43.621241Z","end":"2026-06-26T02:10:44.174383Z","steps":["trace[2032578222] 'process raft request' (duration: 552.754676ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:44.174451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:43.621233Z","time spent":"553.184835ms","remote":"127.0.0.1:37808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T02:10:44.17447Z","caller":"traceutil/trace.go:171","msg":"trace[1988294703] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"560.29284ms","start":"2026-06-26T02:10:43.614157Z","end":"2026-06-26T02:10:44.17445Z","steps":["trace[1988294703] 'process raft request' (duration: 559.618986ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:44.174542Z","caller":"traceutil/trace.go:171","msg":"trace[1737362652] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"534.542816ms","start":"2026-06-26T02:10:43.639989Z","end":"2026-06-26T02:10:44.174532Z","steps":["trace[1737362652] 'process raft request' (duration: 534.132587ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:44.174541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:43.614151Z","time spent":"560.355002ms","remote":"127.0.0.1:37808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T02:10:44.174587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:43.639968Z","time spent":"534.599628ms","remote":"127.0.0.1:37808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T02:10:44.174649Z","caller":"traceutil/trace.go:171","msg":"trace[1953266820] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"556.451917ms","start":"2026-06-26T02:10:43.618184Z","end":"2026-06-26T02:10:44.174636Z","steps":["trace[1953266820] 'process raft request' (duration: 555.663521ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:44.174658Z","caller":"traceutil/trace.go:171","msg":"trace[1017252953] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"558.393059ms","start":"2026-06-26T02:10:43.616226Z","end":"2026-06-26T02:10:44.174619Z","steps":["trace[1017252953] 'process raft request' (duration: 557.582102ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:44.174713Z","caller":"traceutil/trace.go:171","msg":"trace[712371875] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"525.192271ms","start":"2026-06-26T02:10:43.649511Z","end":"2026-06-26T02:10:44.174704Z","steps":["trace[712371875] 'process raft request' (duration: 524.68895ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:44.174726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:43.618173Z","time spent":"556.520969ms","remote":"127.0.0.1:37808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T02:10:44.174759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:43.649495Z","time spent":"525.245372ms","remote":"127.0.0.1:37808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T02:10:44.174765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:43.616206Z","time spent":"558.506561ms","remote":"127.0.0.1:37808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T02:10:44.174592Z","caller":"traceutil/trace.go:171","msg":"trace[984325550] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"551.57749ms","start":"2026-06-26T02:10:43.622993Z","end":"2026-06-26T02:10:44.17457Z","steps":["trace[984325550] 'process raft request' (duration: 551.080349ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:44.175281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:43.622985Z","time spent":"552.170272ms","remote":"127.0.0.1:37808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T02:10:44.190198Z","caller":"traceutil/trace.go:171","msg":"trace[522738186] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"414.316687ms","start":"2026-06-26T02:10:43.775865Z","end":"2026-06-26T02:10:44.190182Z","steps":["trace[522738186] 'process raft request' (duration: 414.148893ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:44.190298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:43.775816Z","time spent":"414.43466ms","remote":"127.0.0.1:37808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T02:10:44.190361Z","caller":"traceutil/trace.go:171","msg":"trace[2139826656] linearizableReadLoop","detail":"{readStateIndex:562; appliedIndex:550; }","duration":"454.741484ms","start":"2026-06-26T02:10:43.73561Z","end":"2026-06-26T02:10:44.190352Z","steps":["trace[2139826656] 'read index received' (duration: 437.921739ms)","trace[2139826656] 'applied index is now lower than readState.Index' (duration: 16.818675ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:10:44.190452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.834196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-26T02:10:44.190472Z","caller":"traceutil/trace.go:171","msg":"trace[657375102] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:543; }","duration":"454.894087ms","start":"2026-06-26T02:10:43.735573Z","end":"2026-06-26T02:10:44.190467Z","steps":["trace[657375102] 'agreement among raft nodes before linearized reading' (duration: 454.812885ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:44.190488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:43.735557Z","time spent":"454.928298ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-26T02:10:46.333479Z","caller":"traceutil/trace.go:171","msg":"trace[187548828] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"116.252831ms","start":"2026-06-26T02:10:46.217202Z","end":"2026-06-26T02:10:46.333455Z","steps":["trace[187548828] 'process raft request' (duration: 116.130788ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:51.260546Z","caller":"traceutil/trace.go:171","msg":"trace[2107563071] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:666; }","duration":"359.227908ms","start":"2026-06-26T02:10:50.901266Z","end":"2026-06-26T02:10:51.260493Z","steps":["trace[2107563071] 'read index received' (duration: 357.204227ms)","trace[2107563071] 'applied index is now lower than readState.Index' (duration: 2.022531ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:10:51.260616Z","caller":"traceutil/trace.go:171","msg":"trace[823095279] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"513.3215ms","start":"2026-06-26T02:10:50.74725Z","end":"2026-06-26T02:10:51.260571Z","steps":["trace[823095279] 'process raft request' (duration: 512.051524ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:51.260986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.596566ms","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-06-26T02:10:51.261047Z","caller":"traceutil/trace.go:171","msg":"trace[952887775] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:643; }","duration":"359.854071ms","start":"2026-06-26T02:10:50.90118Z","end":"2026-06-26T02:10:51.261035Z","steps":["trace[952887775] 'agreement among raft nodes before linearized reading' (duration: 359.463883ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:51.261081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:50.901139Z","time spent":"359.934493ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-26T02:10:51.261148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:50.747216Z","time spent":"513.79286ms","remote":"127.0.0.1:37858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:10:51.435123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.27823ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T02:10:51.435243Z","caller":"traceutil/trace.go:171","msg":"trace[485711527] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:667; }","duration":"114.104488ms","start":"2026-06-26T02:10:51.321122Z","end":"2026-06-26T02:10:51.435226Z","steps":["trace[485711527] 'read index received' (duration: 42.341µs)","trace[485711527] 'applied index is now lower than readState.Index' (duration: 114.061007ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:10:51.435391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.267021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-2gcbw\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-26T02:10:51.435431Z","caller":"traceutil/trace.go:171","msg":"trace[242464811] range","detail":"{range_begin:/registry/pods/kube-system/cilium-2gcbw; range_end:; response_count:1; response_revision:644; }","duration":"114.346113ms","start":"2026-06-26T02:10:51.321073Z","end":"2026-06-26T02:10:51.435419Z","steps":["trace[242464811] 'agreement among raft nodes before linearized reading' (duration: 114.1994ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:51.435426Z","caller":"traceutil/trace.go:171","msg":"trace[997318306] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"169.398386ms","start":"2026-06-26T02:10:51.266007Z","end":"2026-06-26T02:10:51.435405Z","steps":["trace[997318306] 'process raft request' (duration: 31.754048ms)","trace[997318306] 'compare' (duration: 137.173398ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:10:51.94997Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1223746553373987160,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:10:53.450045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000507621s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-26T02:10:53.450139Z","caller":"traceutil/trace.go:171","msg":"trace[754679486] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000642024s","start":"2026-06-26T02:10:51.449475Z","end":"2026-06-26T02:10:53.450117Z","steps":["trace[754679486] 'agreement among raft nodes before linearized reading' (duration: 2.000543722s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:53.450391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:51.449451Z","time spent":"2.000924209s","remote":"127.0.0.1:37758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/26 02:10:53 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-26T02:10:53.509429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.458835888s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-26T02:10:53.509833Z","caller":"traceutil/trace.go:171","msg":"trace[808217361] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"2.177270507s","start":"2026-06-26T02:10:51.332519Z","end":"2026-06-26T02:10:53.509789Z","steps":["trace[808217361] 'process raft request' (duration: 718.028032ms)","trace[808217361] 'compare' (duration: 1.457837018s)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:10:53.509928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:51.332489Z","time spent":"2.177402779s","remote":"127.0.0.1:37998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T02:10:53.511511Z","caller":"traceutil/trace.go:171","msg":"trace[275826415] linearizableReadLoop","detail":"{readStateIndex:670; appliedIndex:668; }","duration":"2.061964424s","start":"2026-06-26T02:10:51.449521Z","end":"2026-06-26T02:10:53.511486Z","steps":["trace[275826415] 'read index received' (duration: 601.125186ms)","trace[275826415] 'applied index is now lower than readState.Index' (duration: 1.460837298s)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:10:53.511528Z","caller":"traceutil/trace.go:171","msg":"trace[1449747919] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"2.061148517s","start":"2026-06-26T02:10:51.450309Z","end":"2026-06-26T02:10:53.511457Z","steps":["trace[1449747919] 'process raft request' (duration: 2.060027795s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:53.511728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:51.45028Z","time spent":"2.061351931s","remote":"127.0.0.1:37956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:10:54.171092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.604257ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-26T02:10:54.17125Z","caller":"traceutil/trace.go:171","msg":"trace[223255233] linearizableReadLoop","detail":"{readStateIndex:671; appliedIndex:670; }","duration":"659.672928ms","start":"2026-06-26T02:10:53.511552Z","end":"2026-06-26T02:10:54.171225Z","steps":["trace[223255233] 'read index received' (duration: 35.781µs)","trace[223255233] 'applied index is now lower than readState.Index' (duration: 659.635057ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:10:54.17142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"754.183054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T02:10:54.171401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"731.10444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-26T02:10:54.17143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.125461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:10:54.171491Z","caller":"traceutil/trace.go:171","msg":"trace[84755165] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:646; }","duration":"731.229513ms","start":"2026-06-26T02:10:53.440239Z","end":"2026-06-26T02:10:54.171468Z","steps":["trace[84755165] 'agreement among raft nodes before linearized reading' (duration: 730.991649ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:54.171543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:53.440218Z","time spent":"731.316564ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-26T02:10:54.17154Z","caller":"traceutil/trace.go:171","msg":"trace[2017889623] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:646; }","duration":"721.277944ms","start":"2026-06-26T02:10:53.450235Z","end":"2026-06-26T02:10:54.171513Z","steps":["trace[2017889623] 'agreement among raft nodes before linearized reading' (duration: 721.07407ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:54.171589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:53.450223Z","time spent":"721.358115ms","remote":"127.0.0.1:37766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T02:10:54.171652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.508895167s","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-06-26T02:10:54.171686Z","caller":"traceutil/trace.go:171","msg":"trace[2088572706] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:646; }","duration":"1.508963918s","start":"2026-06-26T02:10:52.662713Z","end":"2026-06-26T02:10:54.171677Z","steps":["trace[2088572706] 'agreement among raft nodes before linearized reading' (duration: 1.508791465s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:54.17168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.42989167s","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-06-26T02:10:54.171727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:52.662693Z","time spent":"1.509025579s","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-26T02:10:54.171731Z","caller":"traceutil/trace.go:171","msg":"trace[469059251] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:646; }","duration":"2.429994472s","start":"2026-06-26T02:10:51.741721Z","end":"2026-06-26T02:10:54.171715Z","steps":["trace[469059251] 'agreement among raft nodes before linearized reading' (duration: 2.429853629s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:54.171772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:51.741701Z","time spent":"2.430063153s","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-26T02:10:54.171483Z","caller":"traceutil/trace.go:171","msg":"trace[612078387] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:646; }","duration":"754.286696ms","start":"2026-06-26T02:10:53.417161Z","end":"2026-06-26T02:10:54.171447Z","steps":["trace[612078387] 'agreement among raft nodes before linearized reading' (duration: 754.189444ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:54.171883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:53.417118Z","time spent":"754.752735ms","remote":"127.0.0.1:37758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T02:10:54.17196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.809917114s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-26T02:10:54.171992Z","caller":"traceutil/trace.go:171","msg":"trace[652444022] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:646; }","duration":"1.810003685s","start":"2026-06-26T02:10:52.361979Z","end":"2026-06-26T02:10:54.171983Z","steps":["trace[652444022] 'agreement among raft nodes before linearized reading' (duration: 1.809917164s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:54.17202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:52.361958Z","time spent":"1.810056217s","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-26T02:10:54.172186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"657.804821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-06-26T02:10:54.172213Z","caller":"traceutil/trace.go:171","msg":"trace[1728145719] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:646; }","duration":"657.868412ms","start":"2026-06-26T02:10:53.514336Z","end":"2026-06-26T02:10:54.172205Z","steps":["trace[1728145719] 'agreement among raft nodes before linearized reading' (duration: 657.783ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:10:54.172239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:10:53.514314Z","time spent":"657.919543ms","remote":"127.0.0.1:37964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"info","ts":"2026-06-26T02:10:54.293096Z","caller":"traceutil/trace.go:171","msg":"trace[656032097] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"116.981256ms","start":"2026-06-26T02:10:54.176087Z","end":"2026-06-26T02:10:54.293068Z","steps":["trace[656032097] 'process raft request' (duration: 116.787972ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:54.312298Z","caller":"traceutil/trace.go:171","msg":"trace[581664212] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"135.687658ms","start":"2026-06-26T02:10:54.176584Z","end":"2026-06-26T02:10:54.312272Z","steps":["trace[581664212] 'process raft request' (duration: 135.594726ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:54.312289Z","caller":"traceutil/trace.go:171","msg":"trace[737910202] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"135.78362ms","start":"2026-06-26T02:10:54.176468Z","end":"2026-06-26T02:10:54.312251Z","steps":["trace[737910202] 'process raft request' (duration: 135.557215ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:54.312518Z","caller":"traceutil/trace.go:171","msg":"trace[2006405199] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"134.989124ms","start":"2026-06-26T02:10:54.177419Z","end":"2026-06-26T02:10:54.312408Z","steps":["trace[2006405199] 'process raft request' (duration: 134.81526ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:54.312624Z","caller":"traceutil/trace.go:171","msg":"trace[1381120264] linearizableReadLoop","detail":"{readStateIndex:675; appliedIndex:671; }","duration":"134.708278ms","start":"2026-06-26T02:10:54.177903Z","end":"2026-06-26T02:10:54.312611Z","steps":["trace[1381120264] 'read index received' (duration: 115.118998ms)","trace[1381120264] 'applied index is now lower than readState.Index' (duration: 19.58807ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:10:54.312727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.80394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-06-26T02:10:54.312768Z","caller":"traceutil/trace.go:171","msg":"trace[1496838752] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:651; }","duration":"134.882892ms","start":"2026-06-26T02:10:54.177868Z","end":"2026-06-26T02:10:54.312751Z","steps":["trace[1496838752] 'agreement among raft nodes before linearized reading' (duration: 134.78996ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:54.312764Z","caller":"traceutil/trace.go:171","msg":"trace[507456664] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"134.649187ms","start":"2026-06-26T02:10:54.178106Z","end":"2026-06-26T02:10:54.312755Z","steps":["trace[507456664] 'process raft request' (duration: 134.257599ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:10:59.65417Z","caller":"traceutil/trace.go:171","msg":"trace[217230024] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"175.367283ms","start":"2026-06-26T02:10:59.478775Z","end":"2026-06-26T02:10:59.654143Z","steps":["trace[217230024] 'process raft request' (duration: 174.859643ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:00.454692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.417979ms","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-06-26T02:11:00.454805Z","caller":"traceutil/trace.go:171","msg":"trace[1962601762] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:734; }","duration":"117.551972ms","start":"2026-06-26T02:11:00.337226Z","end":"2026-06-26T02:11:00.454778Z","steps":["trace[1962601762] 'agreement among raft nodes before linearized reading' (duration: 117.317948ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:00.454898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.179687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-26T02:11:00.455139Z","caller":"traceutil/trace.go:171","msg":"trace[662807264] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:734; }","duration":"116.567804ms","start":"2026-06-26T02:11:00.338517Z","end":"2026-06-26T02:11:00.455085Z","steps":["trace[662807264] 'agreement among raft nodes before linearized reading' (duration: 116.010474ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:00.561326Z","caller":"traceutil/trace.go:171","msg":"trace[533305879] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"155.242686ms","start":"2026-06-26T02:11:00.406046Z","end":"2026-06-26T02:11:00.561288Z","steps":["trace[533305879] 'process raft request' (duration: 106.28763ms)","trace[533305879] 'compare' (duration: 48.710101ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:11:00.561545Z","caller":"traceutil/trace.go:171","msg":"trace[1883340410] linearizableReadLoop","detail":"{readStateIndex:761; appliedIndex:760; }","duration":"106.768289ms","start":"2026-06-26T02:11:00.454397Z","end":"2026-06-26T02:11:00.561165Z","steps":["trace[1883340410] 'read index received' (duration: 58.010257ms)","trace[1883340410] 'applied index is now lower than readState.Index' (duration: 48.756852ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:11:00.561548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.312645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:11:00.561771Z","caller":"traceutil/trace.go:171","msg":"trace[427528062] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:735; }","duration":"111.583389ms","start":"2026-06-26T02:11:00.45017Z","end":"2026-06-26T02:11:00.561753Z","steps":["trace[427528062] 'agreement among raft nodes before linearized reading' (duration: 111.306454ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:00.60236Z","caller":"traceutil/trace.go:171","msg":"trace[1730489676] transaction","detail":"{read_only:false; response_revision:736; number_of_response:1; }","duration":"142.544005ms","start":"2026-06-26T02:11:00.459766Z","end":"2026-06-26T02:11:00.60231Z","steps":["trace[1730489676] 'process raft request' (duration: 142.023985ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:00.60254Z","caller":"traceutil/trace.go:171","msg":"trace[312317795] transaction","detail":"{read_only:false; response_revision:737; number_of_response:1; }","duration":"142.301769ms","start":"2026-06-26T02:11:00.46023Z","end":"2026-06-26T02:11:00.602532Z","steps":["trace[312317795] 'process raft request' (duration: 141.700117ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:00.602982Z","caller":"traceutil/trace.go:171","msg":"trace[1346395214] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"121.391725ms","start":"2026-06-26T02:11:00.481557Z","end":"2026-06-26T02:11:00.602949Z","steps":["trace[1346395214] 'process raft request' (duration: 120.471487ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:00.603097Z","caller":"traceutil/trace.go:171","msg":"trace[1112655642] transaction","detail":"{read_only:false; response_revision:738; number_of_response:1; }","duration":"134.995723ms","start":"2026-06-26T02:11:00.468081Z","end":"2026-06-26T02:11:00.603077Z","steps":["trace[1112655642] 'process raft request' (duration: 133.887501ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:06.552553Z","caller":"traceutil/trace.go:171","msg":"trace[1772211759] transaction","detail":"{read_only:false; response_revision:769; number_of_response:1; }","duration":"142.301593ms","start":"2026-06-26T02:11:06.410232Z","end":"2026-06-26T02:11:06.552533Z","steps":["trace[1772211759] 'process raft request' (duration: 142.171191ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:06.552719Z","caller":"traceutil/trace.go:171","msg":"trace[117973722] linearizableReadLoop","detail":"{readStateIndex:797; appliedIndex:795; }","duration":"127.084939ms","start":"2026-06-26T02:11:06.425414Z","end":"2026-06-26T02:11:06.552498Z","steps":["trace[117973722] 'read index received' (duration: 71.610931ms)","trace[117973722] 'applied index is now lower than readState.Index' (duration: 55.472938ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:11:06.552998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.563288ms","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-06-26T02:11:06.553108Z","caller":"traceutil/trace.go:171","msg":"trace[1252812094] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:769; }","duration":"127.67385ms","start":"2026-06-26T02:11:06.425386Z","end":"2026-06-26T02:11:06.55306Z","steps":["trace[1252812094] 'agreement among raft nodes before linearized reading' (duration: 127.329263ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:06.579537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.61525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-26T02:11:06.579583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.782865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:11:06.579645Z","caller":"traceutil/trace.go:171","msg":"trace[1232901591] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:772; }","duration":"131.856835ms","start":"2026-06-26T02:11:06.447752Z","end":"2026-06-26T02:11:06.579608Z","steps":["trace[1232901591] 'agreement among raft nodes before linearized reading' (duration: 131.802274ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:06.579608Z","caller":"traceutil/trace.go:171","msg":"trace[358290365] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:772; }","duration":"152.696871ms","start":"2026-06-26T02:11:06.426895Z","end":"2026-06-26T02:11:06.579592Z","steps":["trace[358290365] 'agreement among raft nodes before linearized reading' (duration: 152.571949ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:09.026938Z","caller":"traceutil/trace.go:171","msg":"trace[64881571] linearizableReadLoop","detail":"{readStateIndex:829; appliedIndex:828; }","duration":"243.511356ms","start":"2026-06-26T02:11:08.783408Z","end":"2026-06-26T02:11:09.026919Z","steps":["trace[64881571] 'read index received' (duration: 243.326283ms)","trace[64881571] 'applied index is now lower than readState.Index' (duration: 184.113µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:11:09.027032Z","caller":"traceutil/trace.go:171","msg":"trace[1337509548] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"329.41369ms","start":"2026-06-26T02:11:08.697611Z","end":"2026-06-26T02:11:09.027025Z","steps":["trace[1337509548] 'process raft request' (duration: 329.187616ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:09.027129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:08.697591Z","time spent":"329.461712ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:11:09.027317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.75031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-26T02:11:09.027454Z","caller":"traceutil/trace.go:171","msg":"trace[1060114622] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:800; }","duration":"239.955243ms","start":"2026-06-26T02:11:08.787481Z","end":"2026-06-26T02:11:09.027436Z","steps":["trace[1060114622] 'agreement among raft nodes before linearized reading' (duration: 239.641918ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:09.027524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.102326ms","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-06-26T02:11:09.027606Z","caller":"traceutil/trace.go:171","msg":"trace[1178624103] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:800; }","duration":"244.222309ms","start":"2026-06-26T02:11:08.783365Z","end":"2026-06-26T02:11:09.027587Z","steps":["trace[1178624103] 'agreement among raft nodes before linearized reading' (duration: 243.959564ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:10.236026Z","caller":"traceutil/trace.go:171","msg":"trace[2109723556] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"151.71758ms","start":"2026-06-26T02:11:10.084279Z","end":"2026-06-26T02:11:10.235997Z","steps":["trace[2109723556] 'process raft request' (duration: 151.456025ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:11.949337Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1223746553373987496,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-26T02:11:12.40241Z","caller":"traceutil/trace.go:171","msg":"trace[1634382583] linearizableReadLoop","detail":"{readStateIndex:848; appliedIndex:847; }","duration":"953.342458ms","start":"2026-06-26T02:11:11.44903Z","end":"2026-06-26T02:11:12.402372Z","steps":["trace[1634382583] 'read index received' (duration: 952.848889ms)","trace[1634382583] 'applied index is now lower than readState.Index' (duration: 491.859µs)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:11:12.4027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"953.595512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:11:12.402831Z","caller":"traceutil/trace.go:171","msg":"trace[1061267037] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:818; }","duration":"953.828697ms","start":"2026-06-26T02:11:11.448984Z","end":"2026-06-26T02:11:12.402812Z","steps":["trace[1061267037] 'agreement among raft nodes before linearized reading' (duration: 953.573212ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:12.402494Z","caller":"traceutil/trace.go:171","msg":"trace[1873082624] transaction","detail":"{read_only:false; response_revision:818; number_of_response:1; }","duration":"975.32079ms","start":"2026-06-26T02:11:11.427131Z","end":"2026-06-26T02:11:12.402452Z","steps":["trace[1873082624] 'process raft request' (duration: 974.923832ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:12.403163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:11.427101Z","time spent":"975.96433ms","remote":"127.0.0.1:37956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:11:12.402931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:11.448966Z","time spent":"953.948288ms","remote":"127.0.0.1:37758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T02:11:12.402852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.906904ms","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-06-26T02:11:12.403697Z","caller":"traceutil/trace.go:171","msg":"trace[987388668] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:818; }","duration":"163.782398ms","start":"2026-06-26T02:11:12.239888Z","end":"2026-06-26T02:11:12.403671Z","steps":["trace[987388668] 'agreement among raft nodes before linearized reading' (duration: 162.779841ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:26.865375Z","caller":"traceutil/trace.go:171","msg":"trace[1646338149] linearizableReadLoop","detail":"{readStateIndex:1007; appliedIndex:1006; }","duration":"415.458939ms","start":"2026-06-26T02:11:26.44989Z","end":"2026-06-26T02:11:26.865349Z","steps":["trace[1646338149] 'read index received' (duration: 415.292997ms)","trace[1646338149] 'applied index is now lower than readState.Index' (duration: 164.912µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:11:26.86543Z","caller":"traceutil/trace.go:171","msg":"trace[1149445216] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"431.816544ms","start":"2026-06-26T02:11:26.433578Z","end":"2026-06-26T02:11:26.865395Z","steps":["trace[1149445216] 'process raft request' (duration: 431.610661ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:26.865613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:26.433556Z","time spent":"431.959887ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:11:26.865664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.290495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-06-26T02:11:26.865711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.842491ms","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-06-26T02:11:26.865755Z","caller":"traceutil/trace.go:171","msg":"trace[274214628] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:974; }","duration":"121.922322ms","start":"2026-06-26T02:11:26.743821Z","end":"2026-06-26T02:11:26.865743Z","steps":["trace[274214628] 'agreement among raft nodes before linearized reading' (duration: 121.775199ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:26.865756Z","caller":"traceutil/trace.go:171","msg":"trace[1519636868] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:974; }","duration":"347.393818ms","start":"2026-06-26T02:11:26.518343Z","end":"2026-06-26T02:11:26.865737Z","steps":["trace[1519636868] 'agreement among raft nodes before linearized reading' (duration: 347.176634ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:26.865856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:26.518309Z","time spent":"347.534251ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-26T02:11:26.865553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.639192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:11:26.865935Z","caller":"traceutil/trace.go:171","msg":"trace[1784778671] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:974; }","duration":"416.040029ms","start":"2026-06-26T02:11:26.449885Z","end":"2026-06-26T02:11:26.865925Z","steps":["trace[1784778671] 'agreement among raft nodes before linearized reading' (duration: 415.616531ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:26.86597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:26.449826Z","time spent":"416.1343ms","remote":"127.0.0.1:37758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-26T02:11:27.044214Z","caller":"traceutil/trace.go:171","msg":"trace[458793265] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"172.521026ms","start":"2026-06-26T02:11:26.871648Z","end":"2026-06-26T02:11:27.044169Z","steps":["trace[458793265] 'process raft request' (duration: 120.074892ms)","trace[458793265] 'compare' (duration: 52.2208ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:11:27.338911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.030889ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T02:11:27.339248Z","caller":"traceutil/trace.go:171","msg":"trace[994059939] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"466.894548ms","start":"2026-06-26T02:11:26.872311Z","end":"2026-06-26T02:11:27.339205Z","steps":["trace[994059939] 'process raft request' (duration: 335.37997ms)","trace[994059939] 'compare' (duration: 130.210797ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:11:27.33946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:26.872293Z","time spent":"467.04672ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:11:27.339496Z","caller":"traceutil/trace.go:171","msg":"trace[1036010852] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"463.580147ms","start":"2026-06-26T02:11:26.875878Z","end":"2026-06-26T02:11:27.339458Z","steps":["trace[1036010852] 'process raft request' (duration: 463.248262ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:27.339686Z","caller":"traceutil/trace.go:171","msg":"trace[757323280] linearizableReadLoop","detail":"{readStateIndex:1011; appliedIndex:1008; }","duration":"194.489184ms","start":"2026-06-26T02:11:27.145173Z","end":"2026-06-26T02:11:27.339663Z","steps":["trace[757323280] 'read index received' (duration: 62.443748ms)","trace[757323280] 'applied index is now lower than readState.Index' (duration: 132.043936ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:11:27.339709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:26.875869Z","time spent":"463.742629ms","remote":"127.0.0.1:37956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5472,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:11:27.339758Z","caller":"traceutil/trace.go:171","msg":"trace[498359721] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"451.348124ms","start":"2026-06-26T02:11:26.888342Z","end":"2026-06-26T02:11:27.33969Z","steps":["trace[498359721] 'process raft request' (duration: 450.935828ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:27.339936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.743078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-26T02:11:27.340015Z","caller":"traceutil/trace.go:171","msg":"trace[514760823] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:978; }","duration":"194.903141ms","start":"2026-06-26T02:11:27.145092Z","end":"2026-06-26T02:11:27.339995Z","steps":["trace[514760823] 'agreement among raft nodes before linearized reading' (duration: 194.665277ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:27.340027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.86895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-06-26T02:11:27.340061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.175427ms","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-06-26T02:11:27.340081Z","caller":"traceutil/trace.go:171","msg":"trace[1524223356] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:978; }","duration":"165.951991ms","start":"2026-06-26T02:11:27.174114Z","end":"2026-06-26T02:11:27.340066Z","steps":["trace[1524223356] 'agreement among raft nodes before linearized reading' (duration: 165.702807ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:27.340115Z","caller":"traceutil/trace.go:171","msg":"trace[1605278841] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:978; }","duration":"181.257058ms","start":"2026-06-26T02:11:27.158841Z","end":"2026-06-26T02:11:27.340098Z","steps":["trace[1605278841] 'agreement among raft nodes before linearized reading' (duration: 181.043595ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:27.34055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.580309ms","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-06-26T02:11:27.340599Z","caller":"traceutil/trace.go:171","msg":"trace[1969515730] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:978; }","duration":"193.667271ms","start":"2026-06-26T02:11:27.146916Z","end":"2026-06-26T02:11:27.340583Z","steps":["trace[1969515730] 'agreement among raft nodes before linearized reading' (duration: 192.886839ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:27.341536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:11:26.888303Z","time spent":"451.642119ms","remote":"127.0.0.1:37836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":811,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T02:11:27.568895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.960175ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T02:11:27.56913Z","caller":"traceutil/trace.go:171","msg":"trace[1011155911] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"225.382132ms","start":"2026-06-26T02:11:27.343724Z","end":"2026-06-26T02:11:27.569106Z","steps":["trace[1011155911] 'process raft request' (duration: 111.093832ms)","trace[1011155911] 'compare' (duration: 113.804742ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:11:27.572853Z","caller":"traceutil/trace.go:171","msg":"trace[957719609] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"227.994272ms","start":"2026-06-26T02:11:27.344838Z","end":"2026-06-26T02:11:27.572832Z","steps":["trace[957719609] 'process raft request' (duration: 227.840979ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:27.573248Z","caller":"traceutil/trace.go:171","msg":"trace[609838556] linearizableReadLoop","detail":"{readStateIndex:1017; appliedIndex:1011; }","duration":"121.518242ms","start":"2026-06-26T02:11:27.451718Z","end":"2026-06-26T02:11:27.573236Z","steps":["trace[609838556] 'read index received' (duration: 3.087627ms)","trace[609838556] 'applied index is now lower than readState.Index' (duration: 118.429615ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:11:27.573291Z","caller":"traceutil/trace.go:171","msg":"trace[6363106] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"227.189169ms","start":"2026-06-26T02:11:27.34607Z","end":"2026-06-26T02:11:27.573259Z","steps":["trace[6363106] 'process raft request' (duration: 227.044667ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:27.573499Z","caller":"traceutil/trace.go:171","msg":"trace[900222724] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"225.94755ms","start":"2026-06-26T02:11:27.347511Z","end":"2026-06-26T02:11:27.573459Z","steps":["trace[900222724] 'process raft request' (duration: 225.642386ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:27.573816Z","caller":"traceutil/trace.go:171","msg":"trace[1145119262] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"225.792317ms","start":"2026-06-26T02:11:27.348007Z","end":"2026-06-26T02:11:27.573799Z","steps":["trace[1145119262] 'process raft request' (duration: 225.194448ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:27.573907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.173482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:11:27.57517Z","caller":"traceutil/trace.go:171","msg":"trace[585906043] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:984; }","duration":"123.523974ms","start":"2026-06-26T02:11:27.451631Z","end":"2026-06-26T02:11:27.575155Z","steps":["trace[585906043] 'agreement among raft nodes before linearized reading' (duration: 122.164412ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:27.57602Z","caller":"traceutil/trace.go:171","msg":"trace[1843008690] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"230.220627ms","start":"2026-06-26T02:11:27.345782Z","end":"2026-06-26T02:11:27.576003Z","steps":["trace[1843008690] 'process raft request' (duration: 227.013627ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:51.36701Z","caller":"traceutil/trace.go:171","msg":"trace[1644325869] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"143.457102ms","start":"2026-06-26T02:11:51.223529Z","end":"2026-06-26T02:11:51.366986Z","steps":["trace[1644325869] 'process raft request' (duration: 143.3138ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:51.943961Z","caller":"traceutil/trace.go:171","msg":"trace[297660919] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"114.799395ms","start":"2026-06-26T02:11:51.829136Z","end":"2026-06-26T02:11:51.943936Z","steps":["trace[297660919] 'process raft request' (duration: 26.731309ms)","trace[297660919] 'compare' (duration: 87.796843ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:11:51.944367Z","caller":"traceutil/trace.go:171","msg":"trace[1816919198] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"113.860484ms","start":"2026-06-26T02:11:51.830499Z","end":"2026-06-26T02:11:51.94436Z","steps":["trace[1816919198] 'process raft request' (duration: 113.833694ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:51.944502Z","caller":"traceutil/trace.go:171","msg":"trace[827117914] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"115.067069ms","start":"2026-06-26T02:11:51.829393Z","end":"2026-06-26T02:11:51.94446Z","steps":["trace[827117914] 'process raft request' (duration: 114.490492ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:53.542745Z","caller":"traceutil/trace.go:171","msg":"trace[1213267772] linearizableReadLoop","detail":"{readStateIndex:1123; appliedIndex:1122; }","duration":"125.850767ms","start":"2026-06-26T02:11:53.416871Z","end":"2026-06-26T02:11:53.542722Z","steps":["trace[1213267772] 'read index received' (duration: 125.651394ms)","trace[1213267772] 'applied index is now lower than readState.Index' (duration: 198.283µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:11:53.542797Z","caller":"traceutil/trace.go:171","msg":"trace[2024904348] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"168.395854ms","start":"2026-06-26T02:11:53.374373Z","end":"2026-06-26T02:11:53.542768Z","steps":["trace[2024904348] 'process raft request' (duration: 168.206702ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:53.542879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.986318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:11:53.542952Z","caller":"traceutil/trace.go:171","msg":"trace[462774235] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1083; }","duration":"126.101092ms","start":"2026-06-26T02:11:53.416826Z","end":"2026-06-26T02:11:53.542927Z","steps":["trace[462774235] 'agreement among raft nodes before linearized reading' (duration: 125.97854ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:57.659586Z","caller":"traceutil/trace.go:171","msg":"trace[1457898256] linearizableReadLoop","detail":"{readStateIndex:1137; appliedIndex:1135; }","duration":"104.014199ms","start":"2026-06-26T02:11:57.555551Z","end":"2026-06-26T02:11:57.659566Z","steps":["trace[1457898256] 'read index received' (duration: 102.682432ms)","trace[1457898256] 'applied index is now lower than readState.Index' (duration: 1.330787ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:11:57.659697Z","caller":"traceutil/trace.go:171","msg":"trace[1299239086] transaction","detail":"{read_only:false; response_revision:1095; number_of_response:1; }","duration":"131.507669ms","start":"2026-06-26T02:11:57.528179Z","end":"2026-06-26T02:11:57.659687Z","steps":["trace[1299239086] 'process raft request' (duration: 130.042581ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:11:57.659957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.382943ms","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-06-26T02:11:57.660027Z","caller":"traceutil/trace.go:171","msg":"trace[189223200] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1096; }","duration":"104.483675ms","start":"2026-06-26T02:11:57.555525Z","end":"2026-06-26T02:11:57.660009Z","steps":["trace[189223200] 'agreement among raft nodes before linearized reading' (duration: 104.264562ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:11:57.660043Z","caller":"traceutil/trace.go:171","msg":"trace[725627385] transaction","detail":"{read_only:false; response_revision:1096; number_of_response:1; }","duration":"109.390459ms","start":"2026-06-26T02:11:57.550605Z","end":"2026-06-26T02:11:57.659995Z","steps":["trace[725627385] 'process raft request' (duration: 108.907933ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:12:34.492311Z","caller":"traceutil/trace.go:171","msg":"trace[1407150437] linearizableReadLoop","detail":"{readStateIndex:1265; appliedIndex:1264; }","duration":"240.868112ms","start":"2026-06-26T02:12:34.25141Z","end":"2026-06-26T02:12:34.492278Z","steps":["trace[1407150437] 'read index received' (duration: 240.68387ms)","trace[1407150437] 'applied index is now lower than readState.Index' (duration: 182.912µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:12:34.492438Z","caller":"traceutil/trace.go:171","msg":"trace[1354375096] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"428.947356ms","start":"2026-06-26T02:12:34.063456Z","end":"2026-06-26T02:12:34.492404Z","steps":["trace[1354375096] 'process raft request' (duration: 428.638983ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:34.492588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:12:34.063436Z","time spent":"429.066478ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:12:34.49263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.191986ms","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-06-26T02:12:34.492672Z","caller":"traceutil/trace.go:171","msg":"trace[1102115909] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1217; }","duration":"241.291946ms","start":"2026-06-26T02:12:34.251366Z","end":"2026-06-26T02:12:34.492658Z","steps":["trace[1102115909] 'agreement among raft nodes before linearized reading' (duration: 241.106854ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:34.492862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.909891ms","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-06-26T02:12:34.49295Z","caller":"traceutil/trace.go:171","msg":"trace[1538599123] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1217; }","duration":"202.032063ms","start":"2026-06-26T02:12:34.290899Z","end":"2026-06-26T02:12:34.492931Z","steps":["trace[1538599123] 'agreement among raft nodes before linearized reading' (duration: 201.793761ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:34.49345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.415297ms","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-06-26T02:12:34.493493Z","caller":"traceutil/trace.go:171","msg":"trace[972242857] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1217; }","duration":"217.603069ms","start":"2026-06-26T02:12:34.275878Z","end":"2026-06-26T02:12:34.493482Z","steps":["trace[972242857] 'agreement among raft nodes before linearized reading' (duration: 216.652228ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:12:36.002144Z","caller":"traceutil/trace.go:171","msg":"trace[1582159810] linearizableReadLoop","detail":"{readStateIndex:1269; appliedIndex:1268; }","duration":"101.022858ms","start":"2026-06-26T02:12:35.901097Z","end":"2026-06-26T02:12:36.00212Z","steps":["trace[1582159810] 'read index received' (duration: 100.840596ms)","trace[1582159810] 'applied index is now lower than readState.Index' (duration: 181.242µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:12:36.00224Z","caller":"traceutil/trace.go:171","msg":"trace[1866812984] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"105.149404ms","start":"2026-06-26T02:12:35.897056Z","end":"2026-06-26T02:12:36.002205Z","steps":["trace[1866812984] 'process raft request' (duration: 104.927812ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:36.002367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.253471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-26T02:12:36.0024Z","caller":"traceutil/trace.go:171","msg":"trace[103846005] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1221; }","duration":"101.325101ms","start":"2026-06-26T02:12:35.901064Z","end":"2026-06-26T02:12:36.002389Z","steps":["trace[103846005] 'agreement among raft nodes before linearized reading' (duration: 101.150469ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:12:44.751805Z","caller":"traceutil/trace.go:171","msg":"trace[2141099975] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"114.76512ms","start":"2026-06-26T02:12:44.637013Z","end":"2026-06-26T02:12:44.751778Z","steps":["trace[2141099975] 'process raft request' (duration: 104.984462ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:12:46.174293Z","caller":"traceutil/trace.go:171","msg":"trace[1990367807] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"100.042672ms","start":"2026-06-26T02:12:46.074224Z","end":"2026-06-26T02:12:46.174266Z","steps":["trace[1990367807] 'process raft request' (duration: 99.792979ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:12:46.320935Z","caller":"traceutil/trace.go:171","msg":"trace[900475796] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"141.913589ms","start":"2026-06-26T02:12:46.17898Z","end":"2026-06-26T02:12:46.320894Z","steps":["trace[900475796] 'process raft request' (duration: 95.678084ms)","trace[900475796] 'compare' (duration: 46.107504ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:12:46.950372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.010057ms","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-06-26T02:12:46.950443Z","caller":"traceutil/trace.go:171","msg":"trace[842036410] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1256; }","duration":"194.159919ms","start":"2026-06-26T02:12:46.75627Z","end":"2026-06-26T02:12:46.95043Z","steps":["trace[842036410] 'range keys from in-memory index tree' (duration: 193.755135ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:46.950694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.250842ms","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-06-26T02:12:46.950809Z","caller":"traceutil/trace.go:171","msg":"trace[856019315] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1256; }","duration":"130.380643ms","start":"2026-06-26T02:12:46.820402Z","end":"2026-06-26T02:12:46.950783Z","steps":["trace[856019315] 'range keys from in-memory index tree' (duration: 130.046398ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:46.950989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.746907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-26T02:12:46.951089Z","caller":"traceutil/trace.go:171","msg":"trace[1107710214] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1256; }","duration":"141.894078ms","start":"2026-06-26T02:12:46.809171Z","end":"2026-06-26T02:12:46.951065Z","steps":["trace[1107710214] 'range keys from in-memory index tree' (duration: 141.572615ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:12:47.334395Z","caller":"traceutil/trace.go:171","msg":"trace[1591609863] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"379.133919ms","start":"2026-06-26T02:12:46.95524Z","end":"2026-06-26T02:12:47.334374Z","steps":["trace[1591609863] 'process raft request' (duration: 379.017237ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:47.334519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:12:46.955215Z","time spent":"379.23944ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:12:47.372694Z","caller":"traceutil/trace.go:171","msg":"trace[2036303889] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"414.576924ms","start":"2026-06-26T02:12:46.958096Z","end":"2026-06-26T02:12:47.372673Z","steps":["trace[2036303889] 'process raft request' (duration: 414.532083ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:47.372844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:12:46.958091Z","time spent":"414.674185ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:12:47.37328Z","caller":"traceutil/trace.go:171","msg":"trace[1046923355] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"415.21392ms","start":"2026-06-26T02:12:46.958038Z","end":"2026-06-26T02:12:47.373252Z","steps":["trace[1046923355] 'process raft request' (duration: 405.05774ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:12:47.373421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:12:46.95802Z","time spent":"415.324321ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:13:03.577893Z","caller":"traceutil/trace.go:171","msg":"trace[808994832] linearizableReadLoop","detail":"{readStateIndex:1402; appliedIndex:1401; }","duration":"122.066869ms","start":"2026-06-26T02:13:03.455805Z","end":"2026-06-26T02:13:03.577872Z","steps":["trace[808994832] 'read index received' (duration: 122.013429ms)","trace[808994832] 'applied index is now lower than readState.Index' (duration: 52.42µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:13:03.578025Z","caller":"traceutil/trace.go:171","msg":"trace[582267276] transaction","detail":"{read_only:false; response_revision:1346; number_of_response:1; }","duration":"124.784507ms","start":"2026-06-26T02:13:03.453229Z","end":"2026-06-26T02:13:03.578013Z","steps":["trace[582267276] 'process raft request' (duration: 124.512244ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:13:03.578332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.507824ms","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-06-26T02:13:03.578374Z","caller":"traceutil/trace.go:171","msg":"trace[1077309924] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1346; }","duration":"122.563824ms","start":"2026-06-26T02:13:03.4558Z","end":"2026-06-26T02:13:03.578364Z","steps":["trace[1077309924] 'agreement among raft nodes before linearized reading' (duration: 122.400113ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:13:03.578958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.838766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-26T02:13:03.579039Z","caller":"traceutil/trace.go:171","msg":"trace[1642667857] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1346; }","duration":"122.946907ms","start":"2026-06-26T02:13:03.456076Z","end":"2026-06-26T02:13:03.579023Z","steps":["trace[1642667857] 'agreement among raft nodes before linearized reading' (duration: 122.405622ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:13:08.195529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.054201ms","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-06-26T02:13:08.195735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"667.631152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.183\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-26T02:13:08.195777Z","caller":"traceutil/trace.go:171","msg":"trace[898920984] range","detail":"{range_begin:/registry/masterleases/199.19.213.183; range_end:; response_count:1; response_revision:1359; }","duration":"667.710183ms","start":"2026-06-26T02:13:07.528054Z","end":"2026-06-26T02:13:08.195764Z","steps":["trace[898920984] 'range keys from in-memory index tree' (duration: 667.504121ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:13:08.195827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:13:07.528032Z","time spent":"667.778864ms","remote":"127.0.0.1:37802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.183\" "} {"level":"warn","ts":"2026-06-26T02:13:08.195792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.650882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-26T02:13:08.195972Z","caller":"traceutil/trace.go:171","msg":"trace[983023171] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1359; }","duration":"563.901495ms","start":"2026-06-26T02:13:07.63204Z","end":"2026-06-26T02:13:08.195942Z","steps":["trace[983023171] 'range keys from in-memory index tree' (duration: 563.355399ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:13:08.196037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:13:07.632019Z","time spent":"564.004856ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-26T02:13:08.195559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"556.852741ms","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-06-26T02:13:08.196213Z","caller":"traceutil/trace.go:171","msg":"trace[1940848921] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1359; }","duration":"557.542879ms","start":"2026-06-26T02:13:07.638648Z","end":"2026-06-26T02:13:08.196191Z","steps":["trace[1940848921] 'range keys from in-memory index tree' (duration: 556.659789ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:13:08.196286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:13:07.638636Z","time spent":"557.634ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-26T02:13:08.195612Z","caller":"traceutil/trace.go:171","msg":"trace[1691205074] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1359; }","duration":"576.200622ms","start":"2026-06-26T02:13:07.619392Z","end":"2026-06-26T02:13:08.195593Z","steps":["trace[1691205074] 'range keys from in-memory index tree' (duration: 575.847649ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:13:08.196393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:13:07.619371Z","time spent":"577.010262ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-26T02:13:08.39321Z","caller":"traceutil/trace.go:171","msg":"trace[1331250629] transaction","detail":"{read_only:false; response_revision:1360; number_of_response:1; }","duration":"192.297744ms","start":"2026-06-26T02:13:08.200884Z","end":"2026-06-26T02:13:08.393181Z","steps":["trace[1331250629] 'process raft request' (duration: 192.081042ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:13:08.393487Z","caller":"traceutil/trace.go:171","msg":"trace[278985628] transaction","detail":"{read_only:false; response_revision:1361; number_of_response:1; }","duration":"191.698177ms","start":"2026-06-26T02:13:08.201768Z","end":"2026-06-26T02:13:08.393466Z","steps":["trace[278985628] 'process raft request' (duration: 191.369934ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:13:08.393724Z","caller":"traceutil/trace.go:171","msg":"trace[678783243] transaction","detail":"{read_only:false; response_revision:1362; number_of_response:1; }","duration":"191.647247ms","start":"2026-06-26T02:13:08.202041Z","end":"2026-06-26T02:13:08.393689Z","steps":["trace[678783243] 'process raft request' (duration: 191.335614ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:13:08.992404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.903325ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:13:08.992532Z","caller":"traceutil/trace.go:171","msg":"trace[558956469] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1362; }","duration":"502.056216ms","start":"2026-06-26T02:13:08.490458Z","end":"2026-06-26T02:13:08.992514Z","steps":["trace[558956469] 'range keys from in-memory index tree' (duration: 501.881965ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:13:08.993423Z","caller":"traceutil/trace.go:171","msg":"trace[1297803487] linearizableReadLoop","detail":"{readStateIndex:1420; appliedIndex:1416; }","duration":"655.827421ms","start":"2026-06-26T02:13:08.337574Z","end":"2026-06-26T02:13:08.993401Z","steps":["trace[1297803487] 'read index received' (duration: 55.405745ms)","trace[1297803487] 'applied index is now lower than readState.Index' (duration: 600.419596ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:13:08.993543Z","caller":"traceutil/trace.go:171","msg":"trace[1104764255] transaction","detail":"{read_only:false; response_revision:1363; number_of_response:1; }","duration":"681.559437ms","start":"2026-06-26T02:13:08.311969Z","end":"2026-06-26T02:13:08.993528Z","steps":["trace[1104764255] 'process raft request' (duration: 680.296525ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:13:08.993693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:13:08.311948Z","time spent":"681.655678ms","remote":"127.0.0.1:37802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:13:08.993671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"656.100634ms","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-06-26T02:13:08.993885Z","caller":"traceutil/trace.go:171","msg":"trace[1606998313] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1363; }","duration":"656.355686ms","start":"2026-06-26T02:13:08.33752Z","end":"2026-06-26T02:13:08.993876Z","steps":["trace[1606998313] 'agreement among raft nodes before linearized reading' (duration: 656.024833ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:13:08.993914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:13:08.337501Z","time spent":"656.405366ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-26T02:13:09.644435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.063335ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T02:13:09.644616Z","caller":"traceutil/trace.go:171","msg":"trace[778478823] transaction","detail":"{read_only:false; response_revision:1364; number_of_response:1; }","duration":"805.929414ms","start":"2026-06-26T02:13:08.838658Z","end":"2026-06-26T02:13:09.644587Z","steps":["trace[778478823] 'process raft request' (duration: 536.628567ms)","trace[778478823] 'compare' (duration: 268.951224ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:13:09.644761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:13:08.838628Z","time spent":"806.056725ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:13:09.644932Z","caller":"traceutil/trace.go:171","msg":"trace[989051146] linearizableReadLoop","detail":"{readStateIndex:1421; appliedIndex:1420; }","duration":"651.340102ms","start":"2026-06-26T02:13:08.993562Z","end":"2026-06-26T02:13:09.644902Z","steps":["trace[989051146] 'read index received' (duration: 381.739392ms)","trace[989051146] 'applied index is now lower than readState.Index' (duration: 269.59778ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:13:09.644985Z","caller":"traceutil/trace.go:171","msg":"trace[1805079738] transaction","detail":"{read_only:false; response_revision:1366; number_of_response:1; }","duration":"215.270028ms","start":"2026-06-26T02:13:09.429697Z","end":"2026-06-26T02:13:09.644967Z","steps":["trace[1805079738] 'process raft request' (duration: 215.216868ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:13:09.64503Z","caller":"traceutil/trace.go:171","msg":"trace[437967023] transaction","detail":"{read_only:false; response_revision:1365; number_of_response:1; }","duration":"648.175719ms","start":"2026-06-26T02:13:08.996838Z","end":"2026-06-26T02:13:09.645013Z","steps":["trace[437967023] 'process raft request' (duration: 647.701494ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:13:09.64511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:13:08.996821Z","time spent":"648.24534ms","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:13:09.64514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"891.31611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:13:09.645181Z","caller":"traceutil/trace.go:171","msg":"trace[2071005412] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1366; }","duration":"891.39403ms","start":"2026-06-26T02:13:08.753774Z","end":"2026-06-26T02:13:09.645168Z","steps":["trace[2071005412] 'agreement among raft nodes before linearized reading' (duration: 891.33374ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:13:09.645222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:13:08.753752Z","time spent":"891.463131ms","remote":"127.0.0.1:37918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumes/test-pv\" "} {"level":"warn","ts":"2026-06-26T02:13:09.645239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.646841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T02:13:09.645217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.876756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-06-26T02:13:09.645279Z","caller":"traceutil/trace.go:171","msg":"trace[2003735044] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:1366; }","duration":"155.688841ms","start":"2026-06-26T02:13:09.489579Z","end":"2026-06-26T02:13:09.645268Z","steps":["trace[2003735044] 'agreement among raft nodes before linearized reading' (duration: 155.624541ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:13:09.645299Z","caller":"traceutil/trace.go:171","msg":"trace[5078420] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1366; }","duration":"649.968947ms","start":"2026-06-26T02:13:08.995311Z","end":"2026-06-26T02:13:09.64528Z","steps":["trace[5078420] 'agreement among raft nodes before linearized reading' (duration: 649.812016ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:13:09.645385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:13:08.995277Z","time spent":"650.091848ms","remote":"127.0.0.1:37936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":445,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"warn","ts":"2026-06-26T02:13:09.6454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"661.132113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-26T02:13:09.645461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.195301592s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:13:09.645504Z","caller":"traceutil/trace.go:171","msg":"trace[642404986] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1366; }","duration":"1.195386164s","start":"2026-06-26T02:13:08.450107Z","end":"2026-06-26T02:13:09.645493Z","steps":["trace[642404986] 'agreement among raft nodes before linearized reading' (duration: 1.195323993s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:13:09.645544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:13:08.450087Z","time spent":"1.195448274s","remote":"127.0.0.1:37758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-26T02:13:09.645658Z","caller":"traceutil/trace.go:171","msg":"trace[629410059] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1366; }","duration":"661.405096ms","start":"2026-06-26T02:13:08.98403Z","end":"2026-06-26T02:13:09.645435Z","steps":["trace[629410059] 'agreement among raft nodes before linearized reading' (duration: 661.009332ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:13:09.645657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.207124365s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-06-26T02:13:09.645718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:13:08.984005Z","time spent":"661.696479ms","remote":"127.0.0.1:38148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":30,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"info","ts":"2026-06-26T02:13:09.645825Z","caller":"traceutil/trace.go:171","msg":"trace[533320053] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1366; }","duration":"1.207355528s","start":"2026-06-26T02:13:08.438439Z","end":"2026-06-26T02:13:09.645795Z","steps":["trace[533320053] 'agreement among raft nodes before linearized reading' (duration: 1.206658551s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:13:09.64597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:13:08.438416Z","time spent":"1.207539569s","remote":"127.0.0.1:38014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-26T02:13:10.575988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"583.749249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:13:10.576062Z","caller":"traceutil/trace.go:171","msg":"trace[926942477] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1367; }","duration":"583.87704ms","start":"2026-06-26T02:13:09.992166Z","end":"2026-06-26T02:13:10.576044Z","steps":["trace[926942477] 'count revisions from in-memory index tree' (duration: 583.610598ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:13:10.576098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:13:09.992146Z","time spent":"583.940381ms","remote":"127.0.0.1:50070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-26T02:13:10.576305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"670.86603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:13:10.576406Z","caller":"traceutil/trace.go:171","msg":"trace[662864800] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1367; }","duration":"671.039953ms","start":"2026-06-26T02:13:09.905344Z","end":"2026-06-26T02:13:10.576384Z","steps":["trace[662864800] 'count revisions from in-memory index tree' (duration: 670.77979ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:13:10.576462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:13:09.905324Z","time spent":"671.125093ms","remote":"127.0.0.1:35792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"warn","ts":"2026-06-26T02:13:10.576543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.858357ms","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-06-26T02:13:10.576613Z","caller":"traceutil/trace.go:171","msg":"trace[133087095] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1367; }","duration":"177.965958ms","start":"2026-06-26T02:13:10.398631Z","end":"2026-06-26T02:13:10.576597Z","steps":["trace[133087095] 'range keys from in-memory index tree' (duration: 177.705135ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:13:10.576737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.298703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-26T02:13:10.576769Z","caller":"traceutil/trace.go:171","msg":"trace[819166780] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1367; }","duration":"179.373763ms","start":"2026-06-26T02:13:10.397387Z","end":"2026-06-26T02:13:10.576761Z","steps":["trace[819166780] 'range keys from in-memory index tree' (duration: 179.167901ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:13:10.576392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.1367ms","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-06-26T02:13:10.577685Z","caller":"traceutil/trace.go:171","msg":"trace[1721085281] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1367; }","duration":"179.459544ms","start":"2026-06-26T02:13:10.398196Z","end":"2026-06-26T02:13:10.577656Z","steps":["trace[1721085281] 'range keys from in-memory index tree' (duration: 177.804997ms)"],"step_count":1}