{"level":"warn","ts":"2026-08-06T07:06:54.00352Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-06T07:06:54.003607Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.14:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.14:2380","--initial-cluster=instance=https://199.19.213.14:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.14:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.14: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-08-06T07:06:54.003684Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-06T07:06:54.003697Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.14:2380"]} {"level":"info","ts":"2026-08-06T07:06:54.003714Z","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-08-06T07:06:54.004504Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.14:2379"]} {"level":"info","ts":"2026-08-06T07:06:54.004625Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.14:2380"],"listen-peer-urls":["https://199.19.213.14:2380"],"advertise-client-urls":["https://199.19.213.14:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.14:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.14: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-08-06T07:06:54.009963Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.108754ms"} {"level":"info","ts":"2026-08-06T07:06:54.017322Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"329f95029c2a91ed","cluster-id":"5fd85759a04d0f9f"} {"level":"info","ts":"2026-08-06T07:06:54.017463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed switched to configuration voters=()"} {"level":"info","ts":"2026-08-06T07:06:54.017526Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed became follower at term 0"} {"level":"info","ts":"2026-08-06T07:06:54.017556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 329f95029c2a91ed [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-06T07:06:54.017581Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed became follower at term 1"} {"level":"info","ts":"2026-08-06T07:06:54.017654Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed switched to configuration voters=(3647798061635899885)"} {"level":"warn","ts":"2026-08-06T07:06:54.022994Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-06T07:06:54.024262Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-06T07:06:54.02544Z","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-08-06T07:06:54.02741Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"329f95029c2a91ed","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-06T07:06:54.027609Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"329f95029c2a91ed","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-06T07:06:54.02771Z","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-08-06T07:06:54.027793Z","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-08-06T07:06:54.027838Z","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-08-06T07:06:54.028888Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed switched to configuration voters=(3647798061635899885)"} {"level":"info","ts":"2026-08-06T07:06:54.029131Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5fd85759a04d0f9f","local-member-id":"329f95029c2a91ed","added-peer-id":"329f95029c2a91ed","added-peer-peer-urls":["https://199.19.213.14:2380"]} {"level":"info","ts":"2026-08-06T07:06:54.031122Z","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-08-06T07:06:54.031144Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.14:2380"} {"level":"info","ts":"2026-08-06T07:06:54.031185Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.14:2380"} {"level":"info","ts":"2026-08-06T07:06:54.031839Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"329f95029c2a91ed","initial-advertise-peer-urls":["https://199.19.213.14:2380"],"listen-peer-urls":["https://199.19.213.14:2380"],"advertise-client-urls":["https://199.19.213.14:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.14:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-06T07:06:54.031873Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-06T07:06:54.718368Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed is starting a new election at term 1"} {"level":"info","ts":"2026-08-06T07:06:54.718412Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed became pre-candidate at term 1"} {"level":"info","ts":"2026-08-06T07:06:54.718425Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed received MsgPreVoteResp from 329f95029c2a91ed at term 1"} {"level":"info","ts":"2026-08-06T07:06:54.718436Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed became candidate at term 2"} {"level":"info","ts":"2026-08-06T07:06:54.718441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed received MsgVoteResp from 329f95029c2a91ed at term 2"} {"level":"info","ts":"2026-08-06T07:06:54.71845Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed became leader at term 2"} {"level":"info","ts":"2026-08-06T07:06:54.718457Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 329f95029c2a91ed elected leader 329f95029c2a91ed at term 2"} {"level":"info","ts":"2026-08-06T07:06:54.919117Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-06T07:06:55.051664Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"329f95029c2a91ed","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.14:2379]}","request-path":"/0/members/329f95029c2a91ed/attributes","cluster-id":"5fd85759a04d0f9f","publish-timeout":"7s"} {"level":"info","ts":"2026-08-06T07:06:55.051669Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-06T07:06:55.051728Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-06T07:06:55.052421Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-06T07:06:55.052453Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-06T07:06:55.054856Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.14:2379"} {"level":"info","ts":"2026-08-06T07:06:55.055672Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-06T07:06:55.064604Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5fd85759a04d0f9f","local-member-id":"329f95029c2a91ed","cluster-version":"3.5"} {"level":"info","ts":"2026-08-06T07:06:55.064756Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-06T07:06:55.064796Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-08-06T07:06:55.389778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.954153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-06T07:06:55.389882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.993145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-06T07:06:55.389878Z","caller":"traceutil/trace.go:171","msg":"trace[1921906101] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"179.088688ms","start":"2026-08-06T07:06:55.210775Z","end":"2026-08-06T07:06:55.389864Z","steps":["trace[1921906101] 'count revisions from in-memory index tree' (duration: 178.877491ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:06:55.38995Z","caller":"traceutil/trace.go:171","msg":"trace[1473657067] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"179.053357ms","start":"2026-08-06T07:06:55.210876Z","end":"2026-08-06T07:06:55.389929Z","steps":["trace[1473657067] 'range keys from in-memory index tree' (duration: 178.902462ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:06:55.389973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.453444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-06T07:06:55.390058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.603431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-06T07:06:55.390093Z","caller":"traceutil/trace.go:171","msg":"trace[426319166] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"133.704872ms","start":"2026-08-06T07:06:55.256372Z","end":"2026-08-06T07:06:55.390077Z","steps":["trace[426319166] 'range keys from in-memory index tree' (duration: 133.395103ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:06:55.390196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.070046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-06T07:06:55.390234Z","caller":"traceutil/trace.go:171","msg":"trace[1462279047] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"167.132528ms","start":"2026-08-06T07:06:55.223088Z","end":"2026-08-06T07:06:55.390221Z","steps":["trace[1462279047] 'range keys from in-memory index tree' (duration: 166.983443ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:06:55.390196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.335298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-06T07:06:55.390323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.659162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-06T07:06:55.390356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.050676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-06T07:06:55.390397Z","caller":"traceutil/trace.go:171","msg":"trace[1734723151] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"167.135279ms","start":"2026-08-06T07:06:55.223253Z","end":"2026-08-06T07:06:55.390388Z","steps":["trace[1734723151] 'count revisions from in-memory index tree' (duration: 166.978954ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:06:55.390395Z","caller":"traceutil/trace.go:171","msg":"trace[1043614167] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"204.591545ms","start":"2026-08-06T07:06:55.185731Z","end":"2026-08-06T07:06:55.390323Z","steps":["trace[1043614167] 'count revisions from in-memory index tree' (duration: 204.094069ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:06:55.390412Z","caller":"traceutil/trace.go:171","msg":"trace[2085105704] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"156.760906ms","start":"2026-08-06T07:06:55.233629Z","end":"2026-08-06T07:06:55.390389Z","steps":["trace[2085105704] 'count revisions from in-memory index tree' (duration: 156.616582ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:06:55.390549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.412319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-06T07:06:55.390544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.462522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-06T07:06:55.390586Z","caller":"traceutil/trace.go:171","msg":"trace[146493343] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"193.481482ms","start":"2026-08-06T07:06:55.197096Z","end":"2026-08-06T07:06:55.390577Z","steps":["trace[146493343] 'count revisions from in-memory index tree' (duration: 193.334488ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:06:55.390312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.647299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-06T07:06:55.390604Z","caller":"traceutil/trace.go:171","msg":"trace[74288011] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"219.570806ms","start":"2026-08-06T07:06:55.171018Z","end":"2026-08-06T07:06:55.390589Z","steps":["trace[74288011] 'count revisions from in-memory index tree' (duration: 219.38585ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:06:55.39063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.562566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-06T07:06:55.390751Z","caller":"traceutil/trace.go:171","msg":"trace[1833425871] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"120.708742ms","start":"2026-08-06T07:06:55.270029Z","end":"2026-08-06T07:06:55.390738Z","steps":["trace[1833425871] 'range keys from in-memory index tree' (duration: 120.457604ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:06:55.390543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.592668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-06T07:06:55.390897Z","caller":"traceutil/trace.go:171","msg":"trace[1287286530] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"120.973289ms","start":"2026-08-06T07:06:55.269914Z","end":"2026-08-06T07:06:55.390887Z","steps":["trace[1287286530] 'count revisions from in-memory index tree' (duration: 120.504014ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:06:55.390259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.438816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-06T07:06:55.390242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.753886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-06T07:06:55.391218Z","caller":"traceutil/trace.go:171","msg":"trace[608372837] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"147.199358ms","start":"2026-08-06T07:06:55.243795Z","end":"2026-08-06T07:06:55.390994Z","steps":["trace[608372837] 'count revisions from in-memory index tree' (duration: 146.340822ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:06:55.391284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.952638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-06T07:06:55.391321Z","caller":"traceutil/trace.go:171","msg":"trace[1521122817] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"110.015811ms","start":"2026-08-06T07:06:55.281295Z","end":"2026-08-06T07:06:55.391311Z","steps":["trace[1521122817] 'count revisions from in-memory index tree' (duration: 109.882816ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:06:55.390231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.248326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-06T07:06:55.391459Z","caller":"traceutil/trace.go:171","msg":"trace[1505831706] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"220.507444ms","start":"2026-08-06T07:06:55.17094Z","end":"2026-08-06T07:06:55.391448Z","steps":["trace[1505831706] 'range keys from in-memory index tree' (duration: 219.106742ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:06:55.391559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.431109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-06T07:06:55.391606Z","caller":"traceutil/trace.go:171","msg":"trace[1525762723] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"194.513972ms","start":"2026-08-06T07:06:55.197082Z","end":"2026-08-06T07:06:55.391596Z","steps":["trace[1525762723] 'range keys from in-memory index tree' (duration: 194.324346ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:06:55.391238Z","caller":"traceutil/trace.go:171","msg":"trace[1307250691] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"147.796566ms","start":"2026-08-06T07:06:55.243432Z","end":"2026-08-06T07:06:55.391229Z","steps":["trace[1307250691] 'range keys from in-memory index tree' (duration: 146.687413ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:06:55.391237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.893566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-06T07:06:55.39177Z","caller":"traceutil/trace.go:171","msg":"trace[1940040107] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"110.429402ms","start":"2026-08-06T07:06:55.281331Z","end":"2026-08-06T07:06:55.39176Z","steps":["trace[1940040107] 'range keys from in-memory index tree' (duration: 109.855025ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:06:55.389802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.332791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-06T07:06:55.390686Z","caller":"traceutil/trace.go:171","msg":"trace[130343325] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1; }","duration":"236.055712ms","start":"2026-08-06T07:06:55.154617Z","end":"2026-08-06T07:06:55.390673Z","steps":["trace[130343325] 'count revisions from in-memory index tree' (duration: 235.537676ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:06:55.391998Z","caller":"traceutil/trace.go:171","msg":"trace[1677586271] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"135.577399ms","start":"2026-08-06T07:06:55.256412Z","end":"2026-08-06T07:06:55.391989Z","steps":["trace[1677586271] 'count revisions from in-memory index tree' (duration: 133.28803ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:06:55.390145Z","caller":"traceutil/trace.go:171","msg":"trace[714061025] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"156.730035ms","start":"2026-08-06T07:06:55.233397Z","end":"2026-08-06T07:06:55.390127Z","steps":["trace[714061025] 'range keys from in-memory index tree' (duration: 156.546ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:06:55.390767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.953765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-06T07:06:55.392581Z","caller":"traceutil/trace.go:171","msg":"trace[1367074593] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"206.765109ms","start":"2026-08-06T07:06:55.185802Z","end":"2026-08-06T07:06:55.392567Z","steps":["trace[1367074593] 'range keys from in-memory index tree' (duration: 204.783641ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:05.109329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.344216ms","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-08-06T07:07:05.109425Z","caller":"traceutil/trace.go:171","msg":"trace[1689936097] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:386; }","duration":"259.499572ms","start":"2026-08-06T07:07:04.849906Z","end":"2026-08-06T07:07:05.109406Z","steps":["trace[1689936097] 'range keys from in-memory index tree' (duration: 259.185901ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:05.109412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.793845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4322"} {"level":"info","ts":"2026-08-06T07:07:05.109537Z","caller":"traceutil/trace.go:171","msg":"trace[113179090] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:386; }","duration":"235.96768ms","start":"2026-08-06T07:07:04.873548Z","end":"2026-08-06T07:07:05.109516Z","steps":["trace[113179090] 'range keys from in-memory index tree' (duration: 235.688301ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:05.429456Z","caller":"traceutil/trace.go:171","msg":"trace[204914297] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"315.804609ms","start":"2026-08-06T07:07:05.113632Z","end":"2026-08-06T07:07:05.429437Z","steps":["trace[204914297] 'process raft request' (duration: 315.681185ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:05.430055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:05.113616Z","time spent":"315.899241ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:07:05.649797Z","caller":"traceutil/trace.go:171","msg":"trace[205025540] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"532.926267ms","start":"2026-08-06T07:07:05.116844Z","end":"2026-08-06T07:07:05.64977Z","steps":["trace[205025540] 'process raft request' (duration: 532.860506ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:05.649934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:05.116835Z","time spent":"533.02712ms","remote":"127.0.0.1:53500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4115,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:07:05.649962Z","caller":"traceutil/trace.go:171","msg":"trace[826671462] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"535.128892ms","start":"2026-08-06T07:07:05.114641Z","end":"2026-08-06T07:07:05.64977Z","steps":["trace[826671462] 'process raft request' (duration: 534.883615ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:05.650017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:05.114621Z","time spent":"535.36636ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:07:06.832304Z","caller":"traceutil/trace.go:171","msg":"trace[627574792] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"215.434238ms","start":"2026-08-06T07:07:06.616843Z","end":"2026-08-06T07:07:06.832277Z","steps":["trace[627574792] 'process raft request' (duration: 215.239862ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:06.967136Z","caller":"traceutil/trace.go:171","msg":"trace[13187925] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"230.856107ms","start":"2026-08-06T07:07:06.736258Z","end":"2026-08-06T07:07:06.967114Z","steps":["trace[13187925] 'process raft request' (duration: 174.695614ms)","trace[13187925] 'compare' (duration: 56.067351ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:07:07.649357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.538922ms","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-08-06T07:07:07.649528Z","caller":"traceutil/trace.go:171","msg":"trace[44587672] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:392; }","duration":"549.735628ms","start":"2026-08-06T07:07:07.099774Z","end":"2026-08-06T07:07:07.64951Z","steps":["trace[44587672] 'range keys from in-memory index tree' (duration: 549.519811ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:07.664924Z","caller":"traceutil/trace.go:171","msg":"trace[150058051] linearizableReadLoop","detail":"{readStateIndex:406; appliedIndex:405; }","duration":"231.103255ms","start":"2026-08-06T07:07:07.433798Z","end":"2026-08-06T07:07:07.664902Z","steps":["trace[150058051] 'read index received' (duration: 230.962591ms)","trace[150058051] 'applied index is now lower than readState.Index' (duration: 139.674µs)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:07:07.664953Z","caller":"traceutil/trace.go:171","msg":"trace[1824607943] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"457.053866ms","start":"2026-08-06T07:07:07.207872Z","end":"2026-08-06T07:07:07.664926Z","steps":["trace[1824607943] 'process raft request' (duration: 456.893362ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:07.665134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.334391ms","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-08-06T07:07:07.665194Z","caller":"traceutil/trace.go:171","msg":"trace[647918054] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:393; }","duration":"231.453706ms","start":"2026-08-06T07:07:07.433727Z","end":"2026-08-06T07:07:07.665181Z","steps":["trace[647918054] 'agreement among raft nodes before linearized reading' (duration: 231.299641ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:07.665159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:07.207846Z","time spent":"457.255473ms","remote":"127.0.0.1:53384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":777,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-06T07:07:07.927143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.191136ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-06T07:07:07.927309Z","caller":"traceutil/trace.go:171","msg":"trace[614861521] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"256.699167ms","start":"2026-08-06T07:07:07.670595Z","end":"2026-08-06T07:07:07.927294Z","steps":["trace[614861521] 'process raft request' (duration: 256.631966ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:07.927662Z","caller":"traceutil/trace.go:171","msg":"trace[1535132403] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"257.064049ms","start":"2026-08-06T07:07:07.670586Z","end":"2026-08-06T07:07:07.92765Z","steps":["trace[1535132403] 'process raft request' (duration: 114.164332ms)","trace[1535132403] 'compare' (duration: 142.094793ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:07:08.25532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.904301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.14\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-08-06T07:07:08.255373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.301749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T07:07:08.255406Z","caller":"traceutil/trace.go:171","msg":"trace[1280331148] range","detail":"{range_begin:/registry/masterleases/199.19.213.14; range_end:; response_count:1; response_revision:395; }","duration":"172.043726ms","start":"2026-08-06T07:07:08.083345Z","end":"2026-08-06T07:07:08.255389Z","steps":["trace[1280331148] 'range keys from in-memory index tree' (duration: 171.78648ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:08.255431Z","caller":"traceutil/trace.go:171","msg":"trace[24013632] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:395; }","duration":"197.400461ms","start":"2026-08-06T07:07:08.058015Z","end":"2026-08-06T07:07:08.255416Z","steps":["trace[24013632] 'range keys from in-memory index tree' (duration: 197.205225ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:08.589974Z","caller":"traceutil/trace.go:171","msg":"trace[647279634] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"246.0578ms","start":"2026-08-06T07:07:08.343889Z","end":"2026-08-06T07:07:08.589947Z","steps":["trace[647279634] 'process raft request' (duration: 155.267805ms)","trace[647279634] 'compare' (duration: 90.660971ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:07:08.653342Z","caller":"traceutil/trace.go:171","msg":"trace[1595122132] linearizableReadLoop","detail":"{readStateIndex:412; appliedIndex:409; }","duration":"187.61745ms","start":"2026-08-06T07:07:08.4657Z","end":"2026-08-06T07:07:08.653318Z","steps":["trace[1595122132] 'read index received' (duration: 33.361754ms)","trace[1595122132] 'applied index is now lower than readState.Index' (duration: 154.254725ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:07:08.653391Z","caller":"traceutil/trace.go:171","msg":"trace[2083349459] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"306.668286ms","start":"2026-08-06T07:07:08.346686Z","end":"2026-08-06T07:07:08.653354Z","steps":["trace[2083349459] 'process raft request' (duration: 306.426419ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:08.653458Z","caller":"traceutil/trace.go:171","msg":"trace[1203103098] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"292.967038ms","start":"2026-08-06T07:07:08.36048Z","end":"2026-08-06T07:07:08.653447Z","steps":["trace[1203103098] 'process raft request' (duration: 292.783002ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:08.653554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:08.34667Z","time spent":"306.801801ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:07:08.65362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.903107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T07:07:08.653656Z","caller":"traceutil/trace.go:171","msg":"trace[1459635711] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:398; }","duration":"187.981191ms","start":"2026-08-06T07:07:08.465662Z","end":"2026-08-06T07:07:08.653643Z","steps":["trace[1459635711] 'agreement among raft nodes before linearized reading' (duration: 187.919129ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:09.150798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.210551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7294"} {"level":"warn","ts":"2026-08-06T07:07:09.150812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.060336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-06T07:07:09.150875Z","caller":"traceutil/trace.go:171","msg":"trace[180103688] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:398; }","duration":"266.531291ms","start":"2026-08-06T07:07:08.884325Z","end":"2026-08-06T07:07:09.150857Z","steps":["trace[180103688] 'range keys from in-memory index tree' (duration: 265.995105ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:09.150882Z","caller":"traceutil/trace.go:171","msg":"trace[1566838017] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:398; }","duration":"314.377826ms","start":"2026-08-06T07:07:08.836488Z","end":"2026-08-06T07:07:09.150866Z","steps":["trace[1566838017] 'range keys from in-memory index tree' (duration: 313.928833ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:09.150976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:08.836466Z","time spent":"314.49686ms","remote":"127.0.0.1:53576","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-08-06T07:07:09.664887Z","caller":"traceutil/trace.go:171","msg":"trace[909341467] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"503.260563ms","start":"2026-08-06T07:07:09.161594Z","end":"2026-08-06T07:07:09.664854Z","steps":["trace[909341467] 'process raft request' (duration: 443.565755ms)","trace[909341467] 'compare' (duration: 59.523024ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:07:09.665073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:09.161566Z","time spent":"503.407009ms","remote":"127.0.0.1:53500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7087,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:07:09.665106Z","caller":"traceutil/trace.go:171","msg":"trace[692391695] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"465.477289ms","start":"2026-08-06T07:07:09.199609Z","end":"2026-08-06T07:07:09.665086Z","steps":["trace[692391695] 'process raft request' (duration: 465.20059ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:09.66509Z","caller":"traceutil/trace.go:171","msg":"trace[1876294039] linearizableReadLoop","detail":"{readStateIndex:415; appliedIndex:413; }","duration":"354.840512ms","start":"2026-08-06T07:07:09.310212Z","end":"2026-08-06T07:07:09.665052Z","steps":["trace[1876294039] 'read index received' (duration: 294.860085ms)","trace[1876294039] 'applied index is now lower than readState.Index' (duration: 59.978337ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:07:09.665225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.002048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4368"} {"level":"warn","ts":"2026-08-06T07:07:09.665255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:09.199583Z","time spent":"465.594261ms","remote":"127.0.0.1:53384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-06T07:07:09.665279Z","caller":"traceutil/trace.go:171","msg":"trace[466694645] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:401; }","duration":"355.090959ms","start":"2026-08-06T07:07:09.310172Z","end":"2026-08-06T07:07:09.665263Z","steps":["trace[466694645] 'agreement among raft nodes before linearized reading' (duration: 354.961385ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:09.665318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:09.310152Z","time spent":"355.155522ms","remote":"127.0.0.1:53494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4390,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-08-06T07:07:09.665407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.453482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T07:07:09.665472Z","caller":"traceutil/trace.go:171","msg":"trace[1445430728] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:401; }","duration":"200.571516ms","start":"2026-08-06T07:07:09.464883Z","end":"2026-08-06T07:07:09.665455Z","steps":["trace[1445430728] 'agreement among raft nodes before linearized reading' (duration: 200.442342ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:10.318797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.758938ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-08-06T07:07:10.318896Z","caller":"traceutil/trace.go:171","msg":"trace[1275229924] linearizableReadLoop","detail":"{readStateIndex:417; appliedIndex:416; }","duration":"428.162595ms","start":"2026-08-06T07:07:09.890718Z","end":"2026-08-06T07:07:10.31888Z","steps":["trace[1275229924] 'read index received' (duration: 210.319976ms)","trace[1275229924] 'applied index is now lower than readState.Index' (duration: 217.840939ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:07:10.318978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:09.714375Z","time spent":"604.600002ms","remote":"127.0.0.1:53794","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-08-06T07:07:10.31907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.349492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-jhb2v\" ","response":"range_response_count:1 size:4462"} {"level":"info","ts":"2026-08-06T07:07:10.319155Z","caller":"traceutil/trace.go:171","msg":"trace[1186395240] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-jhb2v; range_end:; response_count:1; response_revision:402; }","duration":"428.481215ms","start":"2026-08-06T07:07:09.890658Z","end":"2026-08-06T07:07:10.31914Z","steps":["trace[1186395240] 'agreement among raft nodes before linearized reading' (duration: 428.3042ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:10.319228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:09.890636Z","time spent":"428.581159ms","remote":"127.0.0.1:53500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":4484,"request content":"key:\"/registry/pods/kube-system/kube-proxy-jhb2v\" "} {"level":"info","ts":"2026-08-06T07:07:10.352055Z","caller":"traceutil/trace.go:171","msg":"trace[119418368] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"432.592118ms","start":"2026-08-06T07:07:09.919439Z","end":"2026-08-06T07:07:10.352031Z","steps":["trace[119418368] 'process raft request' (duration: 432.429064ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:10.352225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:09.919413Z","time spent":"432.721091ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:07:10.35222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.850568ms","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-08-06T07:07:10.35229Z","caller":"traceutil/trace.go:171","msg":"trace[2025426280] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:403; }","duration":"421.022223ms","start":"2026-08-06T07:07:09.931249Z","end":"2026-08-06T07:07:10.352272Z","steps":["trace[2025426280] 'agreement among raft nodes before linearized reading' (duration: 420.780386ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:10.35235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:09.931228Z","time spent":"421.108816ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-06T07:07:10.352374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.675203ms","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-08-06T07:07:10.352502Z","caller":"traceutil/trace.go:171","msg":"trace[110373699] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:403; }","duration":"420.865299ms","start":"2026-08-06T07:07:09.931618Z","end":"2026-08-06T07:07:10.352483Z","steps":["trace[110373699] 'agreement among raft nodes before linearized reading' (duration: 420.613701ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:10.352579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:09.931609Z","time spent":"420.948861ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-06T07:07:10.556432Z","caller":"traceutil/trace.go:171","msg":"trace[1029464925] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"236.088683ms","start":"2026-08-06T07:07:10.320325Z","end":"2026-08-06T07:07:10.556414Z","steps":["trace[1029464925] 'process raft request' (duration: 235.899267ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:10.557111Z","caller":"traceutil/trace.go:171","msg":"trace[1002318723] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"230.728993ms","start":"2026-08-06T07:07:10.326372Z","end":"2026-08-06T07:07:10.557101Z","steps":["trace[1002318723] 'process raft request' (duration: 229.977161ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:11.188589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.75571ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-06T07:07:11.188794Z","caller":"traceutil/trace.go:171","msg":"trace[206636923] linearizableReadLoop","detail":"{readStateIndex:423; appliedIndex:420; }","duration":"528.97994ms","start":"2026-08-06T07:07:10.659804Z","end":"2026-08-06T07:07:11.188784Z","steps":["trace[206636923] 'read index received' (duration: 443.75019ms)","trace[206636923] 'applied index is now lower than readState.Index' (duration: 85.22897ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:07:11.188792Z","caller":"traceutil/trace.go:171","msg":"trace[1567342478] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"832.917384ms","start":"2026-08-06T07:07:10.355848Z","end":"2026-08-06T07:07:11.188766Z","steps":["trace[1567342478] 'process raft request' (duration: 291.915006ms)","trace[1567342478] 'compare' (duration: 540.564525ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:07:11.18886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.063243ms","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-08-06T07:07:11.188879Z","caller":"traceutil/trace.go:171","msg":"trace[94174917] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:408; }","duration":"529.118643ms","start":"2026-08-06T07:07:10.659753Z","end":"2026-08-06T07:07:11.188872Z","steps":["trace[94174917] 'agreement among raft nodes before linearized reading' (duration: 529.065141ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:11.188913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:10.659733Z","time spent":"529.173856ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-06T07:07:11.18892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:10.355825Z","time spent":"833.021258ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:07:11.189056Z","caller":"traceutil/trace.go:171","msg":"trace[1060607342] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"832.012837ms","start":"2026-08-06T07:07:10.357036Z","end":"2026-08-06T07:07:11.189049Z","steps":["trace[1060607342] 'process raft request' (duration: 831.633326ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:11.189093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:10.357018Z","time spent":"832.051928ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:07:11.189207Z","caller":"traceutil/trace.go:171","msg":"trace[1887919352] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"623.047863ms","start":"2026-08-06T07:07:10.566153Z","end":"2026-08-06T07:07:11.189201Z","steps":["trace[1887919352] 'process raft request' (duration: 622.570488ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:11.189239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:10.566135Z","time spent":"623.086464ms","remote":"127.0.0.1:53750","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2903,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:07:11.464777Z","caller":"traceutil/trace.go:171","msg":"trace[1195036030] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"217.302804ms","start":"2026-08-06T07:07:11.247442Z","end":"2026-08-06T07:07:11.464745Z","steps":["trace[1195036030] 'process raft request' (duration: 143.236248ms)","trace[1195036030] 'compare' (duration: 73.875101ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:07:12.659848Z","caller":"traceutil/trace.go:171","msg":"trace[5365212] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"203.545964ms","start":"2026-08-06T07:07:12.456267Z","end":"2026-08-06T07:07:12.659813Z","steps":["trace[5365212] 'process raft request' (duration: 203.309307ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:13.231645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.805254ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-06T07:07:13.231835Z","caller":"traceutil/trace.go:171","msg":"trace[2145905189] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"560.143268ms","start":"2026-08-06T07:07:12.671667Z","end":"2026-08-06T07:07:13.23181Z","steps":["trace[2145905189] 'process raft request' (duration: 269.071437ms)","trace[2145905189] 'compare' (duration: 290.654618ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:07:13.232454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:12.671645Z","time spent":"560.754687ms","remote":"127.0.0.1:53500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6736,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:07:13.814736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.30848ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-06T07:07:13.814988Z","caller":"traceutil/trace.go:171","msg":"trace[91602345] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"577.212066ms","start":"2026-08-06T07:07:13.237756Z","end":"2026-08-06T07:07:13.814968Z","steps":["trace[91602345] 'process raft request' (duration: 577.135015ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:13.815024Z","caller":"traceutil/trace.go:171","msg":"trace[31738967] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"577.648339ms","start":"2026-08-06T07:07:13.237339Z","end":"2026-08-06T07:07:13.814987Z","steps":["trace[31738967] 'process raft request' (duration: 577.504215ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:13.815066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:13.23774Z","time spent":"577.2873ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:07:13.815262Z","caller":"traceutil/trace.go:171","msg":"trace[439346432] linearizableReadLoop","detail":"{readStateIndex:430; appliedIndex:427; }","duration":"351.873594ms","start":"2026-08-06T07:07:13.46336Z","end":"2026-08-06T07:07:13.815234Z","steps":["trace[439346432] 'read index received' (duration: 41.952µs)","trace[439346432] 'applied index is now lower than readState.Index' (duration: 351.829652ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:07:13.815571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:13.23731Z","time spent":"577.791414ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:07:13.815663Z","caller":"traceutil/trace.go:171","msg":"trace[1469584062] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"579.258797ms","start":"2026-08-06T07:07:13.236358Z","end":"2026-08-06T07:07:13.815617Z","steps":["trace[1469584062] 'process raft request' (duration: 151.989868ms)","trace[1469584062] 'compare' (duration: 426.167636ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:07:13.815825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:13.236337Z","time spent":"579.405272ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:07:14.227492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.54727ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"warn","ts":"2026-08-06T07:07:14.227501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"764.115654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T07:07:14.227618Z","caller":"traceutil/trace.go:171","msg":"trace[1083249113] linearizableReadLoop","detail":"{readStateIndex:431; appliedIndex:430; }","duration":"412.292974ms","start":"2026-08-06T07:07:13.815302Z","end":"2026-08-06T07:07:14.227595Z","steps":["trace[1083249113] 'read index received' (duration: 41.962µs)","trace[1083249113] 'applied index is now lower than readState.Index' (duration: 412.249232ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:07:14.227677Z","caller":"traceutil/trace.go:171","msg":"trace[341726078] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:415; }","duration":"764.323381ms","start":"2026-08-06T07:07:13.46331Z","end":"2026-08-06T07:07:14.227633Z","steps":["trace[341726078] 'agreement among raft nodes before linearized reading' (duration: 352.029268ms)","trace[341726078] 'range keys from in-memory index tree' (duration: 412.066797ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:07:14.227731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:13.463288Z","time spent":"764.425314ms","remote":"127.0.0.1:53318","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-06T07:07:14.22774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"758.699994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-06T07:07:14.227781Z","caller":"traceutil/trace.go:171","msg":"trace[1857294921] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:415; }","duration":"758.774255ms","start":"2026-08-06T07:07:13.468992Z","end":"2026-08-06T07:07:14.227767Z","steps":["trace[1857294921] 'agreement among raft nodes before linearized reading' (duration: 758.665041ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:14.227832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:13.468974Z","time spent":"758.847078ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-06T07:07:14.354647Z","caller":"traceutil/trace.go:171","msg":"trace[2061072631] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"122.636524ms","start":"2026-08-06T07:07:14.231991Z","end":"2026-08-06T07:07:14.354627Z","steps":["trace[2061072631] 'process raft request' (duration: 122.4734ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:15.984666Z","caller":"traceutil/trace.go:171","msg":"trace[1209946293] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"160.75634ms","start":"2026-08-06T07:07:15.823881Z","end":"2026-08-06T07:07:15.984637Z","steps":["trace[1209946293] 'process raft request' (duration: 160.683767ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:15.984733Z","caller":"traceutil/trace.go:171","msg":"trace[1263012831] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"160.829491ms","start":"2026-08-06T07:07:15.823881Z","end":"2026-08-06T07:07:15.98471Z","steps":["trace[1263012831] 'process raft request' (duration: 160.556704ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:16.025592Z","caller":"traceutil/trace.go:171","msg":"trace[388109382] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"200.663099ms","start":"2026-08-06T07:07:15.824904Z","end":"2026-08-06T07:07:16.025567Z","steps":["trace[388109382] 'process raft request' (duration: 200.532664ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:18.21446Z","caller":"traceutil/trace.go:171","msg":"trace[1163180063] transaction","detail":"{read_only:false; response_revision:422; number_of_response:1; }","duration":"220.755517ms","start":"2026-08-06T07:07:17.993335Z","end":"2026-08-06T07:07:18.21409Z","steps":["trace[1163180063] 'process raft request' (duration: 220.582123ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:18.485968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.821603ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-06T07:07:18.486069Z","caller":"traceutil/trace.go:171","msg":"trace[301847744] linearizableReadLoop","detail":"{readStateIndex:439; appliedIndex:437; }","duration":"456.206133ms","start":"2026-08-06T07:07:18.029851Z","end":"2026-08-06T07:07:18.486057Z","steps":["trace[301847744] 'read index received' (duration: 183.9293ms)","trace[301847744] 'applied index is now lower than readState.Index' (duration: 272.269901ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:07:18.486089Z","caller":"traceutil/trace.go:171","msg":"trace[1873386288] transaction","detail":"{read_only:false; response_revision:423; number_of_response:1; }","duration":"492.454152ms","start":"2026-08-06T07:07:17.993609Z","end":"2026-08-06T07:07:18.486063Z","steps":["trace[1873386288] 'process raft request' (duration: 292.502104ms)","trace[1873386288] 'compare' (duration: 199.7083ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:07:18.486156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.927694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.14\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-08-06T07:07:18.486192Z","caller":"traceutil/trace.go:171","msg":"trace[548732443] range","detail":"{range_begin:/registry/masterleases/199.19.213.14; range_end:; response_count:1; response_revision:423; }","duration":"401.996187ms","start":"2026-08-06T07:07:18.084188Z","end":"2026-08-06T07:07:18.486184Z","steps":["trace[548732443] 'agreement among raft nodes before linearized reading' (duration: 401.940265ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:18.486207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:17.993598Z","time spent":"492.545374ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:07:18.486218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:18.084139Z","time spent":"402.072589ms","remote":"127.0.0.1:53342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":155,"request content":"key:\"/registry/masterleases/199.19.213.14\" "} {"level":"warn","ts":"2026-08-06T07:07:18.486161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.300274ms","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-08-06T07:07:18.486474Z","caller":"traceutil/trace.go:171","msg":"trace[1334384639] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:423; }","duration":"456.652675ms","start":"2026-08-06T07:07:18.02981Z","end":"2026-08-06T07:07:18.486462Z","steps":["trace[1334384639] 'agreement among raft nodes before linearized reading' (duration: 456.297455ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:18.486525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:18.029792Z","time spent":"456.708307ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-06T07:07:18.970872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.493832ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-06T07:07:18.971056Z","caller":"traceutil/trace.go:171","msg":"trace[1485201687] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"480.121944ms","start":"2026-08-06T07:07:18.490911Z","end":"2026-08-06T07:07:18.971033Z","steps":["trace[1485201687] 'process raft request' (duration: 277.358573ms)","trace[1485201687] 'compare' (duration: 202.343388ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:07:18.971142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:18.490892Z","time spent":"480.217626ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:07:18.971563Z","caller":"traceutil/trace.go:171","msg":"trace[262301848] transaction","detail":"{read_only:false; response_revision:426; number_of_response:1; }","duration":"444.809842ms","start":"2026-08-06T07:07:18.526741Z","end":"2026-08-06T07:07:18.971551Z","steps":["trace[262301848] 'process raft request' (duration: 444.76177ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:18.971608Z","caller":"traceutil/trace.go:171","msg":"trace[1032252689] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"479.808094ms","start":"2026-08-06T07:07:18.49178Z","end":"2026-08-06T07:07:18.971588Z","steps":["trace[1032252689] 'process raft request' (duration: 479.204886ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:18.971628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:18.526723Z","time spent":"444.870664ms","remote":"127.0.0.1:53342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:07:18.971707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:18.491772Z","time spent":"479.882266ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:07:20.328817Z","caller":"traceutil/trace.go:171","msg":"trace[363863731] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"105.809102ms","start":"2026-08-06T07:07:20.222983Z","end":"2026-08-06T07:07:20.328792Z","steps":["trace[363863731] 'process raft request' (duration: 105.585276ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:20.913722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.699407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T07:07:20.913813Z","caller":"traceutil/trace.go:171","msg":"trace[1294208153] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:427; }","duration":"449.823671ms","start":"2026-08-06T07:07:20.463968Z","end":"2026-08-06T07:07:20.913792Z","steps":["trace[1294208153] 'range keys from in-memory index tree' (duration: 449.624886ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:20.913722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.802737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-08-06T07:07:20.913857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:20.463953Z","time spent":"449.896034ms","remote":"127.0.0.1:53318","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-06T07:07:20.913908Z","caller":"traceutil/trace.go:171","msg":"trace[1206537687] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:427; }","duration":"423.016932ms","start":"2026-08-06T07:07:20.49085Z","end":"2026-08-06T07:07:20.913867Z","steps":["trace[1206537687] 'range keys from in-memory index tree' (duration: 422.688183ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:20.914048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:20.490834Z","time spent":"423.161847ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-06T07:07:20.914108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.599122ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-06T07:07:20.914214Z","caller":"traceutil/trace.go:171","msg":"trace[1308747991] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"376.498667ms","start":"2026-08-06T07:07:20.537696Z","end":"2026-08-06T07:07:20.914194Z","steps":["trace[1308747991] 'process raft request' (duration: 204.707019ms)","trace[1308747991] 'compare' (duration: 171.19367ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:07:20.914274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:20.537657Z","time spent":"376.587629ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:07:21.474639Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10515236446006854863,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-06T07:07:21.975843Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10515236446006854863,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-06T07:07:22.476383Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10515236446006854863,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-06T07:07:22.976857Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10515236446006854863,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-06T07:07:23.040298Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.119896468s","expected-duration":"1s"} {"level":"info","ts":"2026-08-06T07:07:23.040877Z","caller":"traceutil/trace.go:171","msg":"trace[714238101] linearizableReadLoop","detail":"{readStateIndex:446; appliedIndex:445; }","duration":"2.066331161s","start":"2026-08-06T07:07:20.974522Z","end":"2026-08-06T07:07:23.040853Z","steps":["trace[714238101] 'read index received' (duration: 2.066041403s)","trace[714238101] 'applied index is now lower than readState.Index' (duration: 288.528µs)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:07:23.041043Z","caller":"traceutil/trace.go:171","msg":"trace[825524866] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"2.1207013s","start":"2026-08-06T07:07:20.920313Z","end":"2026-08-06T07:07:23.041014Z","steps":["trace[825524866] 'process raft request' (duration: 2.120388591s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:23.04114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.066573078s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-06T07:07:23.041212Z","caller":"traceutil/trace.go:171","msg":"trace[1004375608] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:429; }","duration":"2.066702482s","start":"2026-08-06T07:07:20.974473Z","end":"2026-08-06T07:07:23.041175Z","steps":["trace[1004375608] 'agreement among raft nodes before linearized reading' (duration: 2.066567028s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:23.041304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.062678062s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-08-06T07:07:23.04134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:20.974453Z","time spent":"2.066843877s","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-06T07:07:23.041399Z","caller":"traceutil/trace.go:171","msg":"trace[2019555918] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:429; }","duration":"2.062814956s","start":"2026-08-06T07:07:20.978566Z","end":"2026-08-06T07:07:23.041381Z","steps":["trace[2019555918] 'agreement among raft nodes before linearized reading' (duration: 2.06262944s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:23.041449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:20.978544Z","time spent":"2.062891408s","remote":"127.0.0.1:53576","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-08-06T07:07:23.041313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.575483417s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-06T07:07:23.04146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:20.920294Z","time spent":"2.120870026s","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:07:23.041548Z","caller":"traceutil/trace.go:171","msg":"trace[766698611] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:429; }","duration":"1.575725734s","start":"2026-08-06T07:07:21.465796Z","end":"2026-08-06T07:07:23.041522Z","steps":["trace[766698611] 'agreement among raft nodes before linearized reading' (duration: 1.575447796s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:23.041318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"708.868559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-08-06T07:07:23.041611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:21.46575Z","time spent":"1.575848669s","remote":"127.0.0.1:53318","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-06T07:07:23.041612Z","caller":"traceutil/trace.go:171","msg":"trace[2047373817] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:429; }","duration":"709.21671ms","start":"2026-08-06T07:07:22.332381Z","end":"2026-08-06T07:07:23.041598Z","steps":["trace[2047373817] 'agreement among raft nodes before linearized reading' (duration: 708.830708ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:23.041727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:22.33236Z","time spent":"709.332944ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-06T07:07:23.509319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.402487ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-06T07:07:23.509607Z","caller":"traceutil/trace.go:171","msg":"trace[1140637059] linearizableReadLoop","detail":"{readStateIndex:449; appliedIndex:446; }","duration":"459.376796ms","start":"2026-08-06T07:07:23.050209Z","end":"2026-08-06T07:07:23.509586Z","steps":["trace[1140637059] 'read index received' (duration: 242.599567ms)","trace[1140637059] 'applied index is now lower than readState.Index' (duration: 216.775799ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:07:23.509702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.484609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T07:07:23.509708Z","caller":"traceutil/trace.go:171","msg":"trace[1653560617] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"462.417566ms","start":"2026-08-06T07:07:23.047268Z","end":"2026-08-06T07:07:23.509685Z","steps":["trace[1653560617] 'process raft request' (duration: 462.199729ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:23.50974Z","caller":"traceutil/trace.go:171","msg":"trace[1289605189] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:432; }","duration":"459.549151ms","start":"2026-08-06T07:07:23.050178Z","end":"2026-08-06T07:07:23.509727Z","steps":["trace[1289605189] 'agreement among raft nodes before linearized reading' (duration: 459.484428ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:23.509779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:23.050168Z","time spent":"459.600654ms","remote":"127.0.0.1:53318","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-06T07:07:23.509811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:23.047244Z","time spent":"462.51402ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:07:23.509801Z","caller":"traceutil/trace.go:171","msg":"trace[1317361326] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"462.461428ms","start":"2026-08-06T07:07:23.047308Z","end":"2026-08-06T07:07:23.509769Z","steps":["trace[1317361326] 'process raft request' (duration: 462.232101ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:23.50983Z","caller":"traceutil/trace.go:171","msg":"trace[311979885] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"463.300633ms","start":"2026-08-06T07:07:23.046468Z","end":"2026-08-06T07:07:23.509768Z","steps":["trace[311979885] 'process raft request' (duration: 246.38173ms)","trace[311979885] 'compare' (duration: 216.292424ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:07:23.509931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:23.047275Z","time spent":"462.584621ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:07:23.510318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:23.046443Z","time spent":"463.493089ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:07:24.160709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.935917ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-08-06T07:07:25.653914Z","caller":"traceutil/trace.go:171","msg":"trace[1932340144] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"118.287834ms","start":"2026-08-06T07:07:25.535604Z","end":"2026-08-06T07:07:25.653891Z","steps":["trace[1932340144] 'process raft request' (duration: 118.13504ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:26.191978Z","caller":"traceutil/trace.go:171","msg":"trace[1543755872] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"655.322384ms","start":"2026-08-06T07:07:25.536619Z","end":"2026-08-06T07:07:26.191942Z","steps":["trace[1543755872] 'process raft request' (duration: 655.278943ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:26.192286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:25.536611Z","time spent":"655.51959ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:07:26.192534Z","caller":"traceutil/trace.go:171","msg":"trace[1455101581] transaction","detail":"{read_only:false; response_revision:435; number_of_response:1; }","duration":"656.548891ms","start":"2026-08-06T07:07:25.535971Z","end":"2026-08-06T07:07:26.19252Z","steps":["trace[1455101581] 'process raft request' (duration: 655.794178ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:26.192687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:25.535944Z","time spent":"656.668415ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:07:26.649932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.409934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T07:07:26.650035Z","caller":"traceutil/trace.go:171","msg":"trace[1418500815] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:436; }","duration":"183.522058ms","start":"2026-08-06T07:07:26.46649Z","end":"2026-08-06T07:07:26.650012Z","steps":["trace[1418500815] 'range keys from in-memory index tree' (duration: 183.331092ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:28.063165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.7047ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-06T07:07:28.063284Z","caller":"traceutil/trace.go:171","msg":"trace[1600766551] linearizableReadLoop","detail":"{readStateIndex:456; appliedIndex:455; }","duration":"404.951534ms","start":"2026-08-06T07:07:27.658316Z","end":"2026-08-06T07:07:28.063268Z","steps":["trace[1600766551] 'read index received' (duration: 252.910575ms)","trace[1600766551] 'applied index is now lower than readState.Index' (duration: 152.039849ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:07:28.063352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.036677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-06T07:07:28.063383Z","caller":"traceutil/trace.go:171","msg":"trace[1727916246] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:438; }","duration":"405.109308ms","start":"2026-08-06T07:07:27.658265Z","end":"2026-08-06T07:07:28.063374Z","steps":["trace[1727916246] 'agreement among raft nodes before linearized reading' (duration: 405.047647ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:28.063372Z","caller":"traceutil/trace.go:171","msg":"trace[802505731] transaction","detail":"{read_only:false; response_revision:438; number_of_response:1; }","duration":"618.923559ms","start":"2026-08-06T07:07:27.444406Z","end":"2026-08-06T07:07:28.06333Z","steps":["trace[802505731] 'process raft request' (duration: 466.971292ms)","trace[802505731] 'compare' (duration: 151.405551ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:07:28.063426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:27.658235Z","time spent":"405.184041ms","remote":"127.0.0.1:53576","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-08-06T07:07:28.063529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:27.44437Z","time spent":"619.070223ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:07:28.400681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.787618ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"info","ts":"2026-08-06T07:07:28.400797Z","caller":"traceutil/trace.go:171","msg":"trace[1971029354] linearizableReadLoop","detail":"{readStateIndex:458; appliedIndex:457; }","duration":"204.532983ms","start":"2026-08-06T07:07:28.196244Z","end":"2026-08-06T07:07:28.400777Z","steps":["trace[1971029354] 'read index received' (duration: 83.55491ms)","trace[1971029354] 'applied index is now lower than readState.Index' (duration: 120.976423ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:07:28.401129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.853072ms","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-08-06T07:07:28.401173Z","caller":"traceutil/trace.go:171","msg":"trace[1971925210] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:439; }","duration":"205.025338ms","start":"2026-08-06T07:07:28.196134Z","end":"2026-08-06T07:07:28.40116Z","steps":["trace[1971925210] 'agreement among raft nodes before linearized reading' (duration: 204.910455ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:28.401263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.940956ms","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-08-06T07:07:28.401364Z","caller":"traceutil/trace.go:171","msg":"trace[263690599] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:439; }","duration":"204.095471ms","start":"2026-08-06T07:07:28.197243Z","end":"2026-08-06T07:07:28.401338Z","steps":["trace[263690599] 'agreement among raft nodes before linearized reading' (duration: 203.907535ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:28.535914Z","caller":"traceutil/trace.go:171","msg":"trace[1599550025] linearizableReadLoop","detail":"{readStateIndex:461; appliedIndex:459; }","duration":"118.978764ms","start":"2026-08-06T07:07:28.416914Z","end":"2026-08-06T07:07:28.535893Z","steps":["trace[1599550025] 'read index received' (duration: 108.614586ms)","trace[1599550025] 'applied index is now lower than readState.Index' (duration: 10.363308ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:07:28.535942Z","caller":"traceutil/trace.go:171","msg":"trace[56852135] transaction","detail":"{read_only:false; response_revision:441; number_of_response:1; }","duration":"131.286691ms","start":"2026-08-06T07:07:28.404629Z","end":"2026-08-06T07:07:28.535916Z","steps":["trace[56852135] 'process raft request' (duration: 120.971894ms)","trace[56852135] 'compare' (duration: 10.148353ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:07:28.536Z","caller":"traceutil/trace.go:171","msg":"trace[500742597] transaction","detail":"{read_only:false; response_revision:442; number_of_response:1; }","duration":"130.066115ms","start":"2026-08-06T07:07:28.405895Z","end":"2026-08-06T07:07:28.535961Z","steps":["trace[500742597] 'process raft request' (duration: 129.960722ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:28.536132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.177101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-08-06T07:07:28.53627Z","caller":"traceutil/trace.go:171","msg":"trace[180068621] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:442; }","duration":"119.354275ms","start":"2026-08-06T07:07:28.416885Z","end":"2026-08-06T07:07:28.536239Z","steps":["trace[180068621] 'agreement among raft nodes before linearized reading' (duration: 119.105028ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:29.563058Z","caller":"traceutil/trace.go:171","msg":"trace[2130456285] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"303.536123ms","start":"2026-08-06T07:07:29.259494Z","end":"2026-08-06T07:07:29.563031Z","steps":["trace[2130456285] 'process raft request' (duration: 303.358688ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:29.563194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:29.259471Z","time spent":"303.654436ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:07:30.271289Z","caller":"traceutil/trace.go:171","msg":"trace[1067720059] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"110.552365ms","start":"2026-08-06T07:07:30.160712Z","end":"2026-08-06T07:07:30.271264Z","steps":["trace[1067720059] 'process raft request' (duration: 110.425101ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:30.897494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.514515ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-06T07:07:30.897615Z","caller":"traceutil/trace.go:171","msg":"trace[2021625214] transaction","detail":"{read_only:false; response_revision:446; number_of_response:1; }","duration":"352.760428ms","start":"2026-08-06T07:07:30.544831Z","end":"2026-08-06T07:07:30.897591Z","steps":["trace[2021625214] 'process raft request' (duration: 207.060119ms)","trace[2021625214] 'compare' (duration: 145.249576ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:07:30.897793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:30.544813Z","time spent":"352.911554ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:07:31.091885Z","caller":"traceutil/trace.go:171","msg":"trace[252673218] transaction","detail":"{read_only:false; response_revision:447; number_of_response:1; }","duration":"119.738757ms","start":"2026-08-06T07:07:30.972131Z","end":"2026-08-06T07:07:31.09187Z","steps":["trace[252673218] 'process raft request' (duration: 116.888972ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:32.591216Z","caller":"traceutil/trace.go:171","msg":"trace[541187805] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"313.879471ms","start":"2026-08-06T07:07:32.277317Z","end":"2026-08-06T07:07:32.591197Z","steps":["trace[541187805] 'process raft request' (duration: 313.738107ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:32.591348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:32.277297Z","time spent":"313.978724ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:07:32.749851Z","caller":"traceutil/trace.go:171","msg":"trace[244079539] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"132.93132ms","start":"2026-08-06T07:07:32.616894Z","end":"2026-08-06T07:07:32.749825Z","steps":["trace[244079539] 'process raft request' (duration: 132.311192ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:33.089357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.460595ms","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-08-06T07:07:33.089457Z","caller":"traceutil/trace.go:171","msg":"trace[1499261560] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:450; }","duration":"187.569179ms","start":"2026-08-06T07:07:32.901864Z","end":"2026-08-06T07:07:33.089433Z","steps":["trace[1499261560] 'range keys from in-memory index tree' (duration: 187.30962ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:33.911824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.532208ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-08-06T07:07:37.834069Z","caller":"traceutil/trace.go:171","msg":"trace[1190496947] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"141.727113ms","start":"2026-08-06T07:07:37.692281Z","end":"2026-08-06T07:07:37.834008Z","steps":["trace[1190496947] 'process raft request' (duration: 141.571948ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:39.272573Z","caller":"traceutil/trace.go:171","msg":"trace[453366903] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"102.782031ms","start":"2026-08-06T07:07:39.169759Z","end":"2026-08-06T07:07:39.272541Z","steps":["trace[453366903] 'process raft request' (duration: 102.644428ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:39.939525Z","caller":"traceutil/trace.go:171","msg":"trace[1442134864] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"200.346699ms","start":"2026-08-06T07:07:39.739134Z","end":"2026-08-06T07:07:39.939481Z","steps":["trace[1442134864] 'process raft request' (duration: 149.651429ms)","trace[1442134864] 'compare' (duration: 50.521445ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:07:40.321297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.043394ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-06T07:07:40.321429Z","caller":"traceutil/trace.go:171","msg":"trace[1008107697] linearizableReadLoop","detail":"{readStateIndex:491; appliedIndex:489; }","duration":"376.721643ms","start":"2026-08-06T07:07:39.944696Z","end":"2026-08-06T07:07:40.321417Z","steps":["trace[1008107697] 'read index received' (duration: 19.699937ms)","trace[1008107697] 'applied index is now lower than readState.Index' (duration: 357.020826ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:07:40.321518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.822096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T07:07:40.321541Z","caller":"traceutil/trace.go:171","msg":"trace[1390289919] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:471; }","duration":"376.869027ms","start":"2026-08-06T07:07:39.944664Z","end":"2026-08-06T07:07:40.321533Z","steps":["trace[1390289919] 'agreement among raft nodes before linearized reading' (duration: 376.782634ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:40.321561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:39.944654Z","time spent":"376.901997ms","remote":"127.0.0.1:53442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" "} {"level":"info","ts":"2026-08-06T07:07:40.321637Z","caller":"traceutil/trace.go:171","msg":"trace[1370928800] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"377.718824ms","start":"2026-08-06T07:07:39.943847Z","end":"2026-08-06T07:07:40.321566Z","steps":["trace[1370928800] 'process raft request' (duration: 243.35102ms)","trace[1370928800] 'compare' (duration: 133.941751ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:07:40.321786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:39.943822Z","time spent":"377.891149ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:07:40.321804Z","caller":"traceutil/trace.go:171","msg":"trace[1469893706] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"374.657382ms","start":"2026-08-06T07:07:39.947126Z","end":"2026-08-06T07:07:40.321784Z","steps":["trace[1469893706] 'process raft request' (duration: 374.25073ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:40.321912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:39.947111Z","time spent":"374.734163ms","remote":"127.0.0.1:53734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4180,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:07:40.610412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.774325ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-06T07:07:40.610515Z","caller":"traceutil/trace.go:171","msg":"trace[1722490921] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"287.118644ms","start":"2026-08-06T07:07:40.323379Z","end":"2026-08-06T07:07:40.610498Z","steps":["trace[1722490921] 'process raft request' (duration: 153.236516ms)","trace[1722490921] 'compare' (duration: 133.557338ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:07:40.660488Z","caller":"traceutil/trace.go:171","msg":"trace[1620490969] linearizableReadLoop","detail":"{readStateIndex:494; appliedIndex:492; }","duration":"196.486804ms","start":"2026-08-06T07:07:40.46398Z","end":"2026-08-06T07:07:40.660467Z","steps":["trace[1620490969] 'read index received' (duration: 12.685679ms)","trace[1620490969] 'applied index is now lower than readState.Index' (duration: 183.800155ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:07:40.660567Z","caller":"traceutil/trace.go:171","msg":"trace[867416965] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"333.005451ms","start":"2026-08-06T07:07:40.327527Z","end":"2026-08-06T07:07:40.660533Z","steps":["trace[867416965] 'process raft request' (duration: 332.813455ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:40.660738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.730192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T07:07:40.660881Z","caller":"traceutil/trace.go:171","msg":"trace[1971228655] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:473; }","duration":"196.911937ms","start":"2026-08-06T07:07:40.463947Z","end":"2026-08-06T07:07:40.660859Z","steps":["trace[1971228655] 'agreement among raft nodes before linearized reading' (duration: 196.648219ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:40.660853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:40.327512Z","time spent":"333.151015ms","remote":"127.0.0.1:53754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3804,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:07:41.063556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.952268ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-06T07:07:41.063838Z","caller":"traceutil/trace.go:171","msg":"trace[1991923596] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"448.857322ms","start":"2026-08-06T07:07:40.614956Z","end":"2026-08-06T07:07:41.063813Z","steps":["trace[1991923596] 'process raft request' (duration: 448.721427ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:41.063913Z","caller":"traceutil/trace.go:171","msg":"trace[111232186] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"446.925175ms","start":"2026-08-06T07:07:40.61698Z","end":"2026-08-06T07:07:41.063905Z","steps":["trace[111232186] 'process raft request' (duration: 446.76041ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:41.063947Z","caller":"traceutil/trace.go:171","msg":"trace[144827131] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"398.943736ms","start":"2026-08-06T07:07:40.664981Z","end":"2026-08-06T07:07:41.063925Z","steps":["trace[144827131] 'process raft request' (duration: 398.896204ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:41.064014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:40.616966Z","time spent":"446.982036ms","remote":"127.0.0.1:53754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3795,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:07:41.064054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:40.664949Z","time spent":"399.063469ms","remote":"127.0.0.1:53384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":689,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-06T07:07:41.064144Z","caller":"traceutil/trace.go:171","msg":"trace[1179492904] linearizableReadLoop","detail":"{readStateIndex:498; appliedIndex:494; }","duration":"403.582215ms","start":"2026-08-06T07:07:40.66055Z","end":"2026-08-06T07:07:41.064132Z","steps":["trace[1179492904] 'read index received' (duration: 112.934445ms)","trace[1179492904] 'applied index is now lower than readState.Index' (duration: 290.64668ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:07:41.064301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.249868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-06T07:07:41.06434Z","caller":"traceutil/trace.go:171","msg":"trace[1506295607] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:478; }","duration":"432.3114ms","start":"2026-08-06T07:07:40.632017Z","end":"2026-08-06T07:07:41.064328Z","steps":["trace[1506295607] 'agreement among raft nodes before linearized reading' (duration: 432.241168ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:41.063957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:40.61493Z","time spent":"448.973616ms","remote":"127.0.0.1:53384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-06T07:07:41.064368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:40.632008Z","time spent":"432.354031ms","remote":"127.0.0.1:53576","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-08-06T07:07:41.064377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.548584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T07:07:41.064408Z","caller":"traceutil/trace.go:171","msg":"trace[1041447086] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:478; }","duration":"402.577254ms","start":"2026-08-06T07:07:40.661821Z","end":"2026-08-06T07:07:41.064398Z","steps":["trace[1041447086] 'agreement among raft nodes before linearized reading' (duration: 402.522983ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:41.06444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:40.661776Z","time spent":"402.655886ms","remote":"127.0.0.1:53308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-06T07:07:41.063838Z","caller":"traceutil/trace.go:171","msg":"trace[1898143208] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"448.985576ms","start":"2026-08-06T07:07:40.614821Z","end":"2026-08-06T07:07:41.063806Z","steps":["trace[1898143208] 'process raft request' (duration: 158.683287ms)","trace[1898143208] 'compare' (duration: 289.737271ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:07:41.064551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.77378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-08-06T07:07:41.064609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.44334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-kctxn\" ","response":"range_response_count:1 size:4016"} {"level":"info","ts":"2026-08-06T07:07:41.064633Z","caller":"traceutil/trace.go:171","msg":"trace[999870161] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:478; }","duration":"257.891324ms","start":"2026-08-06T07:07:40.806722Z","end":"2026-08-06T07:07:41.064613Z","steps":["trace[999870161] 'agreement among raft nodes before linearized reading' (duration: 257.75425ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:41.064108Z","caller":"traceutil/trace.go:171","msg":"trace[205525270] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"446.167742ms","start":"2026-08-06T07:07:40.617898Z","end":"2026-08-06T07:07:41.064066Z","steps":["trace[205525270] 'process raft request' (duration: 445.921785ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:41.064729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:40.617883Z","time spent":"446.791831ms","remote":"127.0.0.1:53500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4037,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:07:41.064575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.792352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4195"} {"level":"info","ts":"2026-08-06T07:07:41.064777Z","caller":"traceutil/trace.go:171","msg":"trace[674979795] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:478; }","duration":"398.018729ms","start":"2026-08-06T07:07:40.666751Z","end":"2026-08-06T07:07:41.06477Z","steps":["trace[674979795] 'agreement among raft nodes before linearized reading' (duration: 397.788311ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:41.064804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:40.666739Z","time spent":"398.058169ms","remote":"127.0.0.1:53734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":4217,"request content":"key:\"/registry/deployments/kube-system/coredns\" "} {"level":"warn","ts":"2026-08-06T07:07:41.064558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:40.6148Z","time spent":"449.722039ms","remote":"127.0.0.1:53384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-06T07:07:41.064631Z","caller":"traceutil/trace.go:171","msg":"trace[926089514] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-kctxn; range_end:; response_count:1; response_revision:478; }","duration":"400.491542ms","start":"2026-08-06T07:07:40.664133Z","end":"2026-08-06T07:07:41.064624Z","steps":["trace[926089514] 'agreement among raft nodes before linearized reading' (duration: 400.455761ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:41.065038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:40.664119Z","time spent":"400.912924ms","remote":"127.0.0.1:53500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":4038,"request content":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-kctxn\" "} {"level":"warn","ts":"2026-08-06T07:07:41.579969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.298305ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-06T07:07:41.580275Z","caller":"traceutil/trace.go:171","msg":"trace[1553955290] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"513.630631ms","start":"2026-08-06T07:07:41.066613Z","end":"2026-08-06T07:07:41.580244Z","steps":["trace[1553955290] 'process raft request' (duration: 306.942114ms)","trace[1553955290] 'compare' (duration: 206.161061ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:07:41.580334Z","caller":"traceutil/trace.go:171","msg":"trace[682024078] linearizableReadLoop","detail":"{readStateIndex:502; appliedIndex:499; }","duration":"509.625473ms","start":"2026-08-06T07:07:41.070692Z","end":"2026-08-06T07:07:41.580317Z","steps":["trace[682024078] 'read index received' (duration: 302.875743ms)","trace[682024078] 'applied index is now lower than readState.Index' (duration: 206.74871ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:07:41.580413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:41.066585Z","time spent":"513.762036ms","remote":"127.0.0.1:53500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4013,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:07:41.580452Z","caller":"traceutil/trace.go:171","msg":"trace[58507631] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"270.953232ms","start":"2026-08-06T07:07:41.309483Z","end":"2026-08-06T07:07:41.580436Z","steps":["trace[58507631] 'process raft request' (duration: 270.774707ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:41.580576Z","caller":"traceutil/trace.go:171","msg":"trace[1545413057] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"511.170898ms","start":"2026-08-06T07:07:41.069396Z","end":"2026-08-06T07:07:41.580567Z","steps":["trace[1545413057] 'process raft request' (duration: 510.679303ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:41.58065Z","caller":"traceutil/trace.go:171","msg":"trace[1173066378] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"510.432257ms","start":"2026-08-06T07:07:41.070209Z","end":"2026-08-06T07:07:41.580641Z","steps":["trace[1173066378] 'process raft request' (duration: 509.996004ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:41.580649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:41.069381Z","time spent":"511.226801ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:07:41.580678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.977283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-67659f764b\" ","response":"range_response_count:1 size:3810"} {"level":"info","ts":"2026-08-06T07:07:41.580738Z","caller":"traceutil/trace.go:171","msg":"trace[211129681] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-67659f764b; range_end:; response_count:1; response_revision:482; }","duration":"510.060205ms","start":"2026-08-06T07:07:41.07066Z","end":"2026-08-06T07:07:41.580721Z","steps":["trace[211129681] 'agreement among raft nodes before linearized reading' (duration: 509.963983ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:41.580787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.047235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-67659f764b\" ","response":"range_response_count:1 size:3810"} {"level":"warn","ts":"2026-08-06T07:07:41.580697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:41.070188Z","time spent":"510.487768ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:07:41.580818Z","caller":"traceutil/trace.go:171","msg":"trace[726166083] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-67659f764b; range_end:; response_count:1; response_revision:482; }","duration":"510.089076ms","start":"2026-08-06T07:07:41.070722Z","end":"2026-08-06T07:07:41.580811Z","steps":["trace[726166083] 'agreement among raft nodes before linearized reading' (duration: 510.019714ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:41.580842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:41.070718Z","time spent":"510.119427ms","remote":"127.0.0.1:53754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":3832,"request content":"key:\"/registry/replicasets/kube-system/coredns-67659f764b\" "} {"level":"warn","ts":"2026-08-06T07:07:41.580891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.942394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T07:07:41.580933Z","caller":"traceutil/trace.go:171","msg":"trace[319812302] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:482; }","duration":"116.014646ms","start":"2026-08-06T07:07:41.464908Z","end":"2026-08-06T07:07:41.580923Z","steps":["trace[319812302] 'agreement among raft nodes before linearized reading' (duration: 115.952065ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:41.580991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.43773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-06T07:07:41.581023Z","caller":"traceutil/trace.go:171","msg":"trace[1050705254] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:482; }","duration":"304.506751ms","start":"2026-08-06T07:07:41.276509Z","end":"2026-08-06T07:07:41.581016Z","steps":["trace[1050705254] 'agreement among raft nodes before linearized reading' (duration: 304.44964ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:41.581041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:41.276486Z","time spent":"304.551613ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-06T07:07:41.580787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:41.070648Z","time spent":"510.127928ms","remote":"127.0.0.1:53754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":3832,"request content":"key:\"/registry/replicasets/kube-system/coredns-67659f764b\" "} {"level":"info","ts":"2026-08-06T07:07:41.897003Z","caller":"traceutil/trace.go:171","msg":"trace[932769883] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"311.240213ms","start":"2026-08-06T07:07:41.585742Z","end":"2026-08-06T07:07:41.896982Z","steps":["trace[932769883] 'process raft request' (duration: 267.962413ms)","trace[932769883] 'compare' (duration: 43.104564ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:07:41.897032Z","caller":"traceutil/trace.go:171","msg":"trace[660455758] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"307.200022ms","start":"2026-08-06T07:07:41.589821Z","end":"2026-08-06T07:07:41.897021Z","steps":["trace[660455758] 'process raft request' (duration: 307.155631ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:41.897139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:41.589811Z","time spent":"307.248744ms","remote":"127.0.0.1:53754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3795,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:07:41.897146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:41.585721Z","time spent":"311.333215ms","remote":"127.0.0.1:53384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":721,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-06T07:07:41.897144Z","caller":"traceutil/trace.go:171","msg":"trace[989276165] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"311.121189ms","start":"2026-08-06T07:07:41.585966Z","end":"2026-08-06T07:07:41.897087Z","steps":["trace[989276165] 'process raft request' (duration: 310.974715ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:41.897319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:41.585954Z","time spent":"311.266353ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:07:42.162667Z","caller":"traceutil/trace.go:171","msg":"trace[1998921731] transaction","detail":"{read_only:false; number_of_response:1; response_revision:486; }","duration":"529.465234ms","start":"2026-08-06T07:07:41.633178Z","end":"2026-08-06T07:07:42.162643Z","steps":["trace[1998921731] 'process raft request' (duration: 529.373921ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:42.162679Z","caller":"traceutil/trace.go:171","msg":"trace[528178253] transaction","detail":"{read_only:false; number_of_response:1; response_revision:486; }","duration":"533.167495ms","start":"2026-08-06T07:07:41.629477Z","end":"2026-08-06T07:07:42.162644Z","steps":["trace[528178253] 'process raft request' (duration: 468.431876ms)","trace[528178253] 'compare' (duration: 64.236944ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:07:42.162827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:41.633165Z","time spent":"529.586098ms","remote":"127.0.0.1:53754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":56,"response count":0,"response size":3843,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:07:42.162948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:41.629459Z","time spent":"533.308258ms","remote":"127.0.0.1:53500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":55,"response count":0,"response size":40,"request content":"compare: success: > failure: >"} {"level":"info","ts":"2026-08-06T07:07:42.359117Z","caller":"traceutil/trace.go:171","msg":"trace[388382594] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"458.651584ms","start":"2026-08-06T07:07:41.900435Z","end":"2026-08-06T07:07:42.359087Z","steps":["trace[388382594] 'process raft request' (duration: 362.693225ms)","trace[388382594] 'compare' (duration: 95.751243ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:07:42.359126Z","caller":"traceutil/trace.go:171","msg":"trace[1302509287] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"454.678756ms","start":"2026-08-06T07:07:41.904411Z","end":"2026-08-06T07:07:42.35909Z","steps":["trace[1302509287] 'process raft request' (duration: 454.610824ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:42.359239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:41.900414Z","time spent":"458.766528ms","remote":"127.0.0.1:53384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":687,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-06T07:07:42.359262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:41.9044Z","time spent":"454.791899ms","remote":"127.0.0.1:53734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4157,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:07:42.389953Z","caller":"traceutil/trace.go:171","msg":"trace[1534106833] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"222.990233ms","start":"2026-08-06T07:07:42.166942Z","end":"2026-08-06T07:07:42.389932Z","steps":["trace[1534106833] 'process raft request' (duration: 222.736105ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:42.390224Z","caller":"traceutil/trace.go:171","msg":"trace[278742620] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"220.034695ms","start":"2026-08-06T07:07:42.170182Z","end":"2026-08-06T07:07:42.390217Z","steps":["trace[278742620] 'process raft request' (duration: 219.637823ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:42.390412Z","caller":"traceutil/trace.go:171","msg":"trace[678937953] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"219.672834ms","start":"2026-08-06T07:07:42.170727Z","end":"2026-08-06T07:07:42.3904Z","steps":["trace[678937953] 'process raft request' (duration: 219.168009ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:42.951929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.951875ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-06T07:07:42.952047Z","caller":"traceutil/trace.go:171","msg":"trace[199091986] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"582.424102ms","start":"2026-08-06T07:07:42.369605Z","end":"2026-08-06T07:07:42.952029Z","steps":["trace[199091986] 'process raft request' (duration: 374.304581ms)","trace[199091986] 'compare' (duration: 207.854552ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:07:42.952104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:42.369588Z","time spent":"582.489415ms","remote":"127.0.0.1:53734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4157,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:07:42.999226Z","caller":"traceutil/trace.go:171","msg":"trace[80845493] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"604.430468ms","start":"2026-08-06T07:07:42.394739Z","end":"2026-08-06T07:07:42.99917Z","steps":["trace[80845493] 'process raft request' (duration: 604.206301ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:42.999256Z","caller":"traceutil/trace.go:171","msg":"trace[8300001] linearizableReadLoop","detail":"{readStateIndex:519; appliedIndex:514; }","duration":"602.630115ms","start":"2026-08-06T07:07:42.396602Z","end":"2026-08-06T07:07:42.999232Z","steps":["trace[8300001] 'read index received' (duration: 347.36526ms)","trace[8300001] 'applied index is now lower than readState.Index' (duration: 255.263755ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:07:42.999279Z","caller":"traceutil/trace.go:171","msg":"trace[1086168874] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"602.980135ms","start":"2026-08-06T07:07:42.396241Z","end":"2026-08-06T07:07:42.999221Z","steps":["trace[1086168874] 'process raft request' (duration: 602.808709ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:42.999322Z","caller":"traceutil/trace.go:171","msg":"trace[663574934] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"602.958373ms","start":"2026-08-06T07:07:42.39632Z","end":"2026-08-06T07:07:42.999279Z","steps":["trace[663574934] 'process raft request' (duration: 602.836909ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:42.999382Z","caller":"traceutil/trace.go:171","msg":"trace[2060432813] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"602.395767ms","start":"2026-08-06T07:07:42.396976Z","end":"2026-08-06T07:07:42.999372Z","steps":["trace[2060432813] 'process raft request' (duration: 602.213532ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:42.999454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:42.39619Z","time spent":"603.16648ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:07:42.99946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:42.394717Z","time spent":"604.627273ms","remote":"127.0.0.1:53384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-06T07:07:42.999478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:42.396967Z","time spent":"602.446709ms","remote":"127.0.0.1:53500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4037,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:07:42.999654Z","caller":"traceutil/trace.go:171","msg":"trace[1440025852] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"603.303504ms","start":"2026-08-06T07:07:42.396317Z","end":"2026-08-06T07:07:42.99962Z","steps":["trace[1440025852] 'process raft request' (duration: 602.793818ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:42.999484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:42.396298Z","time spent":"603.103879ms","remote":"127.0.0.1:53384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-06T07:07:42.999761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:42.396309Z","time spent":"603.399417ms","remote":"127.0.0.1:53754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3840,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:07:42.999699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.117373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-06T07:07:42.999802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.200571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-7c96b6546b\" ","response":"range_response_count:1 size:3819"} {"level":"info","ts":"2026-08-06T07:07:42.999816Z","caller":"traceutil/trace.go:171","msg":"trace[861504712] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:497; }","duration":"535.280718ms","start":"2026-08-06T07:07:42.464522Z","end":"2026-08-06T07:07:42.999802Z","steps":["trace[861504712] 'agreement among raft nodes before linearized reading' (duration: 535.126773ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:42.999853Z","caller":"traceutil/trace.go:171","msg":"trace[771181676] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-7c96b6546b; range_end:; response_count:1; response_revision:497; }","duration":"603.275964ms","start":"2026-08-06T07:07:42.396559Z","end":"2026-08-06T07:07:42.999835Z","steps":["trace[771181676] 'agreement among raft nodes before linearized reading' (duration: 603.174741ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:42.99986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:42.464499Z","time spent":"535.349689ms","remote":"127.0.0.1:53308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-06T07:07:42.999911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:42.396543Z","time spent":"603.353025ms","remote":"127.0.0.1:53754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":3841,"request content":"key:\"/registry/replicasets/kube-system/coredns-7c96b6546b\" "} {"level":"info","ts":"2026-08-06T07:07:43.310438Z","caller":"traceutil/trace.go:171","msg":"trace[71313232] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"302.577604ms","start":"2026-08-06T07:07:43.007832Z","end":"2026-08-06T07:07:43.310409Z","steps":["trace[71313232] 'process raft request' (duration: 274.780056ms)","trace[71313232] 'compare' (duration: 27.688155ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:07:43.310634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:43.00781Z","time spent":"302.718698ms","remote":"127.0.0.1:53754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3840,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:07:43.600404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.115553ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-06T07:07:43.600575Z","caller":"traceutil/trace.go:171","msg":"trace[1749569096] linearizableReadLoop","detail":"{readStateIndex:523; appliedIndex:521; }","duration":"135.501658ms","start":"2026-08-06T07:07:43.465058Z","end":"2026-08-06T07:07:43.60056Z","steps":["trace[1749569096] 'read index received' (duration: 30.982µs)","trace[1749569096] 'applied index is now lower than readState.Index' (duration: 135.467646ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:07:43.600611Z","caller":"traceutil/trace.go:171","msg":"trace[586646107] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"590.138572ms","start":"2026-08-06T07:07:43.010446Z","end":"2026-08-06T07:07:43.600585Z","steps":["trace[586646107] 'process raft request' (duration: 590.045489ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:43.600623Z","caller":"traceutil/trace.go:171","msg":"trace[891465251] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"590.826832ms","start":"2026-08-06T07:07:43.009754Z","end":"2026-08-06T07:07:43.60058Z","steps":["trace[891465251] 'process raft request' (duration: 443.45867ms)","trace[891465251] 'compare' (duration: 146.99901ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:07:43.6008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:43.009736Z","time spent":"590.973056ms","remote":"127.0.0.1:53734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4180,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:07:43.600855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:43.010432Z","time spent":"590.240345ms","remote":"127.0.0.1:53754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3804,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:07:43.600902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.824088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T07:07:43.601055Z","caller":"traceutil/trace.go:171","msg":"trace[1961925072] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:500; }","duration":"135.971142ms","start":"2026-08-06T07:07:43.465054Z","end":"2026-08-06T07:07:43.601025Z","steps":["trace[1961925072] 'agreement among raft nodes before linearized reading' (duration: 135.59012ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:43.863366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.896763ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-06T07:07:43.863482Z","caller":"traceutil/trace.go:171","msg":"trace[132090754] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"258.340416ms","start":"2026-08-06T07:07:43.605121Z","end":"2026-08-06T07:07:43.863461Z","steps":["trace[132090754] 'process raft request' (duration: 96.284568ms)","trace[132090754] 'compare' (duration: 161.76534ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:07:43.863572Z","caller":"traceutil/trace.go:171","msg":"trace[1088372962] linearizableReadLoop","detail":"{readStateIndex:525; appliedIndex:523; }","duration":"255.072449ms","start":"2026-08-06T07:07:43.608484Z","end":"2026-08-06T07:07:43.863556Z","steps":["trace[1088372962] 'read index received' (duration: 48.304849ms)","trace[1088372962] 'applied index is now lower than readState.Index' (duration: 206.76588ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:07:43.908013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.506682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4195"} {"level":"info","ts":"2026-08-06T07:07:43.908098Z","caller":"traceutil/trace.go:171","msg":"trace[1404890323] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:502; }","duration":"299.616456ms","start":"2026-08-06T07:07:43.608458Z","end":"2026-08-06T07:07:43.908075Z","steps":["trace[1404890323] 'agreement among raft nodes before linearized reading' (duration: 255.144701ms)","trace[1404890323] 'range keys from in-memory index tree' (duration: 44.345311ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:07:44.1717Z","caller":"traceutil/trace.go:171","msg":"trace[1411025245] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"254.569455ms","start":"2026-08-06T07:07:43.917094Z","end":"2026-08-06T07:07:44.171664Z","steps":["trace[1411025245] 'process raft request' (duration: 237.334361ms)","trace[1411025245] 'compare' (duration: 17.082189ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:07:46.293856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.002094ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-06T07:07:46.293968Z","caller":"traceutil/trace.go:171","msg":"trace[972329458] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"295.558815ms","start":"2026-08-06T07:07:45.998388Z","end":"2026-08-06T07:07:46.293947Z","steps":["trace[972329458] 'process raft request' (duration: 120.389696ms)","trace[972329458] 'compare' (duration: 174.811579ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:07:47.915442Z","caller":"traceutil/trace.go:171","msg":"trace[201845499] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"221.337324ms","start":"2026-08-06T07:07:47.694082Z","end":"2026-08-06T07:07:47.915419Z","steps":["trace[201845499] 'process raft request' (duration: 221.17551ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:48.098472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.201646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-06T07:07:48.098562Z","caller":"traceutil/trace.go:171","msg":"trace[1004182095] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:510; }","duration":"141.296689ms","start":"2026-08-06T07:07:47.957247Z","end":"2026-08-06T07:07:48.098544Z","steps":["trace[1004182095] 'range keys from in-memory index tree' (duration: 141.124204ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:48.257039Z","caller":"traceutil/trace.go:171","msg":"trace[344231919] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"113.464881ms","start":"2026-08-06T07:07:48.143554Z","end":"2026-08-06T07:07:48.257019Z","steps":["trace[344231919] 'process raft request' (duration: 66.348468ms)","trace[344231919] 'compare' (duration: 47.038ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:07:53.384904Z","caller":"traceutil/trace.go:171","msg":"trace[1348549351] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"218.573342ms","start":"2026-08-06T07:07:53.166308Z","end":"2026-08-06T07:07:53.384881Z","steps":["trace[1348549351] 'process raft request' (duration: 218.395746ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:53.561351Z","caller":"traceutil/trace.go:171","msg":"trace[1432888635] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"376.860059ms","start":"2026-08-06T07:07:53.184433Z","end":"2026-08-06T07:07:53.561293Z","steps":["trace[1432888635] 'process raft request' (duration: 376.57299ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:53.561538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:53.184414Z","time spent":"377.045943ms","remote":"127.0.0.1:53360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-06T07:07:53.561709Z","caller":"traceutil/trace.go:171","msg":"trace[2145113297] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"364.20348ms","start":"2026-08-06T07:07:53.197494Z","end":"2026-08-06T07:07:53.561698Z","steps":["trace[2145113297] 'process raft request' (duration: 363.998965ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:53.56176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:53.197477Z","time spent":"364.261672ms","remote":"127.0.0.1:53360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-06T07:07:53.561835Z","caller":"traceutil/trace.go:171","msg":"trace[275882648] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"365.577262ms","start":"2026-08-06T07:07:53.19625Z","end":"2026-08-06T07:07:53.561828Z","steps":["trace[275882648] 'process raft request' (duration: 365.131849ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:53.56158Z","caller":"traceutil/trace.go:171","msg":"trace[858896043] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"365.299994ms","start":"2026-08-06T07:07:53.196246Z","end":"2026-08-06T07:07:53.561546Z","steps":["trace[858896043] 'process raft request' (duration: 364.903322ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:53.562033Z","caller":"traceutil/trace.go:171","msg":"trace[1937756902] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"361.591374ms","start":"2026-08-06T07:07:53.200432Z","end":"2026-08-06T07:07:53.562024Z","steps":["trace[1937756902] 'process raft request' (duration: 361.272924ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:53.562189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:53.200425Z","time spent":"361.734697ms","remote":"127.0.0.1:53360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-06T07:07:53.562254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:53.196225Z","time spent":"365.821759ms","remote":"127.0.0.1:53360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-06T07:07:53.562303Z","caller":"traceutil/trace.go:171","msg":"trace[605796516] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"364.645844ms","start":"2026-08-06T07:07:53.197646Z","end":"2026-08-06T07:07:53.562292Z","steps":["trace[605796516] 'process raft request' (duration: 364.009555ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:53.562343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:53.19763Z","time spent":"364.694555ms","remote":"127.0.0.1:53360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-06T07:07:53.562462Z","caller":"traceutil/trace.go:171","msg":"trace[1790470372] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"341.742581ms","start":"2026-08-06T07:07:53.22071Z","end":"2026-08-06T07:07:53.562453Z","steps":["trace[1790470372] 'process raft request' (duration: 341.226696ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:53.562506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:53.22069Z","time spent":"341.796433ms","remote":"127.0.0.1:53360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-06T07:07:53.561924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:53.196235Z","time spent":"365.626943ms","remote":"127.0.0.1:53360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-06T07:07:53.562569Z","caller":"traceutil/trace.go:171","msg":"trace[1759485458] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"351.063849ms","start":"2026-08-06T07:07:53.211418Z","end":"2026-08-06T07:07:53.562482Z","steps":["trace[1759485458] 'process raft request' (duration: 350.361278ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:53.561968Z","caller":"traceutil/trace.go:171","msg":"trace[1942273648] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"364.335674ms","start":"2026-08-06T07:07:53.197625Z","end":"2026-08-06T07:07:53.561961Z","steps":["trace[1942273648] 'process raft request' (duration: 363.978224ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:53.562612Z","caller":"traceutil/trace.go:171","msg":"trace[1377288638] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"307.992905ms","start":"2026-08-06T07:07:53.254562Z","end":"2026-08-06T07:07:53.562554Z","steps":["trace[1377288638] 'process raft request' (duration: 307.47164ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:53.562832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:53.197621Z","time spent":"365.17651ms","remote":"127.0.0.1:53360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-06T07:07:53.563312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:53.211139Z","time spent":"352.117201ms","remote":"127.0.0.1:53360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-06T07:07:53.561994Z","caller":"traceutil/trace.go:171","msg":"trace[1665955082] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"364.432738ms","start":"2026-08-06T07:07:53.197555Z","end":"2026-08-06T07:07:53.561987Z","steps":["trace[1665955082] 'process raft request' (duration: 363.992935ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:53.564404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:53.197551Z","time spent":"366.819259ms","remote":"127.0.0.1:53360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-06T07:07:53.564481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:53.254541Z","time spent":"308.322146ms","remote":"127.0.0.1:53360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-06T07:07:53.574309Z","caller":"traceutil/trace.go:171","msg":"trace[742055810] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"200.012448ms","start":"2026-08-06T07:07:53.374275Z","end":"2026-08-06T07:07:53.574287Z","steps":["trace[742055810] 'process raft request' (duration: 199.856664ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:07:58.975655Z","caller":"traceutil/trace.go:171","msg":"trace[765304620] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"324.037153ms","start":"2026-08-06T07:07:58.651584Z","end":"2026-08-06T07:07:58.975621Z","steps":["trace[765304620] 'process raft request' (duration: 323.329053ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:58.97582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:07:58.651552Z","time spent":"324.188439ms","remote":"127.0.0.1:53392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036225,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:08:00.353452Z","caller":"traceutil/trace.go:171","msg":"trace[1099449051] linearizableReadLoop","detail":"{readStateIndex:696; appliedIndex:695; }","duration":"332.730374ms","start":"2026-08-06T07:08:00.020697Z","end":"2026-08-06T07:08:00.353427Z","steps":["trace[1099449051] 'read index received' (duration: 331.897669ms)","trace[1099449051] 'applied index is now lower than readState.Index' (duration: 831.535µs)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:08:00.353529Z","caller":"traceutil/trace.go:171","msg":"trace[1466736046] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"341.169124ms","start":"2026-08-06T07:08:00.012325Z","end":"2026-08-06T07:08:00.353494Z","steps":["trace[1466736046] 'process raft request' (duration: 340.542935ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:08:00.353689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.479527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-08-06T07:08:00.353696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.981801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-64bwp\" ","response":"range_response_count:1 size:16961"} {"level":"warn","ts":"2026-08-06T07:08:00.353712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:08:00.012271Z","time spent":"341.343189ms","remote":"127.0.0.1:53392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:08:00.353735Z","caller":"traceutil/trace.go:171","msg":"trace[962803235] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:666; }","duration":"126.568252ms","start":"2026-08-06T07:08:00.227155Z","end":"2026-08-06T07:08:00.353723Z","steps":["trace[962803235] 'agreement among raft nodes before linearized reading' (duration: 126.428987ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:08:00.35377Z","caller":"traceutil/trace.go:171","msg":"trace[294899709] range","detail":"{range_begin:/registry/pods/kube-system/cilium-64bwp; range_end:; response_count:1; response_revision:666; }","duration":"333.092863ms","start":"2026-08-06T07:08:00.020657Z","end":"2026-08-06T07:08:00.35375Z","steps":["trace[294899709] 'agreement among raft nodes before linearized reading' (duration: 332.890047ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:08:00.353821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:08:00.020641Z","time spent":"333.165995ms","remote":"127.0.0.1:53500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16983,"request content":"key:\"/registry/pods/kube-system/cilium-64bwp\" "} {"level":"info","ts":"2026-08-06T07:08:00.944452Z","caller":"traceutil/trace.go:171","msg":"trace[1056047565] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"524.111896ms","start":"2026-08-06T07:08:00.420312Z","end":"2026-08-06T07:08:00.944424Z","steps":["trace[1056047565] 'process raft request' (duration: 523.490587ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:08:00.944583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:08:00.42029Z","time spent":"524.232219ms","remote":"127.0.0.1:53786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-06T07:08:01.219199Z","caller":"traceutil/trace.go:171","msg":"trace[1280116501] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"265.345956ms","start":"2026-08-06T07:08:00.95382Z","end":"2026-08-06T07:08:01.219166Z","steps":["trace[1280116501] 'process raft request' (duration: 265.257133ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:08:01.219235Z","caller":"traceutil/trace.go:171","msg":"trace[1255223363] linearizableReadLoop","detail":"{readStateIndex:700; appliedIndex:698; }","duration":"755.139498ms","start":"2026-08-06T07:08:00.464069Z","end":"2026-08-06T07:08:01.219209Z","steps":["trace[1255223363] 'read index received' (duration: 479.747323ms)","trace[1255223363] 'applied index is now lower than readState.Index' (duration: 275.390815ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:08:01.219203Z","caller":"traceutil/trace.go:171","msg":"trace[1040997378] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"797.096028ms","start":"2026-08-06T07:08:00.422047Z","end":"2026-08-06T07:08:01.219143Z","steps":["trace[1040997378] 'process raft request' (duration: 736.164092ms)","trace[1040997378] 'compare' (duration: 60.699378ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:08:01.219383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"755.297112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T07:08:01.219417Z","caller":"traceutil/trace.go:171","msg":"trace[1451407794] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:671; }","duration":"755.397156ms","start":"2026-08-06T07:08:00.46401Z","end":"2026-08-06T07:08:01.219407Z","steps":["trace[1451407794] 'agreement among raft nodes before linearized reading' (duration: 755.314303ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:08:01.219459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:08:00.46397Z","time spent":"755.481618ms","remote":"127.0.0.1:53308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-06T07:08:01.219485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:08:00.422022Z","time spent":"797.384006ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:08:01.219654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.868982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T07:08:01.219689Z","caller":"traceutil/trace.go:171","msg":"trace[814943913] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:671; }","duration":"265.927192ms","start":"2026-08-06T07:08:00.95375Z","end":"2026-08-06T07:08:01.219677Z","steps":["trace[814943913] 'agreement among raft nodes before linearized reading' (duration: 265.882461ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:08:17.417229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.708075ms","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-08-06T07:08:17.41741Z","caller":"traceutil/trace.go:171","msg":"trace[1441635056] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:833; }","duration":"316.905651ms","start":"2026-08-06T07:08:17.100479Z","end":"2026-08-06T07:08:17.417384Z","steps":["trace[1441635056] 'range keys from in-memory index tree' (duration: 316.687115ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:08:17.417424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.965062ms","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-08-06T07:08:17.417501Z","caller":"traceutil/trace.go:171","msg":"trace[2018945238] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:833; }","duration":"128.095796ms","start":"2026-08-06T07:08:17.289386Z","end":"2026-08-06T07:08:17.417482Z","steps":["trace[2018945238] 'range keys from in-memory index tree' (duration: 127.728055ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:08:17.417699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.170315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-8mdkn\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-08-06T07:08:17.41776Z","caller":"traceutil/trace.go:171","msg":"trace[543080984] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-8mdkn; range_end:; response_count:1; response_revision:833; }","duration":"301.279088ms","start":"2026-08-06T07:08:17.116468Z","end":"2026-08-06T07:08:17.417747Z","steps":["trace[543080984] 'range keys from in-memory index tree' (duration: 300.915727ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:08:17.41779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:08:17.116448Z","time spent":"301.335369ms","remote":"127.0.0.1:53500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3986,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-8mdkn\" "} {"level":"warn","ts":"2026-08-06T07:08:53.874245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.43284ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-08-06T07:08:53.874401Z","caller":"traceutil/trace.go:171","msg":"trace[801250944] linearizableReadLoop","detail":"{readStateIndex:1096; appliedIndex:1095; }","duration":"409.842424ms","start":"2026-08-06T07:08:53.464534Z","end":"2026-08-06T07:08:53.874377Z","steps":["trace[801250944] 'read index received' (duration: 38.771µs)","trace[801250944] 'applied index is now lower than readState.Index' (duration: 409.801683ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:08:53.874656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.103942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T07:08:53.874696Z","caller":"traceutil/trace.go:171","msg":"trace[1365645881] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1053; }","duration":"410.162414ms","start":"2026-08-06T07:08:53.46452Z","end":"2026-08-06T07:08:53.874683Z","steps":["trace[1365645881] 'agreement among raft nodes before linearized reading' (duration: 410.057941ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:08:53.874743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:08:53.464465Z","time spent":"410.269158ms","remote":"127.0.0.1:53318","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-06T07:08:53.874904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.139391ms","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-08-06T07:08:53.874995Z","caller":"traceutil/trace.go:171","msg":"trace[744318535] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1053; }","duration":"226.277106ms","start":"2026-08-06T07:08:53.648696Z","end":"2026-08-06T07:08:53.874973Z","steps":["trace[744318535] 'agreement among raft nodes before linearized reading' (duration: 226.010798ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:08:53.875009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.776685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-06T07:08:53.875104Z","caller":"traceutil/trace.go:171","msg":"trace[1030518147] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1053; }","duration":"183.90397ms","start":"2026-08-06T07:08:53.691176Z","end":"2026-08-06T07:08:53.87508Z","steps":["trace[1030518147] 'agreement among raft nodes before linearized reading' (duration: 183.539739ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:08:54.136645Z","caller":"traceutil/trace.go:171","msg":"trace[1432182361] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"256.16103ms","start":"2026-08-06T07:08:53.880445Z","end":"2026-08-06T07:08:54.136606Z","steps":["trace[1432182361] 'process raft request' (duration: 255.910983ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:08:54.16293Z","caller":"traceutil/trace.go:171","msg":"trace[395328620] transaction","detail":"{read_only:false; response_revision:1055; number_of_response:1; }","duration":"282.45149ms","start":"2026-08-06T07:08:53.880453Z","end":"2026-08-06T07:08:54.162904Z","steps":["trace[395328620] 'process raft request' (duration: 282.256454ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:08:54.163133Z","caller":"traceutil/trace.go:171","msg":"trace[63820437] transaction","detail":"{read_only:false; response_revision:1056; number_of_response:1; }","duration":"131.305242ms","start":"2026-08-06T07:08:54.031815Z","end":"2026-08-06T07:08:54.163121Z","steps":["trace[63820437] 'process raft request' (duration: 131.048143ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:09:16.849014Z","caller":"traceutil/trace.go:171","msg":"trace[820493979] transaction","detail":"{read_only:false; response_revision:1130; number_of_response:1; }","duration":"133.015318ms","start":"2026-08-06T07:09:16.715971Z","end":"2026-08-06T07:09:16.848986Z","steps":["trace[820493979] 'process raft request' (duration: 132.891915ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:09:17.434729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.760308ms","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-08-06T07:09:17.43487Z","caller":"traceutil/trace.go:171","msg":"trace[1420218790] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1130; }","duration":"332.922513ms","start":"2026-08-06T07:09:17.101928Z","end":"2026-08-06T07:09:17.43485Z","steps":["trace[1420218790] 'range keys from in-memory index tree' (duration: 332.742348ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:09:17.435645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.263229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-06T07:09:17.435758Z","caller":"traceutil/trace.go:171","msg":"trace[1135210168] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1130; }","duration":"406.426613ms","start":"2026-08-06T07:09:17.029312Z","end":"2026-08-06T07:09:17.435739Z","steps":["trace[1135210168] 'range keys from in-memory index tree' (duration: 405.424543ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:09:17.435935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:09:17.029289Z","time spent":"406.629339ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-06T07:09:18.415344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:09:18.092421Z","time spent":"322.917956ms","remote":"127.0.0.1:53342","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-08-06T07:09:18.524317Z","caller":"traceutil/trace.go:171","msg":"trace[148765644] linearizableReadLoop","detail":"{readStateIndex:1180; appliedIndex:1178; }","duration":"277.624458ms","start":"2026-08-06T07:09:18.24667Z","end":"2026-08-06T07:09:18.524295Z","steps":["trace[148765644] 'read index received' (duration: 168.597428ms)","trace[148765644] 'applied index is now lower than readState.Index' (duration: 109.02616ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:09:18.524375Z","caller":"traceutil/trace.go:171","msg":"trace[18999718] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"279.429632ms","start":"2026-08-06T07:09:18.244906Z","end":"2026-08-06T07:09:18.524335Z","steps":["trace[18999718] 'process raft request' (duration: 257.755423ms)","trace[18999718] 'compare' (duration: 21.36815ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:09:18.524568Z","caller":"traceutil/trace.go:171","msg":"trace[1362275516] transaction","detail":"{read_only:false; response_revision:1133; number_of_response:1; }","duration":"107.789943ms","start":"2026-08-06T07:09:18.41675Z","end":"2026-08-06T07:09:18.52454Z","steps":["trace[1362275516] 'process raft request' (duration: 107.499845ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:09:18.524613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.377275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T07:09:18.524679Z","caller":"traceutil/trace.go:171","msg":"trace[1379582793] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1133; }","duration":"267.50061ms","start":"2026-08-06T07:09:18.257161Z","end":"2026-08-06T07:09:18.524662Z","steps":["trace[1379582793] 'agreement among raft nodes before linearized reading' (duration: 267.337096ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:09:18.524699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.005899ms","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-08-06T07:09:18.524754Z","caller":"traceutil/trace.go:171","msg":"trace[557993399] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1133; }","duration":"278.110684ms","start":"2026-08-06T07:09:18.246631Z","end":"2026-08-06T07:09:18.524741Z","steps":["trace[557993399] 'agreement among raft nodes before linearized reading' (duration: 277.800044ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:09:18.524893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.399333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-08-06T07:09:18.524925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.558934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-06T07:09:18.524987Z","caller":"traceutil/trace.go:171","msg":"trace[1518274380] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1133; }","duration":"262.632556ms","start":"2026-08-06T07:09:18.262339Z","end":"2026-08-06T07:09:18.524972Z","steps":["trace[1518274380] 'agreement among raft nodes before linearized reading' (duration: 262.453461ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:09:18.524949Z","caller":"traceutil/trace.go:171","msg":"trace[983036998] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1133; }","duration":"212.506636ms","start":"2026-08-06T07:09:18.312425Z","end":"2026-08-06T07:09:18.524931Z","steps":["trace[983036998] 'agreement among raft nodes before linearized reading' (duration: 212.332621ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:09:19.647067Z","caller":"traceutil/trace.go:171","msg":"trace[1648967257] transaction","detail":"{read_only:false; response_revision:1138; number_of_response:1; }","duration":"158.238303ms","start":"2026-08-06T07:09:19.4888Z","end":"2026-08-06T07:09:19.647039Z","steps":["trace[1648967257] 'process raft request' (duration: 158.096619ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:09:35.017973Z","caller":"traceutil/trace.go:171","msg":"trace[1399041757] linearizableReadLoop","detail":"{readStateIndex:1290; appliedIndex:1289; }","duration":"418.693476ms","start":"2026-08-06T07:09:34.599257Z","end":"2026-08-06T07:09:35.01795Z","steps":["trace[1399041757] 'read index received' (duration: 418.50584ms)","trace[1399041757] 'applied index is now lower than readState.Index' (duration: 186.735µs)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:09:35.018381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.897687ms","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-08-06T07:09:35.018416Z","caller":"traceutil/trace.go:171","msg":"trace[844669933] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1237; }","duration":"386.974588ms","start":"2026-08-06T07:09:34.63143Z","end":"2026-08-06T07:09:35.018405Z","steps":["trace[844669933] 'agreement among raft nodes before linearized reading' (duration: 386.844044ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:09:35.018442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:09:34.631413Z","time spent":"387.02244ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-06T07:09:35.018424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.128108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-06T07:09:35.01854Z","caller":"traceutil/trace.go:171","msg":"trace[316615920] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1237; }","duration":"419.322463ms","start":"2026-08-06T07:09:34.599199Z","end":"2026-08-06T07:09:35.018521Z","steps":["trace[316615920] 'agreement among raft nodes before linearized reading' (duration: 419.019475ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:09:35.018562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.436002ms","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-08-06T07:09:35.018603Z","caller":"traceutil/trace.go:171","msg":"trace[1805347933] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1237; }","duration":"386.490034ms","start":"2026-08-06T07:09:34.632102Z","end":"2026-08-06T07:09:35.018592Z","steps":["trace[1805347933] 'agreement among raft nodes before linearized reading' (duration: 386.398842ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:09:35.018605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:09:34.599177Z","time spent":"419.397515ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-06T07:09:35.018631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:09:34.632095Z","time spent":"386.529805ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-06T07:09:35.018722Z","caller":"traceutil/trace.go:171","msg":"trace[577104377] transaction","detail":"{read_only:false; response_revision:1237; number_of_response:1; }","duration":"432.449471ms","start":"2026-08-06T07:09:34.586263Z","end":"2026-08-06T07:09:35.018713Z","steps":["trace[577104377] 'process raft request' (duration: 431.562305ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:09:35.018792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:09:34.58624Z","time spent":"432.506293ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:09:53.715561Z","caller":"traceutil/trace.go:171","msg":"trace[1951753012] transaction","detail":"{read_only:false; response_revision:1327; number_of_response:1; }","duration":"472.060502ms","start":"2026-08-06T07:09:53.243465Z","end":"2026-08-06T07:09:53.715526Z","steps":["trace[1951753012] 'process raft request' (duration: 382.368212ms)","trace[1951753012] 'compare' (duration: 88.717901ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:09:53.715757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:09:53.243449Z","time spent":"472.205075ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":457,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:09:54.058497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.908483ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-08-06T07:09:54.058622Z","caller":"traceutil/trace.go:171","msg":"trace[1773530292] linearizableReadLoop","detail":"{readStateIndex:1384; appliedIndex:1383; }","duration":"273.204529ms","start":"2026-08-06T07:09:53.785396Z","end":"2026-08-06T07:09:54.058601Z","steps":["trace[1773530292] 'read index received' (duration: 36.341µs)","trace[1773530292] 'applied index is now lower than readState.Index' (duration: 273.166468ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:09:54.058777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.360383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-06T07:09:54.05884Z","caller":"traceutil/trace.go:171","msg":"trace[571099637] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1327; }","duration":"273.464556ms","start":"2026-08-06T07:09:53.785361Z","end":"2026-08-06T07:09:54.058825Z","steps":["trace[571099637] 'agreement among raft nodes before linearized reading' (duration: 273.355143ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:09:54.076998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.165327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-06T07:09:54.077137Z","caller":"traceutil/trace.go:171","msg":"trace[514130383] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1328; }","duration":"272.340842ms","start":"2026-08-06T07:09:53.804755Z","end":"2026-08-06T07:09:54.077096Z","steps":["trace[514130383] 'agreement among raft nodes before linearized reading' (duration: 272.021723ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:10:06.759487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.496665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T07:10:06.759582Z","caller":"traceutil/trace.go:171","msg":"trace[628572353] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1411; }","duration":"191.64193ms","start":"2026-08-06T07:10:06.567923Z","end":"2026-08-06T07:10:06.759564Z","steps":["trace[628572353] 'count revisions from in-memory index tree' (duration: 191.345071ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:10:06.759973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.94949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T07:10:06.760075Z","caller":"traceutil/trace.go:171","msg":"trace[938288554] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1411; }","duration":"295.303622ms","start":"2026-08-06T07:10:06.464727Z","end":"2026-08-06T07:10:06.760031Z","steps":["trace[938288554] 'range keys from in-memory index tree' (duration: 294.876758ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:11:11.810641Z","caller":"traceutil/trace.go:171","msg":"trace[740101322] linearizableReadLoop","detail":"{readStateIndex:1779; appliedIndex:1778; }","duration":"379.082031ms","start":"2026-08-06T07:11:11.431537Z","end":"2026-08-06T07:11:11.810619Z","steps":["trace[740101322] 'read index received' (duration: 378.925857ms)","trace[740101322] 'applied index is now lower than readState.Index' (duration: 155.324µs)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:11:11.810732Z","caller":"traceutil/trace.go:171","msg":"trace[904609724] transaction","detail":"{read_only:false; response_revision:1707; number_of_response:1; }","duration":"452.189563ms","start":"2026-08-06T07:11:11.35853Z","end":"2026-08-06T07:11:11.810719Z","steps":["trace[904609724] 'process raft request' (duration: 451.939396ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:11:11.810819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:11:11.35851Z","time spent":"452.256505ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:11:11.810882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.335568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-08-06T07:11:11.810915Z","caller":"traceutil/trace.go:171","msg":"trace[154679039] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1707; }","duration":"379.4077ms","start":"2026-08-06T07:11:11.431497Z","end":"2026-08-06T07:11:11.810905Z","steps":["trace[154679039] 'agreement among raft nodes before linearized reading' (duration: 379.243124ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:11:11.810945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:11:11.431477Z","time spent":"379.462223ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":553,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-08-06T07:11:11.811008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.966702ms","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-08-06T07:11:11.811089Z","caller":"traceutil/trace.go:171","msg":"trace[1837290850] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1707; }","duration":"347.090406ms","start":"2026-08-06T07:11:11.463977Z","end":"2026-08-06T07:11:11.811068Z","steps":["trace[1837290850] 'agreement among raft nodes before linearized reading' (duration: 346.827609ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:11:11.811107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.257323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-06T07:11:11.811126Z","caller":"traceutil/trace.go:171","msg":"trace[1375754105] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1707; }","duration":"280.309715ms","start":"2026-08-06T07:11:11.530811Z","end":"2026-08-06T07:11:11.811121Z","steps":["trace[1375754105] 'agreement among raft nodes before linearized reading' (duration: 280.255863ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:11:11.811133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:11:11.463961Z","time spent":"347.163559ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-06T07:11:11.811127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.244253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-08-06T07:11:11.811182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.514218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T07:11:11.811213Z","caller":"traceutil/trace.go:171","msg":"trace[1043747233] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1707; }","duration":"341.56313ms","start":"2026-08-06T07:11:11.46964Z","end":"2026-08-06T07:11:11.811204Z","steps":["trace[1043747233] 'agreement among raft nodes before linearized reading' (duration: 341.508399ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:11:11.811221Z","caller":"traceutil/trace.go:171","msg":"trace[526097863] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1707; }","duration":"280.381716ms","start":"2026-08-06T07:11:11.530815Z","end":"2026-08-06T07:11:11.811196Z","steps":["trace[526097863] 'agreement among raft nodes before linearized reading' (duration: 280.097168ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:11:11.811187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.142625ms","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-08-06T07:11:11.811311Z","caller":"traceutil/trace.go:171","msg":"trace[1433215363] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1707; }","duration":"322.2996ms","start":"2026-08-06T07:11:11.488981Z","end":"2026-08-06T07:11:11.81128Z","steps":["trace[1433215363] 'agreement among raft nodes before linearized reading' (duration: 322.00002ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:11:11.811375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:11:11.488969Z","time spent":"322.381603ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-06T07:11:11.81124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:11:11.469634Z","time spent":"341.601222ms","remote":"127.0.0.1:53318","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-06T07:11:11.956771Z","caller":"traceutil/trace.go:171","msg":"trace[1812540357] transaction","detail":"{read_only:false; response_revision:1709; number_of_response:1; }","duration":"141.202174ms","start":"2026-08-06T07:11:11.815534Z","end":"2026-08-06T07:11:11.956736Z","steps":["trace[1812540357] 'process raft request' (duration: 141.044408ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:11:11.95685Z","caller":"traceutil/trace.go:171","msg":"trace[383561045] transaction","detail":"{read_only:false; response_revision:1710; number_of_response:1; }","duration":"141.06555ms","start":"2026-08-06T07:11:11.815773Z","end":"2026-08-06T07:11:11.956838Z","steps":["trace[383561045] 'process raft request' (duration: 140.865224ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:11:11.956788Z","caller":"traceutil/trace.go:171","msg":"trace[243247319] transaction","detail":"{read_only:false; response_revision:1711; number_of_response:1; }","duration":"140.161272ms","start":"2026-08-06T07:11:11.816607Z","end":"2026-08-06T07:11:11.956768Z","steps":["trace[243247319] 'process raft request' (duration: 140.08097ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:11:11.957106Z","caller":"traceutil/trace.go:171","msg":"trace[2042444988] transaction","detail":"{read_only:false; response_revision:1712; number_of_response:1; }","duration":"140.026408ms","start":"2026-08-06T07:11:11.817055Z","end":"2026-08-06T07:11:11.957081Z","steps":["trace[2042444988] 'process raft request' (duration: 139.674658ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:11:11.957368Z","caller":"traceutil/trace.go:171","msg":"trace[961064087] transaction","detail":"{read_only:false; response_revision:1708; number_of_response:1; }","duration":"142.647786ms","start":"2026-08-06T07:11:11.814696Z","end":"2026-08-06T07:11:11.957344Z","steps":["trace[961064087] 'process raft request' (duration: 106.309732ms)","trace[961064087] 'compare' (duration: 35.423007ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:11:12.691913Z","caller":"traceutil/trace.go:171","msg":"trace[815883692] transaction","detail":"{read_only:false; response_revision:1713; number_of_response:1; }","duration":"175.617721ms","start":"2026-08-06T07:11:12.516261Z","end":"2026-08-06T07:11:12.691879Z","steps":["trace[815883692] 'process raft request' (duration: 175.385884ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:11:13.990859Z","caller":"traceutil/trace.go:171","msg":"trace[181071988] transaction","detail":"{read_only:false; response_revision:1717; number_of_response:1; }","duration":"117.316194ms","start":"2026-08-06T07:11:13.873515Z","end":"2026-08-06T07:11:13.990831Z","steps":["trace[181071988] 'process raft request' (duration: 60.438881ms)","trace[181071988] 'compare' (duration: 56.720169ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:11:14.133525Z","caller":"traceutil/trace.go:171","msg":"trace[2118157174] transaction","detail":"{read_only:false; response_revision:1718; number_of_response:1; }","duration":"137.723709ms","start":"2026-08-06T07:11:13.995777Z","end":"2026-08-06T07:11:14.1335Z","steps":["trace[2118157174] 'process raft request' (duration: 136.75596ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:11:14.140939Z","caller":"traceutil/trace.go:171","msg":"trace[799780124] transaction","detail":"{read_only:false; response_revision:1719; number_of_response:1; }","duration":"144.648728ms","start":"2026-08-06T07:11:13.996271Z","end":"2026-08-06T07:11:14.14092Z","steps":["trace[799780124] 'process raft request' (duration: 144.011139ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:11:14.141181Z","caller":"traceutil/trace.go:171","msg":"trace[485311919] transaction","detail":"{read_only:false; response_revision:1720; number_of_response:1; }","duration":"144.874824ms","start":"2026-08-06T07:11:13.996292Z","end":"2026-08-06T07:11:14.141167Z","steps":["trace[485311919] 'process raft request' (duration: 144.122761ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:11:14.141323Z","caller":"traceutil/trace.go:171","msg":"trace[1804077255] transaction","detail":"{read_only:false; response_revision:1721; number_of_response:1; }","duration":"144.259236ms","start":"2026-08-06T07:11:13.997053Z","end":"2026-08-06T07:11:14.141312Z","steps":["trace[1804077255] 'process raft request' (duration: 143.423771ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:11:14.141439Z","caller":"traceutil/trace.go:171","msg":"trace[1547789007] transaction","detail":"{read_only:false; response_revision:1722; number_of_response:1; }","duration":"141.862335ms","start":"2026-08-06T07:11:13.999568Z","end":"2026-08-06T07:11:14.14143Z","steps":["trace[1547789007] 'process raft request' (duration: 140.968007ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:14:13.138604Z","caller":"traceutil/trace.go:171","msg":"trace[534442854] transaction","detail":"{read_only:false; response_revision:2555; number_of_response:1; }","duration":"117.642338ms","start":"2026-08-06T07:14:13.020939Z","end":"2026-08-06T07:14:13.138581Z","steps":["trace[534442854] 'process raft request' (duration: 117.414321ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:14:15.519752Z","caller":"traceutil/trace.go:171","msg":"trace[1359291998] linearizableReadLoop","detail":"{readStateIndex:2675; appliedIndex:2674; }","duration":"372.149471ms","start":"2026-08-06T07:14:15.147568Z","end":"2026-08-06T07:14:15.519718Z","steps":["trace[1359291998] 'read index received' (duration: 371.966705ms)","trace[1359291998] 'applied index is now lower than readState.Index' (duration: 181.206µs)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:14:15.519902Z","caller":"traceutil/trace.go:171","msg":"trace[1576813393] transaction","detail":"{read_only:false; response_revision:2565; number_of_response:1; }","duration":"375.192169ms","start":"2026-08-06T07:14:15.144684Z","end":"2026-08-06T07:14:15.519876Z","steps":["trace[1576813393] 'process raft request' (duration: 374.855639ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:14:15.520022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.431748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-06T07:14:15.520093Z","caller":"traceutil/trace.go:171","msg":"trace[1387142792] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2565; }","duration":"372.510921ms","start":"2026-08-06T07:14:15.147564Z","end":"2026-08-06T07:14:15.520075Z","steps":["trace[1387142792] 'agreement among raft nodes before linearized reading' (duration: 372.324185ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:14:15.520182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:14:15.147524Z","time spent":"372.603563ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-06T07:14:15.520199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:14:15.144676Z","time spent":"375.303212ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:14:15.520476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.807761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-08-06T07:14:15.520542Z","caller":"traceutil/trace.go:171","msg":"trace[299861348] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2565; }","duration":"273.927534ms","start":"2026-08-06T07:14:15.246598Z","end":"2026-08-06T07:14:15.520526Z","steps":["trace[299861348] 'agreement among raft nodes before linearized reading' (duration: 273.77241ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:14:15.520838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.238404ms","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-08-06T07:14:15.520893Z","caller":"traceutil/trace.go:171","msg":"trace[555269263] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2565; }","duration":"274.327096ms","start":"2026-08-06T07:14:15.246556Z","end":"2026-08-06T07:14:15.520883Z","steps":["trace[555269263] 'agreement among raft nodes before linearized reading' (duration: 273.453871ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:14:15.521214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.529622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-06T07:14:15.521321Z","caller":"traceutil/trace.go:171","msg":"trace[55883135] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2565; }","duration":"274.679216ms","start":"2026-08-06T07:14:15.246617Z","end":"2026-08-06T07:14:15.521297Z","steps":["trace[55883135] 'agreement among raft nodes before linearized reading' (duration: 273.519962ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:14:17.426165Z","caller":"traceutil/trace.go:171","msg":"trace[883827314] transaction","detail":"{read_only:false; response_revision:2573; number_of_response:1; }","duration":"261.33875ms","start":"2026-08-06T07:14:17.164808Z","end":"2026-08-06T07:14:17.426147Z","steps":["trace[883827314] 'process raft request' (duration: 261.221337ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:14:19.155154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.566237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T07:14:19.155239Z","caller":"traceutil/trace.go:171","msg":"trace[206681027] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:2582; }","duration":"513.710641ms","start":"2026-08-06T07:14:18.641513Z","end":"2026-08-06T07:14:19.155224Z","steps":["trace[206681027] 'count revisions from in-memory index tree' (duration: 513.468924ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:14:19.155285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:14:18.641496Z","time spent":"513.777732ms","remote":"127.0.0.1:53740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":27,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"info","ts":"2026-08-06T07:14:19.158887Z","caller":"traceutil/trace.go:171","msg":"trace[1113060747] transaction","detail":"{read_only:false; response_revision:2583; number_of_response:1; }","duration":"399.984096ms","start":"2026-08-06T07:14:18.758882Z","end":"2026-08-06T07:14:19.158866Z","steps":["trace[1113060747] 'process raft request' (duration: 399.834551ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:14:19.159147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:14:18.758844Z","time spent":"400.09658ms","remote":"127.0.0.1:53494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7167,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:14:19.609001Z","caller":"traceutil/trace.go:171","msg":"trace[1174429788] transaction","detail":"{read_only:false; response_revision:2585; number_of_response:1; }","duration":"242.260377ms","start":"2026-08-06T07:14:19.366716Z","end":"2026-08-06T07:14:19.608976Z","steps":["trace[1174429788] 'process raft request' (duration: 241.757183ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:14:23.645147Z","caller":"traceutil/trace.go:171","msg":"trace[1064745718] linearizableReadLoop","detail":"{readStateIndex:2715; appliedIndex:2714; }","duration":"483.465824ms","start":"2026-08-06T07:14:23.161656Z","end":"2026-08-06T07:14:23.645121Z","steps":["trace[1064745718] 'read index received' (duration: 483.283488ms)","trace[1064745718] 'applied index is now lower than readState.Index' (duration: 180.916µs)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:14:23.645235Z","caller":"traceutil/trace.go:171","msg":"trace[149688984] transaction","detail":"{read_only:false; response_revision:2604; number_of_response:1; }","duration":"936.24292ms","start":"2026-08-06T07:14:22.708952Z","end":"2026-08-06T07:14:23.645195Z","steps":["trace[149688984] 'process raft request' (duration: 935.994402ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:14:23.645436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.760323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:534"} {"level":"warn","ts":"2026-08-06T07:14:23.645436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:14:22.708921Z","time spent":"936.412225ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:14:23.645492Z","caller":"traceutil/trace.go:171","msg":"trace[1229412778] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2604; }","duration":"483.884806ms","start":"2026-08-06T07:14:23.161591Z","end":"2026-08-06T07:14:23.645476Z","steps":["trace[1229412778] 'agreement among raft nodes before linearized reading' (duration: 483.67633ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:14:23.645557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:14:23.161568Z","time spent":"483.979319ms","remote":"127.0.0.1:53576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":556,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-08-06T07:14:31.818001Z","caller":"traceutil/trace.go:171","msg":"trace[1359520269] transaction","detail":"{read_only:false; response_revision:2649; number_of_response:1; }","duration":"100.7683ms","start":"2026-08-06T07:14:31.717222Z","end":"2026-08-06T07:14:31.81799Z","steps":["trace[1359520269] 'process raft request' (duration: 100.583524ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:14:31.818257Z","caller":"traceutil/trace.go:171","msg":"trace[1896354638] transaction","detail":"{read_only:false; response_revision:2650; number_of_response:1; }","duration":"100.637645ms","start":"2026-08-06T07:14:31.71759Z","end":"2026-08-06T07:14:31.818228Z","steps":["trace[1896354638] 'process raft request' (duration: 100.364607ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:14:31.8179Z","caller":"traceutil/trace.go:171","msg":"trace[1979567311] transaction","detail":"{read_only:false; response_revision:2648; number_of_response:1; }","duration":"100.727139ms","start":"2026-08-06T07:14:31.717146Z","end":"2026-08-06T07:14:31.817873Z","steps":["trace[1979567311] 'process raft request' (duration: 58.390362ms)","trace[1979567311] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/kube-system/plndr-cp-lock; req_size:415; } (duration: 42.11047ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:14:39.862628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.610881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-08-06T07:14:39.862701Z","caller":"traceutil/trace.go:171","msg":"trace[566207990] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2694; }","duration":"112.726385ms","start":"2026-08-06T07:14:39.749959Z","end":"2026-08-06T07:14:39.862685Z","steps":["trace[566207990] 'range keys from in-memory index tree' (duration: 112.462767ms)"],"step_count":1}