{"level":"warn","ts":"2026-03-20T05:25:51.296368Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-20T05:25:51.296469Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.95:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.95:2380","--initial-cluster=instance=https://199.204.45.95:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.95:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.95: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-03-20T05:25:51.29654Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-20T05:25:51.296553Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.95:2380"]} {"level":"info","ts":"2026-03-20T05:25:51.296572Z","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-03-20T05:25:51.29724Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"]} {"level":"info","ts":"2026-03-20T05:25:51.297346Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.95:2380"],"listen-peer-urls":["https://199.204.45.95:2380"],"advertise-client-urls":["https://199.204.45.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.95: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-03-20T05:25:51.303731Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.140994ms"} {"level":"info","ts":"2026-03-20T05:25:51.314359Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"be773dfc027af3eb","cluster-id":"9ba5fbd7288fd5af"} {"level":"info","ts":"2026-03-20T05:25:51.314468Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=()"} {"level":"info","ts":"2026-03-20T05:25:51.314502Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became follower at term 0"} {"level":"info","ts":"2026-03-20T05:25:51.314519Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft be773dfc027af3eb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-20T05:25:51.314531Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became follower at term 1"} {"level":"info","ts":"2026-03-20T05:25:51.314596Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=(13724506542017541099)"} {"level":"warn","ts":"2026-03-20T05:25:51.320688Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-20T05:25:51.322181Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-20T05:25:51.324012Z","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-03-20T05:25:51.326459Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"be773dfc027af3eb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-20T05:25:51.327244Z","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-03-20T05:25:51.327438Z","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-03-20T05:25:51.327506Z","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-03-20T05:25:51.326611Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"be773dfc027af3eb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-20T05:25:51.328353Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=(13724506542017541099)"} {"level":"info","ts":"2026-03-20T05:25:51.32852Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9ba5fbd7288fd5af","local-member-id":"be773dfc027af3eb","added-peer-id":"be773dfc027af3eb","added-peer-peer-urls":["https://199.204.45.95:2380"]} {"level":"info","ts":"2026-03-20T05:25:51.333439Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.95:2380"} {"level":"info","ts":"2026-03-20T05:25:51.333493Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.95:2380"} {"level":"info","ts":"2026-03-20T05:25:51.333352Z","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-03-20T05:25:51.335795Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"be773dfc027af3eb","initial-advertise-peer-urls":["https://199.204.45.95:2380"],"listen-peer-urls":["https://199.204.45.95:2380"],"advertise-client-urls":["https://199.204.45.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-20T05:25:51.33582Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-20T05:25:51.915058Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb is starting a new election at term 1"} {"level":"info","ts":"2026-03-20T05:25:51.915118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became pre-candidate at term 1"} {"level":"info","ts":"2026-03-20T05:25:51.915146Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb received MsgPreVoteResp from be773dfc027af3eb at term 1"} {"level":"info","ts":"2026-03-20T05:25:51.915161Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became candidate at term 2"} {"level":"info","ts":"2026-03-20T05:25:51.915167Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb received MsgVoteResp from be773dfc027af3eb at term 2"} {"level":"info","ts":"2026-03-20T05:25:51.91518Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became leader at term 2"} {"level":"info","ts":"2026-03-20T05:25:51.915189Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: be773dfc027af3eb elected leader be773dfc027af3eb at term 2"} {"level":"info","ts":"2026-03-20T05:25:51.916366Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-20T05:25:51.917287Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"be773dfc027af3eb","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.95:2379]}","request-path":"/0/members/be773dfc027af3eb/attributes","cluster-id":"9ba5fbd7288fd5af","publish-timeout":"7s"} {"level":"info","ts":"2026-03-20T05:25:51.917334Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-20T05:25:51.917922Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9ba5fbd7288fd5af","local-member-id":"be773dfc027af3eb","cluster-version":"3.5"} {"level":"info","ts":"2026-03-20T05:25:51.917982Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-20T05:25:51.918044Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-20T05:25:51.918081Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-20T05:25:51.918139Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-20T05:25:51.918158Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-20T05:25:51.9194Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.95:2379"} {"level":"info","ts":"2026-03-20T05:25:51.920326Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-20T05:25:55.68695Z","caller":"traceutil/trace.go:171","msg":"trace[1935141908] transaction","detail":"{read_only:false; response_revision:245; number_of_response:1; }","duration":"195.435272ms","start":"2026-03-20T05:25:55.491475Z","end":"2026-03-20T05:25:55.68691Z","steps":["trace[1935141908] 'process raft request' (duration: 195.15401ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:25:58.025386Z","caller":"traceutil/trace.go:171","msg":"trace[2099714049] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"131.802538ms","start":"2026-03-20T05:25:57.893535Z","end":"2026-03-20T05:25:58.025337Z","steps":["trace[2099714049] 'process raft request' (duration: 98.540932ms)","trace[2099714049] 'compare' (duration: 32.920993ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:25:58.025672Z","caller":"traceutil/trace.go:171","msg":"trace[616122129] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"126.267462ms","start":"2026-03-20T05:25:57.899128Z","end":"2026-03-20T05:25:58.025395Z","steps":["trace[616122129] 'process raft request' (duration: 126.098791ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:25:58.641618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.552958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T05:25:58.641746Z","caller":"traceutil/trace.go:171","msg":"trace[1472059295] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:0; response_revision:313; }","duration":"206.748109ms","start":"2026-03-20T05:25:58.434968Z","end":"2026-03-20T05:25:58.641716Z","steps":["trace[1472059295] 'range keys from in-memory index tree' (duration: 206.477268ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:25:58.895652Z","caller":"traceutil/trace.go:171","msg":"trace[732213993] linearizableReadLoop","detail":"{readStateIndex:324; appliedIndex:323; }","duration":"160.086365ms","start":"2026-03-20T05:25:58.735534Z","end":"2026-03-20T05:25:58.89562Z","steps":["trace[732213993] 'read index received' (duration: 154.326387ms)","trace[732213993] 'applied index is now lower than readState.Index' (duration: 5.758808ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:25:58.896011Z","caller":"traceutil/trace.go:171","msg":"trace[1589897344] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"163.706185ms","start":"2026-03-20T05:25:58.732287Z","end":"2026-03-20T05:25:58.895994Z","steps":["trace[1589897344] 'process raft request' (duration: 157.668335ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:25:58.896133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.765038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-03-20T05:25:58.896199Z","caller":"traceutil/trace.go:171","msg":"trace[1222324080] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:315; }","duration":"109.899518ms","start":"2026-03-20T05:25:58.786282Z","end":"2026-03-20T05:25:58.896181Z","steps":["trace[1222324080] 'agreement among raft nodes before linearized reading' (duration: 109.761507ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:25:58.896447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.906121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-03-20T05:25:58.897017Z","caller":"traceutil/trace.go:171","msg":"trace[318849272] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:315; }","duration":"161.497316ms","start":"2026-03-20T05:25:58.735499Z","end":"2026-03-20T05:25:58.896996Z","steps":["trace[318849272] 'agreement among raft nodes before linearized reading' (duration: 160.903741ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:25:59.286217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.823264ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-20T05:25:59.286596Z","caller":"traceutil/trace.go:171","msg":"trace[1802992702] linearizableReadLoop","detail":"{readStateIndex:332; appliedIndex:330; }","duration":"151.597012ms","start":"2026-03-20T05:25:59.134972Z","end":"2026-03-20T05:25:59.286569Z","steps":["trace[1802992702] 'read index received' (duration: 14.505478ms)","trace[1802992702] 'applied index is now lower than readState.Index' (duration: 137.090054ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:25:59.286523Z","caller":"traceutil/trace.go:171","msg":"trace[321179681] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"182.397646ms","start":"2026-03-20T05:25:59.10408Z","end":"2026-03-20T05:25:59.286477Z","steps":["trace[321179681] 'process raft request' (duration: 45.381972ms)","trace[321179681] 'compare' (duration: 135.3463ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:25:59.286655Z","caller":"traceutil/trace.go:171","msg":"trace[145615311] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"177.582757ms","start":"2026-03-20T05:25:59.10903Z","end":"2026-03-20T05:25:59.286613Z","steps":["trace[145615311] 'process raft request' (duration: 177.373915ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:25:59.287012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.009455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-03-20T05:25:59.287143Z","caller":"traceutil/trace.go:171","msg":"trace[661950225] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:323; }","duration":"152.125437ms","start":"2026-03-20T05:25:59.134937Z","end":"2026-03-20T05:25:59.287062Z","steps":["trace[661950225] 'agreement among raft nodes before linearized reading' (duration: 151.722134ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:25:59.516501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.127981ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-20T05:25:59.516619Z","caller":"traceutil/trace.go:171","msg":"trace[259563336] linearizableReadLoop","detail":"{readStateIndex:338; appliedIndex:337; }","duration":"131.72843ms","start":"2026-03-20T05:25:59.38487Z","end":"2026-03-20T05:25:59.516598Z","steps":["trace[259563336] 'read index received' (duration: 14.281906ms)","trace[259563336] 'applied index is now lower than readState.Index' (duration: 117.445254ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T05:25:59.516688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.812861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T05:25:59.516723Z","caller":"traceutil/trace.go:171","msg":"trace[657609895] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:0; response_revision:329; }","duration":"131.885141ms","start":"2026-03-20T05:25:59.384826Z","end":"2026-03-20T05:25:59.516711Z","steps":["trace[657609895] 'agreement among raft nodes before linearized reading' (duration: 131.829391ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:25:59.516763Z","caller":"traceutil/trace.go:171","msg":"trace[634709033] transaction","detail":"{read_only:false; response_revision:329; number_of_response:1; }","duration":"136.444058ms","start":"2026-03-20T05:25:59.380216Z","end":"2026-03-20T05:25:59.516661Z","steps":["trace[634709033] 'process raft request' (duration: 18.995855ms)","trace[634709033] 'compare' (duration: 116.969049ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:25:59.733208Z","caller":"traceutil/trace.go:171","msg":"trace[415038324] linearizableReadLoop","detail":"{readStateIndex:339; appliedIndex:338; }","duration":"158.897714ms","start":"2026-03-20T05:25:59.574263Z","end":"2026-03-20T05:25:59.733161Z","steps":["trace[415038324] 'read index received' (duration: 81.481489ms)","trace[415038324] 'applied index is now lower than readState.Index' (duration: 77.415155ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T05:25:59.733392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.107456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-03-20T05:25:59.733363Z","caller":"traceutil/trace.go:171","msg":"trace[968574407] transaction","detail":"{read_only:false; response_revision:330; number_of_response:1; }","duration":"210.9851ms","start":"2026-03-20T05:25:59.522317Z","end":"2026-03-20T05:25:59.733302Z","steps":["trace[968574407] 'process raft request' (duration: 133.510405ms)","trace[968574407] 'compare' (duration: 77.176113ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:25:59.733439Z","caller":"traceutil/trace.go:171","msg":"trace[381994284] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:330; }","duration":"159.235796ms","start":"2026-03-20T05:25:59.574192Z","end":"2026-03-20T05:25:59.733428Z","steps":["trace[381994284] 'agreement among raft nodes before linearized reading' (duration: 159.097515ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:25:59.918794Z","caller":"traceutil/trace.go:171","msg":"trace[151249602] transaction","detail":"{read_only:false; response_revision:332; number_of_response:1; }","duration":"123.080089ms","start":"2026-03-20T05:25:59.795691Z","end":"2026-03-20T05:25:59.918772Z","steps":["trace[151249602] 'process raft request' (duration: 64.465539ms)","trace[151249602] 'compare' (duration: 58.520729ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:26:01.792158Z","caller":"traceutil/trace.go:171","msg":"trace[1285401447] linearizableReadLoop","detail":"{readStateIndex:358; appliedIndex:357; }","duration":"106.675531ms","start":"2026-03-20T05:26:01.685461Z","end":"2026-03-20T05:26:01.792136Z","steps":["trace[1285401447] 'read index received' (duration: 106.479888ms)","trace[1285401447] 'applied index is now lower than readState.Index' (duration: 194.573µs)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:26:01.792219Z","caller":"traceutil/trace.go:171","msg":"trace[782512450] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"145.259492ms","start":"2026-03-20T05:26:01.646918Z","end":"2026-03-20T05:26:01.792177Z","steps":["trace[782512450] 'process raft request' (duration: 145.08686ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:01.792578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.094004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-03-20T05:26:01.79263Z","caller":"traceutil/trace.go:171","msg":"trace[588683552] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:349; }","duration":"107.212495ms","start":"2026-03-20T05:26:01.685405Z","end":"2026-03-20T05:26:01.792617Z","steps":["trace[588683552] 'agreement among raft nodes before linearized reading' (duration: 106.865103ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:01.972982Z","caller":"traceutil/trace.go:171","msg":"trace[772983266] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"176.297872ms","start":"2026-03-20T05:26:01.796655Z","end":"2026-03-20T05:26:01.972952Z","steps":["trace[772983266] 'process raft request' (duration: 114.193651ms)","trace[772983266] 'compare' (duration: 61.843249ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:26:01.972984Z","caller":"traceutil/trace.go:171","msg":"trace[924699027] linearizableReadLoop","detail":"{readStateIndex:361; appliedIndex:358; }","duration":"137.320818ms","start":"2026-03-20T05:26:01.83564Z","end":"2026-03-20T05:26:01.97296Z","steps":["trace[924699027] 'read index received' (duration: 49.67921ms)","trace[924699027] 'applied index is now lower than readState.Index' (duration: 87.640578ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:26:01.973043Z","caller":"traceutil/trace.go:171","msg":"trace[1913893803] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"174.144875ms","start":"2026-03-20T05:26:01.798865Z","end":"2026-03-20T05:26:01.97301Z","steps":["trace[1913893803] 'process raft request' (duration: 174.020614ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:01.973229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.565289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-03-20T05:26:01.973279Z","caller":"traceutil/trace.go:171","msg":"trace[2075410062] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:352; }","duration":"137.68828ms","start":"2026-03-20T05:26:01.83558Z","end":"2026-03-20T05:26:01.973269Z","steps":["trace[2075410062] 'agreement among raft nodes before linearized reading' (duration: 137.539139ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:02.215524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.220355ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-20T05:26:02.215798Z","caller":"traceutil/trace.go:171","msg":"trace[48870702] linearizableReadLoop","detail":"{readStateIndex:368; appliedIndex:365; }","duration":"130.266862ms","start":"2026-03-20T05:26:02.085506Z","end":"2026-03-20T05:26:02.215773Z","steps":["trace[48870702] 'read index received' (duration: 84.679218ms)","trace[48870702] 'applied index is now lower than readState.Index' (duration: 45.586364ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:26:02.21582Z","caller":"traceutil/trace.go:171","msg":"trace[1448590239] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"150.382822ms","start":"2026-03-20T05:26:02.065416Z","end":"2026-03-20T05:26:02.215799Z","steps":["trace[1448590239] 'process raft request' (duration: 150.232201ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:02.21607Z","caller":"traceutil/trace.go:171","msg":"trace[680356900] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"154.401955ms","start":"2026-03-20T05:26:02.061656Z","end":"2026-03-20T05:26:02.216058Z","steps":["trace[680356900] 'process raft request' (duration: 14.574556ms)","trace[680356900] 'compare' (duration: 139.030824ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T05:26:02.216307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.791466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-03-20T05:26:02.216348Z","caller":"traceutil/trace.go:171","msg":"trace[2056321402] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:359; }","duration":"130.869527ms","start":"2026-03-20T05:26:02.085467Z","end":"2026-03-20T05:26:02.216337Z","steps":["trace[2056321402] 'agreement among raft nodes before linearized reading' (duration: 130.796427ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:02.216382Z","caller":"traceutil/trace.go:171","msg":"trace[1141986934] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"150.572554ms","start":"2026-03-20T05:26:02.065766Z","end":"2026-03-20T05:26:02.216338Z","steps":["trace[1141986934] 'process raft request' (duration: 149.94303ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:02.494458Z","caller":"traceutil/trace.go:171","msg":"trace[743791545] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"267.973904ms","start":"2026-03-20T05:26:02.226473Z","end":"2026-03-20T05:26:02.494447Z","steps":["trace[743791545] 'process raft request' (duration: 267.899514ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:02.494441Z","caller":"traceutil/trace.go:171","msg":"trace[407381398] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"269.478166ms","start":"2026-03-20T05:26:02.224917Z","end":"2026-03-20T05:26:02.494395Z","steps":["trace[407381398] 'process raft request' (duration: 262.075037ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:02.494666Z","caller":"traceutil/trace.go:171","msg":"trace[1702612704] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"268.072025ms","start":"2026-03-20T05:26:02.226573Z","end":"2026-03-20T05:26:02.494645Z","steps":["trace[1702612704] 'process raft request' (duration: 267.849913ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:02.494955Z","caller":"traceutil/trace.go:171","msg":"trace[969054467] linearizableReadLoop","detail":"{readStateIndex:374; appliedIndex:368; }","duration":"257.901784ms","start":"2026-03-20T05:26:02.237033Z","end":"2026-03-20T05:26:02.494935Z","steps":["trace[969054467] 'read index received' (duration: 3.139226ms)","trace[969054467] 'applied index is now lower than readState.Index' (duration: 254.760058ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:26:02.495126Z","caller":"traceutil/trace.go:171","msg":"trace[1017081058] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"266.12311ms","start":"2026-03-20T05:26:02.228993Z","end":"2026-03-20T05:26:02.495116Z","steps":["trace[1017081058] 'process raft request' (duration: 265.881467ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:02.495189Z","caller":"traceutil/trace.go:171","msg":"trace[961789130] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"267.648532ms","start":"2026-03-20T05:26:02.22753Z","end":"2026-03-20T05:26:02.495178Z","steps":["trace[961789130] 'process raft request' (duration: 267.030347ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:02.495341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.177597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"warn","ts":"2026-03-20T05:26:02.495403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.856039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-03-20T05:26:02.495446Z","caller":"traceutil/trace.go:171","msg":"trace[1713307639] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:365; }","duration":"209.93875ms","start":"2026-03-20T05:26:02.285492Z","end":"2026-03-20T05:26:02.495431Z","steps":["trace[1713307639] 'agreement among raft nodes before linearized reading' (duration: 209.87453ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:02.495453Z","caller":"traceutil/trace.go:171","msg":"trace[1511022315] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:365; }","duration":"258.424698ms","start":"2026-03-20T05:26:02.236989Z","end":"2026-03-20T05:26:02.495414Z","steps":["trace[1511022315] 'agreement among raft nodes before linearized reading' (duration: 258.137046ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:02.495494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.430396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-03-20T05:26:02.495574Z","caller":"traceutil/trace.go:171","msg":"trace[947006346] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:365; }","duration":"109.555816ms","start":"2026-03-20T05:26:02.386004Z","end":"2026-03-20T05:26:02.495559Z","steps":["trace[947006346] 'agreement among raft nodes before linearized reading' (duration: 109.378185ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:02.495592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.791008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-03-20T05:26:02.495765Z","caller":"traceutil/trace.go:171","msg":"trace[478334481] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:365; }","duration":"159.96011ms","start":"2026-03-20T05:26:02.335794Z","end":"2026-03-20T05:26:02.495754Z","steps":["trace[478334481] 'agreement among raft nodes before linearized reading' (duration: 159.773168ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:02.645965Z","caller":"traceutil/trace.go:171","msg":"trace[1577311224] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"143.000354ms","start":"2026-03-20T05:26:02.502933Z","end":"2026-03-20T05:26:02.645933Z","steps":["trace[1577311224] 'process raft request' (duration: 108.355938ms)","trace[1577311224] 'compare' (duration: 34.232723ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:26:02.646156Z","caller":"traceutil/trace.go:171","msg":"trace[609195603] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"143.123855ms","start":"2026-03-20T05:26:02.503019Z","end":"2026-03-20T05:26:02.646143Z","steps":["trace[609195603] 'process raft request' (duration: 142.690292ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:02.646802Z","caller":"traceutil/trace.go:171","msg":"trace[1735028288] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"142.48714ms","start":"2026-03-20T05:26:02.504261Z","end":"2026-03-20T05:26:02.646748Z","steps":["trace[1735028288] 'process raft request' (duration: 141.524472ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:02.646992Z","caller":"traceutil/trace.go:171","msg":"trace[1547392577] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"142.349849ms","start":"2026-03-20T05:26:02.504629Z","end":"2026-03-20T05:26:02.646979Z","steps":["trace[1547392577] 'process raft request' (duration: 141.354681ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:02.647326Z","caller":"traceutil/trace.go:171","msg":"trace[366755445] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"142.102056ms","start":"2026-03-20T05:26:02.505213Z","end":"2026-03-20T05:26:02.647315Z","steps":["trace[366755445] 'process raft request' (duration: 141.515652ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:02.647376Z","caller":"traceutil/trace.go:171","msg":"trace[1670507407] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"140.654375ms","start":"2026-03-20T05:26:02.506713Z","end":"2026-03-20T05:26:02.647368Z","steps":["trace[1670507407] 'process raft request' (duration: 140.337902ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:02.837035Z","caller":"traceutil/trace.go:171","msg":"trace[823920568] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"183.7127ms","start":"2026-03-20T05:26:02.653303Z","end":"2026-03-20T05:26:02.837016Z","steps":["trace[823920568] 'process raft request' (duration: 183.544939ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:02.837061Z","caller":"traceutil/trace.go:171","msg":"trace[154021197] linearizableReadLoop","detail":"{readStateIndex:386; appliedIndex:381; }","duration":"182.967834ms","start":"2026-03-20T05:26:02.654068Z","end":"2026-03-20T05:26:02.837036Z","steps":["trace[154021197] 'read index received' (duration: 37.901643ms)","trace[154021197] 'applied index is now lower than readState.Index' (duration: 145.065251ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:26:02.837181Z","caller":"traceutil/trace.go:171","msg":"trace[11495510] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"182.990485ms","start":"2026-03-20T05:26:02.654182Z","end":"2026-03-20T05:26:02.837172Z","steps":["trace[11495510] 'process raft request' (duration: 182.772033ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:02.837184Z","caller":"traceutil/trace.go:171","msg":"trace[1818487740] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"183.617999ms","start":"2026-03-20T05:26:02.653545Z","end":"2026-03-20T05:26:02.837163Z","steps":["trace[1818487740] 'process raft request' (duration: 183.372777ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:02.837343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.251506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/admin\" ","response":"range_response_count:1 size:2278"} {"level":"info","ts":"2026-03-20T05:26:02.837422Z","caller":"traceutil/trace.go:171","msg":"trace[683751517] range","detail":"{range_begin:/registry/clusterroles/admin; range_end:; response_count:1; response_revision:379; }","duration":"183.366738ms","start":"2026-03-20T05:26:02.654043Z","end":"2026-03-20T05:26:02.83741Z","steps":["trace[683751517] 'agreement among raft nodes before linearized reading' (duration: 183.172746ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:02.837463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.426494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-68656\" ","response":"range_response_count:1 size:3439"} {"level":"info","ts":"2026-03-20T05:26:02.837519Z","caller":"traceutil/trace.go:171","msg":"trace[1766342141] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-68656; range_end:; response_count:1; response_revision:379; }","duration":"140.519884ms","start":"2026-03-20T05:26:02.696988Z","end":"2026-03-20T05:26:02.837508Z","steps":["trace[1766342141] 'agreement among raft nodes before linearized reading' (duration: 140.416934ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:02.83715Z","caller":"traceutil/trace.go:171","msg":"trace[1109124312] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"185.215351ms","start":"2026-03-20T05:26:02.651894Z","end":"2026-03-20T05:26:02.837109Z","steps":["trace[1109124312] 'process raft request' (duration: 184.915639ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:02.837659Z","caller":"traceutil/trace.go:171","msg":"trace[2507780] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"178.647259ms","start":"2026-03-20T05:26:02.658962Z","end":"2026-03-20T05:26:02.837609Z","steps":["trace[2507780] 'process raft request' (duration: 178.030215ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:02.836925Z","caller":"traceutil/trace.go:171","msg":"trace[1847510222] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"185.065591ms","start":"2026-03-20T05:26:02.65183Z","end":"2026-03-20T05:26:02.836896Z","steps":["trace[1847510222] 'process raft request' (duration: 150.480614ms)","trace[1847510222] 'compare' (duration: 34.347815ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:26:03.058473Z","caller":"traceutil/trace.go:171","msg":"trace[1460816378] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"215.675662ms","start":"2026-03-20T05:26:02.842765Z","end":"2026-03-20T05:26:03.05844Z","steps":["trace[1460816378] 'process raft request' (duration: 198.602437ms)","trace[1460816378] 'compare' (duration: 16.879804ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T05:26:03.058612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.155101ms","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-03-20T05:26:03.058642Z","caller":"traceutil/trace.go:171","msg":"trace[428683795] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:385; }","duration":"163.201641ms","start":"2026-03-20T05:26:02.895434Z","end":"2026-03-20T05:26:03.058636Z","steps":["trace[428683795] 'agreement among raft nodes before linearized reading' (duration: 163.125671ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:03.058522Z","caller":"traceutil/trace.go:171","msg":"trace[710194994] linearizableReadLoop","detail":"{readStateIndex:394; appliedIndex:388; }","duration":"163.05012ms","start":"2026-03-20T05:26:02.895454Z","end":"2026-03-20T05:26:03.058504Z","steps":["trace[710194994] 'read index received' (duration: 18.924581ms)","trace[710194994] 'applied index is now lower than readState.Index' (duration: 144.124869ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:26:03.058864Z","caller":"traceutil/trace.go:171","msg":"trace[253522282] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"214.309331ms","start":"2026-03-20T05:26:02.844548Z","end":"2026-03-20T05:26:03.058858Z","steps":["trace[253522282] 'process raft request' (duration: 213.810607ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:03.059047Z","caller":"traceutil/trace.go:171","msg":"trace[2040246328] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"211.896252ms","start":"2026-03-20T05:26:02.847145Z","end":"2026-03-20T05:26:03.059041Z","steps":["trace[2040246328] 'process raft request' (duration: 211.330038ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:03.058952Z","caller":"traceutil/trace.go:171","msg":"trace[1739097164] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"214.05642ms","start":"2026-03-20T05:26:02.844889Z","end":"2026-03-20T05:26:03.058946Z","steps":["trace[1739097164] 'process raft request' (duration: 213.512636ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:03.059026Z","caller":"traceutil/trace.go:171","msg":"trace[2104538132] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"212.83921ms","start":"2026-03-20T05:26:02.846177Z","end":"2026-03-20T05:26:03.059016Z","steps":["trace[2104538132] 'process raft request' (duration: 212.266876ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:03.463724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.464636ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-20T05:26:03.46386Z","caller":"traceutil/trace.go:171","msg":"trace[1348407595] linearizableReadLoop","detail":"{readStateIndex:396; appliedIndex:395; }","duration":"154.533416ms","start":"2026-03-20T05:26:03.309283Z","end":"2026-03-20T05:26:03.463816Z","steps":["trace[1348407595] 'read index received' (duration: 28.839239ms)","trace[1348407595] 'applied index is now lower than readState.Index' (duration: 125.693077ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:26:03.463968Z","caller":"traceutil/trace.go:171","msg":"trace[1089121959] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"395.956044ms","start":"2026-03-20T05:26:03.068Z","end":"2026-03-20T05:26:03.463956Z","steps":["trace[1089121959] 'process raft request' (duration: 270.172475ms)","trace[1089121959] 'compare' (duration: 125.357945ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T05:26:03.464032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:03.067976Z","time spent":"396.024874ms","remote":"127.0.0.1:47414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3804,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-20T05:26:03.464574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.277862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-03-20T05:26:03.464765Z","caller":"traceutil/trace.go:171","msg":"trace[473276385] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:387; }","duration":"155.528775ms","start":"2026-03-20T05:26:03.309218Z","end":"2026-03-20T05:26:03.464747Z","steps":["trace[473276385] 'agreement among raft nodes before linearized reading' (duration: 154.91428ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:04.081498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.468829ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-20T05:26:04.081626Z","caller":"traceutil/trace.go:171","msg":"trace[1317946026] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"611.940875ms","start":"2026-03-20T05:26:03.469665Z","end":"2026-03-20T05:26:04.081606Z","steps":["trace[1317946026] 'process raft request' (duration: 125.237694ms)","trace[1317946026] 'compare' (duration: 486.303367ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T05:26:04.081697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:03.469643Z","time spent":"612.022946ms","remote":"127.0.0.1:47176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-20T05:26:04.108189Z","caller":"traceutil/trace.go:171","msg":"trace[1263179925] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"638.476983ms","start":"2026-03-20T05:26:03.469683Z","end":"2026-03-20T05:26:04.10816Z","steps":["trace[1263179925] 'process raft request' (duration: 638.297912ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:04.108374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:03.469666Z","time spent":"638.617775ms","remote":"127.0.0.1:47176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-20T05:26:04.108542Z","caller":"traceutil/trace.go:171","msg":"trace[1007635473] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"638.770056ms","start":"2026-03-20T05:26:03.469753Z","end":"2026-03-20T05:26:04.108523Z","steps":["trace[1007635473] 'process raft request' (duration: 638.363463ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:04.108666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:03.469747Z","time spent":"638.842736ms","remote":"127.0.0.1:47176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-20T05:26:04.109286Z","caller":"traceutil/trace.go:171","msg":"trace[962643149] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"636.691619ms","start":"2026-03-20T05:26:03.472429Z","end":"2026-03-20T05:26:04.10912Z","steps":["trace[962643149] 'process raft request' (duration: 636.458258ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:04.10954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:03.472423Z","time spent":"636.995912ms","remote":"127.0.0.1:47384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4041,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-20T05:26:04.13224Z","caller":"traceutil/trace.go:171","msg":"trace[25435564] linearizableReadLoop","detail":"{readStateIndex:401; appliedIndex:397; }","duration":"438.927769ms","start":"2026-03-20T05:26:03.693284Z","end":"2026-03-20T05:26:04.132212Z","steps":["trace[25435564] 'read index received' (duration: 414.669068ms)","trace[25435564] 'applied index is now lower than readState.Index' (duration: 24.257671ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:26:04.132414Z","caller":"traceutil/trace.go:171","msg":"trace[977040983] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"522.231109ms","start":"2026-03-20T05:26:03.610171Z","end":"2026-03-20T05:26:04.132402Z","steps":["trace[977040983] 'process raft request' (duration: 521.936047ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:04.132548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:03.610156Z","time spent":"522.3133ms","remote":"127.0.0.1:47176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-20T05:26:04.132663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.944621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-03-20T05:26:04.132758Z","caller":"traceutil/trace.go:171","msg":"trace[168556094] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:392; }","duration":"243.132893ms","start":"2026-03-20T05:26:03.88961Z","end":"2026-03-20T05:26:04.132743Z","steps":["trace[168556094] 'agreement among raft nodes before linearized reading' (duration: 242.896961ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:04.132649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.338972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6961"} {"level":"info","ts":"2026-03-20T05:26:04.132959Z","caller":"traceutil/trace.go:171","msg":"trace[80668671] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:392; }","duration":"439.717134ms","start":"2026-03-20T05:26:03.693228Z","end":"2026-03-20T05:26:04.132945Z","steps":["trace[80668671] 'agreement among raft nodes before linearized reading' (duration: 439.296641ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:04.133038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:03.693205Z","time spent":"439.818395ms","remote":"127.0.0.1:47106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":6985,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"info","ts":"2026-03-20T05:26:04.520117Z","caller":"traceutil/trace.go:171","msg":"trace[308554652] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"265.706474ms","start":"2026-03-20T05:26:04.254382Z","end":"2026-03-20T05:26:04.520088Z","steps":["trace[308554652] 'process raft request' (duration: 265.520893ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:05.003587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.008837ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-20T05:26:05.003705Z","caller":"traceutil/trace.go:171","msg":"trace[334492628] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"611.614179ms","start":"2026-03-20T05:26:04.392072Z","end":"2026-03-20T05:26:05.003686Z","steps":["trace[334492628] 'process raft request' (duration: 242.437541ms)","trace[334492628] 'compare' (duration: 368.859936ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T05:26:05.003761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:04.392034Z","time spent":"611.70641ms","remote":"127.0.0.1:47004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":777,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-20T05:26:06.354738Z","caller":"traceutil/trace.go:171","msg":"trace[696809077] linearizableReadLoop","detail":"{readStateIndex:416; appliedIndex:414; }","duration":"184.469193ms","start":"2026-03-20T05:26:06.170246Z","end":"2026-03-20T05:26:06.354715Z","steps":["trace[696809077] 'read index received' (duration: 102.002622ms)","trace[696809077] 'applied index is now lower than readState.Index' (duration: 82.465481ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:26:06.354797Z","caller":"traceutil/trace.go:171","msg":"trace[903415812] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"237.208611ms","start":"2026-03-20T05:26:06.117559Z","end":"2026-03-20T05:26:06.354768Z","steps":["trace[903415812] 'process raft request' (duration: 154.6806ms)","trace[903415812] 'compare' (duration: 82.272509ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:26:06.354887Z","caller":"traceutil/trace.go:171","msg":"trace[361849889] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"237.310252ms","start":"2026-03-20T05:26:06.117567Z","end":"2026-03-20T05:26:06.354877Z","steps":["trace[361849889] 'process raft request' (duration: 237.101371ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:06.355037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.699225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-03-20T05:26:06.355156Z","caller":"traceutil/trace.go:171","msg":"trace[341606464] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:405; }","duration":"184.914007ms","start":"2026-03-20T05:26:06.170219Z","end":"2026-03-20T05:26:06.355133Z","steps":["trace[341606464] 'agreement among raft nodes before linearized reading' (duration: 184.654334ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:06.908747Z","caller":"traceutil/trace.go:171","msg":"trace[1249381904] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"185.174587ms","start":"2026-03-20T05:26:06.723545Z","end":"2026-03-20T05:26:06.90872Z","steps":["trace[1249381904] 'process raft request' (duration: 185.003326ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:07.365776Z","caller":"traceutil/trace.go:171","msg":"trace[2080160247] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"104.223003ms","start":"2026-03-20T05:26:07.261527Z","end":"2026-03-20T05:26:07.36575Z","steps":["trace[2080160247] 'process raft request' (duration: 104.065652ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:10.580028Z","caller":"traceutil/trace.go:171","msg":"trace[824294712] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"444.881391ms","start":"2026-03-20T05:26:10.135124Z","end":"2026-03-20T05:26:10.580006Z","steps":["trace[824294712] 'process raft request' (duration: 444.65801ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:10.580174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:10.135104Z","time spent":"444.998002ms","remote":"127.0.0.1:47176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-20T05:26:10.665381Z","caller":"traceutil/trace.go:171","msg":"trace[972090964] linearizableReadLoop","detail":"{readStateIndex:430; appliedIndex:428; }","duration":"286.153792ms","start":"2026-03-20T05:26:10.379199Z","end":"2026-03-20T05:26:10.665353Z","steps":["trace[972090964] 'read index received' (duration: 200.629946ms)","trace[972090964] 'applied index is now lower than readState.Index' (duration: 85.522426ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T05:26:10.665599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.377743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-03-20T05:26:10.665642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.419741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-03-20T05:26:10.665671Z","caller":"traceutil/trace.go:171","msg":"trace[694716376] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:418; }","duration":"286.502364ms","start":"2026-03-20T05:26:10.379151Z","end":"2026-03-20T05:26:10.665653Z","steps":["trace[694716376] 'agreement among raft nodes before linearized reading' (duration: 286.337653ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:10.665691Z","caller":"traceutil/trace.go:171","msg":"trace[1652922763] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:418; }","duration":"283.511401ms","start":"2026-03-20T05:26:10.382167Z","end":"2026-03-20T05:26:10.665679Z","steps":["trace[1652922763] 'agreement among raft nodes before linearized reading' (duration: 283.39781ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:10.665829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.388789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-03-20T05:26:10.665889Z","caller":"traceutil/trace.go:171","msg":"trace[723183904] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:418; }","duration":"255.47017ms","start":"2026-03-20T05:26:10.410405Z","end":"2026-03-20T05:26:10.665875Z","steps":["trace[723183904] 'agreement among raft nodes before linearized reading' (duration: 255.330559ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:10.817429Z","caller":"traceutil/trace.go:171","msg":"trace[753149050] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"146.606008ms","start":"2026-03-20T05:26:10.670795Z","end":"2026-03-20T05:26:10.817401Z","steps":["trace[753149050] 'process raft request' (duration: 146.435036ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:10.828794Z","caller":"traceutil/trace.go:171","msg":"trace[1144848825] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"157.38219ms","start":"2026-03-20T05:26:10.671396Z","end":"2026-03-20T05:26:10.828778Z","steps":["trace[1144848825] 'process raft request' (duration: 157.200169ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:10.828785Z","caller":"traceutil/trace.go:171","msg":"trace[636982970] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"157.894773ms","start":"2026-03-20T05:26:10.670794Z","end":"2026-03-20T05:26:10.828689Z","steps":["trace[636982970] 'process raft request' (duration: 157.687671ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:12.950318Z","caller":"traceutil/trace.go:171","msg":"trace[1216290912] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"100.128768ms","start":"2026-03-20T05:26:12.850171Z","end":"2026-03-20T05:26:12.9503Z","steps":["trace[1216290912] 'process raft request' (duration: 100.032567ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:15.776293Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576314635760719334,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-20T05:26:16.156948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"656.075782ms","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-03-20T05:26:16.157046Z","caller":"traceutil/trace.go:171","msg":"trace[1249611593] linearizableReadLoop","detail":"{readStateIndex:475; appliedIndex:474; }","duration":"881.884148ms","start":"2026-03-20T05:26:15.275139Z","end":"2026-03-20T05:26:16.157023Z","steps":["trace[1249611593] 'read index received' (duration: 798.547181ms)","trace[1249611593] 'applied index is now lower than readState.Index' (duration: 83.335997ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:26:16.15708Z","caller":"traceutil/trace.go:171","msg":"trace[872960979] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:460; }","duration":"656.228423ms","start":"2026-03-20T05:26:15.500832Z","end":"2026-03-20T05:26:16.157061Z","steps":["trace[872960979] 'range keys from in-memory index tree' (duration: 656.054792ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:16.157165Z","caller":"traceutil/trace.go:171","msg":"trace[895872581] transaction","detail":"{read_only:false; response_revision:461; number_of_response:1; }","duration":"887.272537ms","start":"2026-03-20T05:26:15.269879Z","end":"2026-03-20T05:26:16.157152Z","steps":["trace[895872581] 'process raft request' (duration: 803.853269ms)","trace[895872581] 'compare' (duration: 83.165596ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T05:26:16.157278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:15.269867Z","time spent":"887.336877ms","remote":"127.0.0.1:47384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4180,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-20T05:26:16.157282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.446931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T05:26:16.157343Z","caller":"traceutil/trace.go:171","msg":"trace[1630401343] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:461; }","duration":"369.539052ms","start":"2026-03-20T05:26:15.787787Z","end":"2026-03-20T05:26:16.157326Z","steps":["trace[1630401343] 'agreement among raft nodes before linearized reading' (duration: 369.443111ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:16.157359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"882.19224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-67659f764b\" ","response":"range_response_count:1 size:3855"} {"level":"info","ts":"2026-03-20T05:26:16.157447Z","caller":"traceutil/trace.go:171","msg":"trace[1646032456] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-67659f764b; range_end:; response_count:1; response_revision:461; }","duration":"882.319291ms","start":"2026-03-20T05:26:15.275108Z","end":"2026-03-20T05:26:16.157427Z","steps":["trace[1646032456] 'agreement among raft nodes before linearized reading' (duration: 882.111999ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:16.157496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:15.275094Z","time spent":"882.394252ms","remote":"127.0.0.1:47414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":3879,"request content":"key:\"/registry/replicasets/kube-system/coredns-67659f764b\" "} {"level":"warn","ts":"2026-03-20T05:26:16.15739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:15.787771Z","time spent":"369.610753ms","remote":"127.0.0.1:46918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-20T05:26:18.838058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.725666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-03-20T05:26:18.838149Z","caller":"traceutil/trace.go:171","msg":"trace[907135972] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:466; }","duration":"229.858367ms","start":"2026-03-20T05:26:18.608275Z","end":"2026-03-20T05:26:18.838133Z","steps":["trace[907135972] 'range keys from in-memory index tree' (duration: 229.619356ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:26.453929Z","caller":"traceutil/trace.go:171","msg":"trace[46912339] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"218.599198ms","start":"2026-03-20T05:26:26.235303Z","end":"2026-03-20T05:26:26.453902Z","steps":["trace[46912339] 'process raft request' (duration: 212.878967ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:29.281191Z","caller":"traceutil/trace.go:171","msg":"trace[1783240410] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"206.658147ms","start":"2026-03-20T05:26:29.074513Z","end":"2026-03-20T05:26:29.281171Z","steps":["trace[1783240410] 'process raft request' (duration: 205.416909ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:31.090076Z","caller":"traceutil/trace.go:171","msg":"trace[1819485487] linearizableReadLoop","detail":"{readStateIndex:547; appliedIndex:546; }","duration":"131.703315ms","start":"2026-03-20T05:26:30.958348Z","end":"2026-03-20T05:26:31.090052Z","steps":["trace[1819485487] 'read index received' (duration: 131.505289ms)","trace[1819485487] 'applied index is now lower than readState.Index' (duration: 197.156µs)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:26:31.090128Z","caller":"traceutil/trace.go:171","msg":"trace[1354693896] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"139.713702ms","start":"2026-03-20T05:26:30.950376Z","end":"2026-03-20T05:26:31.090089Z","steps":["trace[1354693896] 'process raft request' (duration: 139.529476ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:31.090298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.922842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-03-20T05:26:31.090342Z","caller":"traceutil/trace.go:171","msg":"trace[1059887710] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:530; }","duration":"132.005785ms","start":"2026-03-20T05:26:30.958325Z","end":"2026-03-20T05:26:31.09033Z","steps":["trace[1059887710] 'agreement among raft nodes before linearized reading' (duration: 131.816699ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:31.517012Z","caller":"traceutil/trace.go:171","msg":"trace[498142925] linearizableReadLoop","detail":"{readStateIndex:548; appliedIndex:547; }","duration":"421.449157ms","start":"2026-03-20T05:26:31.095536Z","end":"2026-03-20T05:26:31.516985Z","steps":["trace[498142925] 'read index received' (duration: 397.47434ms)","trace[498142925] 'applied index is now lower than readState.Index' (duration: 23.973927ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:26:31.517073Z","caller":"traceutil/trace.go:171","msg":"trace[1181019036] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"422.084328ms","start":"2026-03-20T05:26:31.094965Z","end":"2026-03-20T05:26:31.517049Z","steps":["trace[1181019036] 'process raft request' (duration: 398.06762ms)","trace[1181019036] 'compare' (duration: 23.805782ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T05:26:31.517224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.678245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-03-20T05:26:31.517224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:31.094938Z","time spent":"422.189942ms","remote":"127.0.0.1:47176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-20T05:26:31.517283Z","caller":"traceutil/trace.go:171","msg":"trace[954027303] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:531; }","duration":"421.763447ms","start":"2026-03-20T05:26:31.095502Z","end":"2026-03-20T05:26:31.517266Z","steps":["trace[954027303] 'agreement among raft nodes before linearized reading' (duration: 421.643913ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:31.517323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:31.095492Z","time spent":"421.820869ms","remote":"127.0.0.1:47176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-03-20T05:26:31.517413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.386516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"warn","ts":"2026-03-20T05:26:31.517412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.711508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T05:26:31.51747Z","caller":"traceutil/trace.go:171","msg":"trace[1794962490] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:531; }","duration":"231.477889ms","start":"2026-03-20T05:26:31.285973Z","end":"2026-03-20T05:26:31.517451Z","steps":["trace[1794962490] 'agreement among raft nodes before linearized reading' (duration: 231.271792ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:31.517509Z","caller":"traceutil/trace.go:171","msg":"trace[1443736671] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:0; response_revision:531; }","duration":"207.867803ms","start":"2026-03-20T05:26:31.309612Z","end":"2026-03-20T05:26:31.51748Z","steps":["trace[1443736671] 'agreement among raft nodes before linearized reading' (duration: 207.683418ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:33.662164Z","caller":"traceutil/trace.go:171","msg":"trace[2038245681] linearizableReadLoop","detail":"{readStateIndex:574; appliedIndex:573; }","duration":"127.202426ms","start":"2026-03-20T05:26:33.534941Z","end":"2026-03-20T05:26:33.662144Z","steps":["trace[2038245681] 'read index received' (duration: 127.113994ms)","trace[2038245681] 'applied index is now lower than readState.Index' (duration: 87.312µs)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:26:33.662296Z","caller":"traceutil/trace.go:171","msg":"trace[954278390] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"136.041469ms","start":"2026-03-20T05:26:33.526227Z","end":"2026-03-20T05:26:33.662268Z","steps":["trace[954278390] 'process raft request' (duration: 135.777961ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:33.662331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.371042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-03-20T05:26:33.662367Z","caller":"traceutil/trace.go:171","msg":"trace[1785680469] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:557; }","duration":"127.458875ms","start":"2026-03-20T05:26:33.534898Z","end":"2026-03-20T05:26:33.662357Z","steps":["trace[1785680469] 'agreement among raft nodes before linearized reading' (duration: 127.365992ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:33.662392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.245226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-03-20T05:26:33.662452Z","caller":"traceutil/trace.go:171","msg":"trace[977229253] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:557; }","duration":"125.338578ms","start":"2026-03-20T05:26:33.537102Z","end":"2026-03-20T05:26:33.662441Z","steps":["trace[977229253] 'agreement among raft nodes before linearized reading' (duration: 125.210094ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:35.863214Z","caller":"traceutil/trace.go:171","msg":"trace[1506878024] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"118.607981ms","start":"2026-03-20T05:26:35.744568Z","end":"2026-03-20T05:26:35.863176Z","steps":["trace[1506878024] 'process raft request' (duration: 57.890648ms)","trace[1506878024] 'compare' (duration: 60.558929ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:26:37.279176Z","caller":"traceutil/trace.go:171","msg":"trace[1308216107] linearizableReadLoop","detail":"{readStateIndex:586; appliedIndex:585; }","duration":"492.339331ms","start":"2026-03-20T05:26:36.786814Z","end":"2026-03-20T05:26:37.279153Z","steps":["trace[1308216107] 'read index received' (duration: 492.231638ms)","trace[1308216107] 'applied index is now lower than readState.Index' (duration: 106.693µs)"],"step_count":2} {"level":"warn","ts":"2026-03-20T05:26:37.279382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.544207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-qs96b\" ","response":"range_response_count:1 size:16961"} {"level":"warn","ts":"2026-03-20T05:26:37.279437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.81493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-03-20T05:26:37.279473Z","caller":"traceutil/trace.go:171","msg":"trace[1924779438] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:568; }","duration":"112.899903ms","start":"2026-03-20T05:26:37.166561Z","end":"2026-03-20T05:26:37.279461Z","steps":["trace[1924779438] 'agreement among raft nodes before linearized reading' (duration: 112.717647ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:37.279496Z","caller":"traceutil/trace.go:171","msg":"trace[815277943] range","detail":"{range_begin:/registry/pods/kube-system/cilium-qs96b; range_end:; response_count:1; response_revision:568; }","duration":"492.67047ms","start":"2026-03-20T05:26:36.786778Z","end":"2026-03-20T05:26:37.279449Z","steps":["trace[815277943] 'agreement among raft nodes before linearized reading' (duration: 492.471875ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:37.279562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:36.78676Z","time spent":"492.788883ms","remote":"127.0.0.1:47106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16985,"request content":"key:\"/registry/pods/kube-system/cilium-qs96b\" "} {"level":"info","ts":"2026-03-20T05:26:37.279783Z","caller":"traceutil/trace.go:171","msg":"trace[1798030488] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"525.620953ms","start":"2026-03-20T05:26:36.753574Z","end":"2026-03-20T05:26:37.279195Z","steps":["trace[1798030488] 'process raft request' (duration: 525.452118ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:37.279882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:36.75353Z","time spent":"526.309345ms","remote":"127.0.0.1:47004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":688,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-20T05:26:37.510739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.846698ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-20T05:26:37.510844Z","caller":"traceutil/trace.go:171","msg":"trace[2108243900] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"226.8858ms","start":"2026-03-20T05:26:37.283939Z","end":"2026-03-20T05:26:37.510825Z","steps":["trace[2108243900] 'process raft request' (duration: 83.852965ms)","trace[2108243900] 'compare' (duration: 142.718835ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:26:38.136382Z","caller":"traceutil/trace.go:171","msg":"trace[184083687] linearizableReadLoop","detail":"{readStateIndex:588; appliedIndex:587; }","duration":"450.200422ms","start":"2026-03-20T05:26:37.686155Z","end":"2026-03-20T05:26:38.136356Z","steps":["trace[184083687] 'read index received' (duration: 425.478291ms)","trace[184083687] 'applied index is now lower than readState.Index' (duration: 24.721191ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:26:38.136642Z","caller":"traceutil/trace.go:171","msg":"trace[238667927] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"842.210219ms","start":"2026-03-20T05:26:37.294419Z","end":"2026-03-20T05:26:38.136629Z","steps":["trace[238667927] 'process raft request' (duration: 817.337322ms)","trace[238667927] 'compare' (duration: 24.503395ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T05:26:38.136739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:37.294394Z","time spent":"842.282211ms","remote":"127.0.0.1:47106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-20T05:26:38.137076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.021692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-03-20T05:26:38.137154Z","caller":"traceutil/trace.go:171","msg":"trace[102608292] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:570; }","duration":"271.134504ms","start":"2026-03-20T05:26:37.865999Z","end":"2026-03-20T05:26:38.137134Z","steps":["trace[102608292] 'agreement among raft nodes before linearized reading' (duration: 270.963639ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:38.137185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.039496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-03-20T05:26:38.137075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.062605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-03-20T05:26:38.137234Z","caller":"traceutil/trace.go:171","msg":"trace[1590300502] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:570; }","duration":"451.069927ms","start":"2026-03-20T05:26:37.686139Z","end":"2026-03-20T05:26:38.137209Z","steps":["trace[1590300502] 'agreement among raft nodes before linearized reading' (duration: 450.992625ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:38.137249Z","caller":"traceutil/trace.go:171","msg":"trace[814203232] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:570; }","duration":"392.274271ms","start":"2026-03-20T05:26:37.744954Z","end":"2026-03-20T05:26:38.137229Z","steps":["trace[814203232] 'agreement among raft nodes before linearized reading' (duration: 391.916231ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:38.137267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:37.686084Z","time spent":"451.174681ms","remote":"127.0.0.1:47176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-03-20T05:26:38.137289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:37.744929Z","time spent":"392.348913ms","remote":"127.0.0.1:47176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-03-20T05:26:38.137076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.491609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T05:26:38.13735Z","caller":"traceutil/trace.go:171","msg":"trace[1957862331] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:570; }","duration":"347.822308ms","start":"2026-03-20T05:26:37.78952Z","end":"2026-03-20T05:26:38.137342Z","steps":["trace[1957862331] 'agreement among raft nodes before linearized reading' (duration: 347.500539ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:38.137374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:37.789492Z","time spent":"347.87676ms","remote":"127.0.0.1:46918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-20T05:26:38.716735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.103009ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-20T05:26:38.716914Z","caller":"traceutil/trace.go:171","msg":"trace[474341999] linearizableReadLoop","detail":"{readStateIndex:591; appliedIndex:588; }","duration":"574.620433ms","start":"2026-03-20T05:26:38.142276Z","end":"2026-03-20T05:26:38.716897Z","steps":["trace[474341999] 'read index received' (duration: 40.680378ms)","trace[474341999] 'applied index is now lower than readState.Index' (duration: 533.938985ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:26:38.716911Z","caller":"traceutil/trace.go:171","msg":"trace[1556539095] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"574.673365ms","start":"2026-03-20T05:26:38.142212Z","end":"2026-03-20T05:26:38.716885Z","steps":["trace[1556539095] 'process raft request' (duration: 101.291528ms)","trace[1556539095] 'compare' (duration: 472.984855ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T05:26:38.717028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:38.142198Z","time spent":"574.758748ms","remote":"127.0.0.1:47176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-20T05:26:38.717069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.793699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-qs96b\" ","response":"range_response_count:1 size:17145"} {"level":"info","ts":"2026-03-20T05:26:38.717097Z","caller":"traceutil/trace.go:171","msg":"trace[1673944185] range","detail":"{range_begin:/registry/pods/kube-system/cilium-qs96b; range_end:; response_count:1; response_revision:573; }","duration":"574.86092ms","start":"2026-03-20T05:26:38.142227Z","end":"2026-03-20T05:26:38.717088Z","steps":["trace[1673944185] 'agreement among raft nodes before linearized reading' (duration: 574.717346ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:38.717134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:38.142218Z","time spent":"574.908032ms","remote":"127.0.0.1:47106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":17169,"request content":"key:\"/registry/pods/kube-system/cilium-qs96b\" "} {"level":"info","ts":"2026-03-20T05:26:38.717271Z","caller":"traceutil/trace.go:171","msg":"trace[2109003609] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"574.987324ms","start":"2026-03-20T05:26:38.142259Z","end":"2026-03-20T05:26:38.717246Z","steps":["trace[2109003609] 'process raft request' (duration: 574.573242ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:38.71742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:38.14225Z","time spent":"575.073866ms","remote":"127.0.0.1:47176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-20T05:26:39.087302Z","caller":"traceutil/trace.go:171","msg":"trace[814114347] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"273.798541ms","start":"2026-03-20T05:26:38.81348Z","end":"2026-03-20T05:26:39.087279Z","steps":["trace[814114347] 'process raft request' (duration: 273.653526ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:40.587374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.072846522s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-03-20T05:26:40.58744Z","caller":"traceutil/trace.go:171","msg":"trace[1375541432] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:574; }","duration":"1.072958295s","start":"2026-03-20T05:26:39.514466Z","end":"2026-03-20T05:26:40.587424Z","steps":["trace[1375541432] 'range keys from in-memory index tree' (duration: 1.072684618s)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:40.587469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:39.514446Z","time spent":"1.073016297s","remote":"127.0.0.1:47176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-03-20T05:26:40.587524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"798.340792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T05:26:40.587617Z","caller":"traceutil/trace.go:171","msg":"trace[197623044] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:574; }","duration":"798.478976ms","start":"2026-03-20T05:26:39.789114Z","end":"2026-03-20T05:26:40.587593Z","steps":["trace[197623044] 'range keys from in-memory index tree' (duration: 798.26834ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:40.58767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:39.789094Z","time spent":"798.561757ms","remote":"127.0.0.1:46918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-20T05:26:40.587806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.005521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-03-20T05:26:40.587935Z","caller":"traceutil/trace.go:171","msg":"trace[1970225945] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:574; }","duration":"400.160956ms","start":"2026-03-20T05:26:40.18772Z","end":"2026-03-20T05:26:40.587881Z","steps":["trace[1970225945] 'range keys from in-memory index tree' (duration: 399.706222ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:40.587985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:40.187701Z","time spent":"400.273639ms","remote":"127.0.0.1:47176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-03-20T05:26:41.657645Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.020047909s","expected-duration":"1s"} {"level":"warn","ts":"2026-03-20T05:26:41.678878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.04128276s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-03-20T05:26:41.679281Z","caller":"traceutil/trace.go:171","msg":"trace[1977347260] linearizableReadLoop","detail":"{readStateIndex:593; appliedIndex:592; }","duration":"1.090371864s","start":"2026-03-20T05:26:40.588797Z","end":"2026-03-20T05:26:41.679168Z","steps":["trace[1977347260] 'read index received' (duration: 48.772064ms)","trace[1977347260] 'applied index is now lower than readState.Index' (duration: 1.04159541s)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:26:41.679465Z","caller":"traceutil/trace.go:171","msg":"trace[1970084386] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"1.087294495s","start":"2026-03-20T05:26:40.592108Z","end":"2026-03-20T05:26:41.679402Z","steps":["trace[1970084386] 'process raft request' (duration: 1.086880844s)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:41.679723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:40.592098Z","time spent":"1.08745713s","remote":"127.0.0.1:47176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-20T05:26:41.748221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.159400315s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T05:26:41.748285Z","caller":"traceutil/trace.go:171","msg":"trace[1977982399] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:575; }","duration":"1.159486217s","start":"2026-03-20T05:26:40.58878Z","end":"2026-03-20T05:26:41.748266Z","steps":["trace[1977982399] 'agreement among raft nodes before linearized reading' (duration: 1.090640641s)","trace[1977982399] 'range keys from in-memory index tree' (duration: 68.744624ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T05:26:41.748378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:40.588767Z","time spent":"1.159603401s","remote":"127.0.0.1:46922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-03-20T05:26:41.7488Z","caller":"traceutil/trace.go:171","msg":"trace[1392924004] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"1.15612371s","start":"2026-03-20T05:26:40.592663Z","end":"2026-03-20T05:26:41.748787Z","steps":["trace[1392924004] 'process raft request' (duration: 1.086713229s)","trace[1392924004] 'compare' (duration: 68.872986ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T05:26:41.748878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:40.592642Z","time spent":"1.156182911s","remote":"127.0.0.1:47176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-20T05:26:41.74902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.026498107s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-03-20T05:26:41.749051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.023238623s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-03-20T05:26:41.749406Z","caller":"traceutil/trace.go:171","msg":"trace[1173345846] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:576; }","duration":"1.023638705s","start":"2026-03-20T05:26:40.72574Z","end":"2026-03-20T05:26:41.749378Z","steps":["trace[1173345846] 'agreement among raft nodes before linearized reading' (duration: 1.023083658s)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:41.749457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:40.725709Z","time spent":"1.023735707s","remote":"127.0.0.1:47176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-03-20T05:26:41.749814Z","caller":"traceutil/trace.go:171","msg":"trace[1618742531] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:576; }","duration":"1.026694013s","start":"2026-03-20T05:26:40.722429Z","end":"2026-03-20T05:26:41.749124Z","steps":["trace[1618742531] 'agreement among raft nodes before linearized reading' (duration: 1.026293041s)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:41.749934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:40.722401Z","time spent":"1.027510845s","remote":"127.0.0.1:47176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-03-20T05:28:11.787513Z","caller":"traceutil/trace.go:171","msg":"trace[398623466] transaction","detail":"{read_only:false; response_revision:1020; number_of_response:1; }","duration":"179.874355ms","start":"2026-03-20T05:28:11.607613Z","end":"2026-03-20T05:28:11.787487Z","steps":["trace[398623466] 'process raft request' (duration: 179.726153ms)"],"step_count":1}