{"level":"warn","ts":"2026-02-11T18:12:50.473219Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-11T18:12:50.473468Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.229:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.229:2380","--initial-cluster=instance=https://199.204.45.229:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.229:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.229: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-02-11T18:12:50.473543Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-11T18:12:50.473552Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.229:2380"]} {"level":"info","ts":"2026-02-11T18:12:50.473581Z","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-02-11T18:12:50.474824Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"]} {"level":"info","ts":"2026-02-11T18:12:50.476165Z","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":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.229: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-02-11T18:12:50.483157Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.730136ms"} {"level":"info","ts":"2026-02-11T18:12:50.492439Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3ba9ae53cc4335db","cluster-id":"4ad2674607ff1d60"} {"level":"info","ts":"2026-02-11T18:12:50.492549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=()"} {"level":"info","ts":"2026-02-11T18:12:50.492596Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 0"} {"level":"info","ts":"2026-02-11T18:12:50.49262Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3ba9ae53cc4335db [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-11T18:12:50.492658Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 1"} {"level":"info","ts":"2026-02-11T18:12:50.492706Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"warn","ts":"2026-02-11T18:12:50.50248Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-11T18:12:50.517103Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-11T18:12:50.518847Z","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-02-11T18:12:50.520895Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3ba9ae53cc4335db","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-11T18:12:50.521416Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3ba9ae53cc4335db","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-11T18:12:50.521625Z","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-02-11T18:12:50.521858Z","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-02-11T18:12:50.521948Z","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-02-11T18:12:50.524749Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"info","ts":"2026-02-11T18:12:50.524843Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","added-peer-id":"3ba9ae53cc4335db","added-peer-peer-urls":["https://199.204.45.229:2380"]} {"level":"info","ts":"2026-02-11T18:12:50.531801Z","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-02-11T18:12:50.532011Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3ba9ae53cc4335db","initial-advertise-peer-urls":["https://199.204.45.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-11T18:12:50.53206Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-11T18:12:50.532595Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-02-11T18:12:50.53572Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-02-11T18:12:50.99315Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db is starting a new election at term 1"} {"level":"info","ts":"2026-02-11T18:12:50.993263Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became pre-candidate at term 1"} {"level":"info","ts":"2026-02-11T18:12:50.993299Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgPreVoteResp from 3ba9ae53cc4335db at term 1"} {"level":"info","ts":"2026-02-11T18:12:50.993322Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became candidate at term 2"} {"level":"info","ts":"2026-02-11T18:12:50.993354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgVoteResp from 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-02-11T18:12:50.993377Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became leader at term 2"} {"level":"info","ts":"2026-02-11T18:12:50.993407Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3ba9ae53cc4335db elected leader 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-02-11T18:12:50.996959Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T18:12:50.999805Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3ba9ae53cc4335db","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.229:2379]}","request-path":"/0/members/3ba9ae53cc4335db/attributes","cluster-id":"4ad2674607ff1d60","publish-timeout":"7s"} {"level":"info","ts":"2026-02-11T18:12:50.999986Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T18:12:51.000131Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T18:12:51.000207Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T18:12:51.000225Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-11T18:12:51.000616Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-11T18:12:51.002148Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-11T18:12:51.004333Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.229:2379"} {"level":"info","ts":"2026-02-11T18:12:51.005242Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-11T18:12:51.005264Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-11T18:12:52.980327Z","caller":"traceutil/trace.go:171","msg":"trace[118774550] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"233.964173ms","start":"2026-02-11T18:12:52.745757Z","end":"2026-02-11T18:12:52.979722Z","steps":["trace[118774550] 'process raft request' (duration: 233.66046ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:12:52.988381Z","caller":"traceutil/trace.go:171","msg":"trace[468267549] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"241.639108ms","start":"2026-02-11T18:12:52.746733Z","end":"2026-02-11T18:12:52.988372Z","steps":["trace[468267549] 'read index received' (duration: 232.566668ms)","trace[468267549] 'applied index is now lower than readState.Index' (duration: 9.07201ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:12:52.988447Z","caller":"traceutil/trace.go:171","msg":"trace[1552895971] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"242.428377ms","start":"2026-02-11T18:12:52.746013Z","end":"2026-02-11T18:12:52.988441Z","steps":["trace[1552895971] 'process raft request' (duration: 242.160124ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:12:52.988608Z","caller":"traceutil/trace.go:171","msg":"trace[492865436] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"193.545575ms","start":"2026-02-11T18:12:52.795057Z","end":"2026-02-11T18:12:52.988602Z","steps":["trace[492865436] 'process raft request' (duration: 193.174491ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:12:52.988757Z","caller":"traceutil/trace.go:171","msg":"trace[1787567750] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"186.491087ms","start":"2026-02-11T18:12:52.802256Z","end":"2026-02-11T18:12:52.988748Z","steps":["trace[1787567750] 'process raft request' (duration: 185.997282ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:12:52.988885Z","caller":"traceutil/trace.go:171","msg":"trace[367536912] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"157.298484ms","start":"2026-02-11T18:12:52.831581Z","end":"2026-02-11T18:12:52.988879Z","steps":["trace[367536912] 'process raft request' (duration: 156.691517ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:12:52.988998Z","caller":"traceutil/trace.go:171","msg":"trace[1260051869] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"157.131651ms","start":"2026-02-11T18:12:52.831861Z","end":"2026-02-11T18:12:52.988993Z","steps":["trace[1260051869] 'process raft request' (duration: 156.427973ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:12:52.989065Z","caller":"traceutil/trace.go:171","msg":"trace[660208945] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"157.113361ms","start":"2026-02-11T18:12:52.831947Z","end":"2026-02-11T18:12:52.98906Z","steps":["trace[660208945] 'process raft request' (duration: 156.354012ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:12:52.989132Z","caller":"traceutil/trace.go:171","msg":"trace[468484496] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"157.151772ms","start":"2026-02-11T18:12:52.831974Z","end":"2026-02-11T18:12:52.989126Z","steps":["trace[468484496] 'process raft request' (duration: 156.342703ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:12:52.989196Z","caller":"traceutil/trace.go:171","msg":"trace[1957577343] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"157.150811ms","start":"2026-02-11T18:12:52.832041Z","end":"2026-02-11T18:12:52.989192Z","steps":["trace[1957577343] 'process raft request' (duration: 156.292882ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:12:52.989266Z","caller":"traceutil/trace.go:171","msg":"trace[900587563] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"157.119381ms","start":"2026-02-11T18:12:52.832141Z","end":"2026-02-11T18:12:52.989261Z","steps":["trace[900587563] 'process raft request' (duration: 156.213041ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:12:52.989394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.646169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:2859"} {"level":"info","ts":"2026-02-11T18:12:52.989419Z","caller":"traceutil/trace.go:171","msg":"trace[455819615] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"242.69512ms","start":"2026-02-11T18:12:52.746717Z","end":"2026-02-11T18:12:52.989412Z","steps":["trace[455819615] 'agreement among raft nodes before linearized reading' (duration: 242.604539ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:12:52.989929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.076718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.229\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-11T18:12:52.989964Z","caller":"traceutil/trace.go:171","msg":"trace[1498972676] range","detail":"{range_begin:/registry/masterleases/199.204.45.229; range_end:; response_count:0; response_revision:11; }","duration":"201.13047ms","start":"2026-02-11T18:12:52.788819Z","end":"2026-02-11T18:12:52.98995Z","steps":["trace[1498972676] 'agreement among raft nodes before linearized reading' (duration: 201.082979ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:12:52.992016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.364786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-11T18:12:52.992059Z","caller":"traceutil/trace.go:171","msg":"trace[1346456366] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"103.395876ms","start":"2026-02-11T18:12:52.888643Z","end":"2026-02-11T18:12:52.992039Z","steps":["trace[1346456366] 'agreement among raft nodes before linearized reading' (duration: 103.255044ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:12:52.992581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.287434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-11T18:12:52.992607Z","caller":"traceutil/trace.go:171","msg":"trace[1163110094] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"139.334354ms","start":"2026-02-11T18:12:52.853265Z","end":"2026-02-11T18:12:52.992599Z","steps":["trace[1163110094] 'agreement among raft nodes before linearized reading' (duration: 139.293524ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:12:52.992812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.602122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-11T18:12:52.992845Z","caller":"traceutil/trace.go:171","msg":"trace[1177233479] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"181.649614ms","start":"2026-02-11T18:12:52.811186Z","end":"2026-02-11T18:12:52.992836Z","steps":["trace[1177233479] 'agreement among raft nodes before linearized reading' (duration: 181.545503ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:12:52.992923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.298574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-11T18:12:52.992944Z","caller":"traceutil/trace.go:171","msg":"trace[736279047] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"203.342484ms","start":"2026-02-11T18:12:52.789594Z","end":"2026-02-11T18:12:52.992937Z","steps":["trace[736279047] 'agreement among raft nodes before linearized reading' (duration: 203.281773ms)"],"step_count":1} 2026/02/11 18:12:55 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-11T18:12:56.360919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.434512ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-11T18:12:56.361423Z","caller":"traceutil/trace.go:171","msg":"trace[460088427] transaction","detail":"{read_only:false; response_revision:285; number_of_response:1; }","duration":"231.112816ms","start":"2026-02-11T18:12:56.130235Z","end":"2026-02-11T18:12:56.361348Z","steps":["trace[460088427] 'process raft request' (duration: 108.39218ms)","trace[460088427] 'compare' (duration: 121.122068ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:12:56.363214Z","caller":"traceutil/trace.go:171","msg":"trace[1149969820] transaction","detail":"{read_only:false; response_revision:286; number_of_response:1; }","duration":"232.865974ms","start":"2026-02-11T18:12:56.13032Z","end":"2026-02-11T18:12:56.363186Z","steps":["trace[1149969820] 'process raft request' (duration: 231.860654ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:12:56.365845Z","caller":"traceutil/trace.go:171","msg":"trace[494030003] transaction","detail":"{read_only:false; response_revision:287; number_of_response:1; }","duration":"233.36181ms","start":"2026-02-11T18:12:56.132467Z","end":"2026-02-11T18:12:56.365828Z","steps":["trace[494030003] 'process raft request' (duration: 230.640711ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:12:56.769841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.046343ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-11T18:12:56.770075Z","caller":"traceutil/trace.go:171","msg":"trace[58266773] transaction","detail":"{read_only:false; response_revision:293; number_of_response:1; }","duration":"142.278587ms","start":"2026-02-11T18:12:56.627775Z","end":"2026-02-11T18:12:56.770054Z","steps":["trace[58266773] 'process raft request' (duration: 26.970031ms)","trace[58266773] 'compare' (duration: 114.868131ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:12:57.298897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.0614ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T18:12:57.298956Z","caller":"traceutil/trace.go:171","msg":"trace[1353963310] linearizableReadLoop","detail":"{readStateIndex:313; appliedIndex:312; }","duration":"202.091349ms","start":"2026-02-11T18:12:57.096854Z","end":"2026-02-11T18:12:57.298945Z","steps":["trace[1353963310] 'read index received' (duration: 65.805026ms)","trace[1353963310] 'applied index is now lower than readState.Index' (duration: 136.285763ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:12:57.29908Z","caller":"traceutil/trace.go:171","msg":"trace[175045263] transaction","detail":"{read_only:false; response_revision:300; number_of_response:1; }","duration":"221.443606ms","start":"2026-02-11T18:12:57.07763Z","end":"2026-02-11T18:12:57.299074Z","steps":["trace[175045263] 'process raft request' (duration: 85.077303ms)","trace[175045263] 'compare' (duration: 135.729906ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:12:57.299179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.327941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T18:12:57.299195Z","caller":"traceutil/trace.go:171","msg":"trace[1537317150] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:0; response_revision:300; }","duration":"202.373421ms","start":"2026-02-11T18:12:57.096816Z","end":"2026-02-11T18:12:57.299189Z","steps":["trace[1537317150] 'agreement among raft nodes before linearized reading' (duration: 202.345871ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:12:57.299266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.392414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-11T18:12:57.299278Z","caller":"traceutil/trace.go:171","msg":"trace[2015784696] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:300; }","duration":"137.404574ms","start":"2026-02-11T18:12:57.161869Z","end":"2026-02-11T18:12:57.299274Z","steps":["trace[2015784696] 'agreement among raft nodes before linearized reading' (duration: 137.382194ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:12:57.299385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.787966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-11T18:12:57.299399Z","caller":"traceutil/trace.go:171","msg":"trace[1565712169] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:300; }","duration":"134.823957ms","start":"2026-02-11T18:12:57.164571Z","end":"2026-02-11T18:12:57.299395Z","steps":["trace[1565712169] 'agreement among raft nodes before linearized reading' (duration: 134.800846ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:12:57.538558Z","caller":"traceutil/trace.go:171","msg":"trace[1666414805] transaction","detail":"{read_only:false; response_revision:302; number_of_response:1; }","duration":"229.634604ms","start":"2026-02-11T18:12:57.308901Z","end":"2026-02-11T18:12:57.538536Z","steps":["trace[1666414805] 'process raft request' (duration: 158.992866ms)","trace[1666414805] 'compare' (duration: 70.193333ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:12:57.538707Z","caller":"traceutil/trace.go:171","msg":"trace[739963625] linearizableReadLoop","detail":"{readStateIndex:317; appliedIndex:314; }","duration":"180.477827ms","start":"2026-02-11T18:12:57.358208Z","end":"2026-02-11T18:12:57.538685Z","steps":["trace[739963625] 'read index received' (duration: 109.632606ms)","trace[739963625] 'applied index is now lower than readState.Index' (duration: 70.844311ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:12:57.538765Z","caller":"traceutil/trace.go:171","msg":"trace[2048269336] transaction","detail":"{read_only:false; response_revision:303; number_of_response:1; }","duration":"229.802595ms","start":"2026-02-11T18:12:57.308955Z","end":"2026-02-11T18:12:57.538757Z","steps":["trace[2048269336] 'process raft request' (duration: 229.575073ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:12:57.538837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.608278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/statefulset-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T18:12:57.538872Z","caller":"traceutil/trace.go:171","msg":"trace[1773976288] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/statefulset-controller; range_end:; response_count:0; response_revision:304; }","duration":"180.675209ms","start":"2026-02-11T18:12:57.358185Z","end":"2026-02-11T18:12:57.53886Z","steps":["trace[1773976288] 'agreement among raft nodes before linearized reading' (duration: 180.582568ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:12:57.538954Z","caller":"traceutil/trace.go:171","msg":"trace[1993369076] transaction","detail":"{read_only:false; response_revision:304; number_of_response:1; }","duration":"228.196969ms","start":"2026-02-11T18:12:57.31075Z","end":"2026-02-11T18:12:57.538947Z","steps":["trace[1993369076] 'process raft request' (duration: 227.887995ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:12:57.953222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.902956ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T18:12:57.953381Z","caller":"traceutil/trace.go:171","msg":"trace[1431257970] transaction","detail":"{read_only:false; response_revision:305; number_of_response:1; }","duration":"406.834136ms","start":"2026-02-11T18:12:57.546528Z","end":"2026-02-11T18:12:57.953362Z","steps":["trace[1431257970] 'process raft request' (duration: 191.718237ms)","trace[1431257970] 'compare' (duration: 211.080275ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:12:57.953443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:12:57.546518Z","time spent":"406.896566ms","remote":"127.0.0.1:54494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T18:12:57.955385Z","caller":"traceutil/trace.go:171","msg":"trace[1301324848] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"408.2062ms","start":"2026-02-11T18:12:57.547169Z","end":"2026-02-11T18:12:57.955376Z","steps":["trace[1301324848] 'process raft request' (duration: 406.149048ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:12:57.955618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:12:57.547158Z","time spent":"408.435413ms","remote":"127.0.0.1:54502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":194,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-11T18:12:57.955902Z","caller":"traceutil/trace.go:171","msg":"trace[539839930] linearizableReadLoop","detail":"{readStateIndex:319; appliedIndex:317; }","duration":"203.390853ms","start":"2026-02-11T18:12:57.750385Z","end":"2026-02-11T18:12:57.953775Z","steps":["trace[539839930] 'read index received' (duration: 126.601759ms)","trace[539839930] 'applied index is now lower than readState.Index' (duration: 76.788294ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:12:57.959188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.798591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-11T18:12:57.960158Z","caller":"traceutil/trace.go:171","msg":"trace[680800910] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:306; }","duration":"209.800131ms","start":"2026-02-11T18:12:57.750349Z","end":"2026-02-11T18:12:57.96015Z","steps":["trace[680800910] 'agreement among raft nodes before linearized reading' (duration: 208.76208ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:12:59.293108Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880867362327150270,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-11T18:12:59.378587Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.401655319s","expected-duration":"1s"} {"level":"info","ts":"2026-02-11T18:12:59.379098Z","caller":"traceutil/trace.go:171","msg":"trace[1004204832] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"1.402209274s","start":"2026-02-11T18:12:57.976864Z","end":"2026-02-11T18:12:59.379074Z","steps":["trace[1004204832] 'process raft request' (duration: 1.402059802s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:12:59.379237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:12:57.976854Z","time spent":"1.402308535s","remote":"127.0.0.1:54494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4245,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T18:13:00.673734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.512148ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-11T18:13:00.673893Z","caller":"traceutil/trace.go:171","msg":"trace[218253998] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"2.696783884s","start":"2026-02-11T18:12:57.97709Z","end":"2026-02-11T18:13:00.673873Z","steps":["trace[218253998] 'process raft request' (duration: 2.158891792s)","trace[218253998] 'compare' (duration: 537.254546ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:13:00.673951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:12:57.977084Z","time spent":"2.696842235s","remote":"127.0.0.1:54502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":199,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-11T18:13:00.674245Z","caller":"traceutil/trace.go:171","msg":"trace[1537267848] linearizableReadLoop","detail":"{readStateIndex:322; appliedIndex:319; }","duration":"1.882105623s","start":"2026-02-11T18:12:58.792129Z","end":"2026-02-11T18:13:00.674234Z","steps":["trace[1537267848] 'read index received' (duration: 586.822585ms)","trace[1537267848] 'applied index is now lower than readState.Index' (duration: 1.295280458s)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:13:00.674407Z","caller":"traceutil/trace.go:171","msg":"trace[1051285953] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"2.697274619s","start":"2026-02-11T18:12:57.977124Z","end":"2026-02-11T18:13:00.674398Z","steps":["trace[1051285953] 'process raft request' (duration: 2.696709363s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:00.674465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:12:57.977119Z","time spent":"2.69730908s","remote":"127.0.0.1:54572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T18:13:00.674633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.882513397s","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-02-11T18:13:00.674662Z","caller":"traceutil/trace.go:171","msg":"trace[1382808831] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:309; }","duration":"1.882578078s","start":"2026-02-11T18:12:58.792075Z","end":"2026-02-11T18:13:00.674654Z","steps":["trace[1382808831] 'agreement among raft nodes before linearized reading' (duration: 1.882486127s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:00.674688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:12:58.792057Z","time spent":"1.882625079s","remote":"127.0.0.1:54572","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-02-11T18:13:00.674822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.291053172s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5098"} {"level":"info","ts":"2026-02-11T18:13:00.674847Z","caller":"traceutil/trace.go:171","msg":"trace[1431517716] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:309; }","duration":"1.291078242s","start":"2026-02-11T18:12:59.383762Z","end":"2026-02-11T18:13:00.67484Z","steps":["trace[1431517716] 'agreement among raft nodes before linearized reading' (duration: 1.291025852s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:00.674871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:12:59.383717Z","time spent":"1.291148904s","remote":"127.0.0.1:54494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":5120,"request content":"key:\"/registry/pods/kube-system/etcd-instance\" "} {"level":"warn","ts":"2026-02-11T18:13:00.67504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.127091743s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-11T18:13:00.675065Z","caller":"traceutil/trace.go:171","msg":"trace[1491208716] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:309; }","duration":"1.127131464s","start":"2026-02-11T18:12:59.547927Z","end":"2026-02-11T18:13:00.675058Z","steps":["trace[1491208716] 'agreement among raft nodes before linearized reading' (duration: 1.127087113s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:00.675089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:12:59.54792Z","time spent":"1.127163314s","remote":"127.0.0.1:54572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-11T18:13:00.675195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.12774391s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-11T18:13:00.675218Z","caller":"traceutil/trace.go:171","msg":"trace[1580958065] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:309; }","duration":"1.127793061s","start":"2026-02-11T18:12:59.547418Z","end":"2026-02-11T18:13:00.675211Z","steps":["trace[1580958065] 'agreement among raft nodes before linearized reading' (duration: 1.127755221s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:00.675241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:12:59.547404Z","time spent":"1.127831582s","remote":"127.0.0.1:54572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-11T18:13:01.48697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.037757ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T18:13:01.48714Z","caller":"traceutil/trace.go:171","msg":"trace[1389448699] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"801.056629ms","start":"2026-02-11T18:13:00.686055Z","end":"2026-02-11T18:13:01.487111Z","steps":["trace[1389448699] 'process raft request' (duration: 374.798929ms)","trace[1389448699] 'compare' (duration: 425.906616ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:13:01.487205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:00.686037Z","time spent":"801.13874ms","remote":"127.0.0.1:54494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5255,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T18:13:01.487374Z","caller":"traceutil/trace.go:171","msg":"trace[1755137731] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"801.075259ms","start":"2026-02-11T18:13:00.686285Z","end":"2026-02-11T18:13:01.48736Z","steps":["trace[1755137731] 'process raft request' (duration: 800.775566ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:01.487459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:00.686261Z","time spent":"801.15047ms","remote":"127.0.0.1:54572","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-02-11T18:13:01.487705Z","caller":"traceutil/trace.go:171","msg":"trace[196248929] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"801.329562ms","start":"2026-02-11T18:13:00.686368Z","end":"2026-02-11T18:13:01.487698Z","steps":["trace[196248929] 'process raft request' (duration: 800.911998ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:01.487733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:00.68636Z","time spent":"801.357532ms","remote":"127.0.0.1:54572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T18:13:01.487788Z","caller":"traceutil/trace.go:171","msg":"trace[41089614] linearizableReadLoop","detail":"{readStateIndex:326; appliedIndex:322; }","duration":"800.754886ms","start":"2026-02-11T18:13:00.687028Z","end":"2026-02-11T18:13:01.487783Z","steps":["trace[41089614] 'read index received' (duration: 373.836129ms)","trace[41089614] 'applied index is now lower than readState.Index' (duration: 426.918267ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:13:01.487899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"735.797981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T18:13:01.487916Z","caller":"traceutil/trace.go:171","msg":"trace[927163699] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"801.512444ms","start":"2026-02-11T18:13:00.686396Z","end":"2026-02-11T18:13:01.487908Z","steps":["trace[927163699] 'process raft request' (duration: 801.277742ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:01.48794Z","caller":"traceutil/trace.go:171","msg":"trace[249403268] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:313; }","duration":"735.869431ms","start":"2026-02-11T18:13:00.75206Z","end":"2026-02-11T18:13:01.487929Z","steps":["trace[249403268] 'agreement among raft nodes before linearized reading' (duration: 735.811361ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:01.48795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:00.686392Z","time spent":"801.541664ms","remote":"127.0.0.1:54572","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-02-11T18:13:01.487973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:00.752042Z","time spent":"735.925012ms","remote":"127.0.0.1:54316","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-02-11T18:13:01.488064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"801.034419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-11T18:13:01.488082Z","caller":"traceutil/trace.go:171","msg":"trace[1662711159] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:313; }","duration":"801.050969ms","start":"2026-02-11T18:13:00.687025Z","end":"2026-02-11T18:13:01.488076Z","steps":["trace[1662711159] 'agreement among raft nodes before linearized reading' (duration: 801.018099ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:01.488107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:00.687006Z","time spent":"801.098119ms","remote":"127.0.0.1:54418","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-02-11T18:13:01.80244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.652082ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-11T18:13:01.802868Z","caller":"traceutil/trace.go:171","msg":"trace[2116845360] linearizableReadLoop","detail":"{readStateIndex:327; appliedIndex:326; }","duration":"307.836888ms","start":"2026-02-11T18:13:01.495013Z","end":"2026-02-11T18:13:01.80285Z","steps":["trace[2116845360] 'read index received' (duration: 110.777331ms)","trace[2116845360] 'applied index is now lower than readState.Index' (duration: 197.057677ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:13:01.803255Z","caller":"traceutil/trace.go:171","msg":"trace[443571527] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"308.291183ms","start":"2026-02-11T18:13:01.49495Z","end":"2026-02-11T18:13:01.803241Z","steps":["trace[443571527] 'process raft request' (duration: 110.781282ms)","trace[443571527] 'compare' (duration: 196.506781ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:13:01.803441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:01.494935Z","time spent":"308.443325ms","remote":"127.0.0.1:54502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":219,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-11T18:13:01.804199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.118611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7045"} {"level":"info","ts":"2026-02-11T18:13:01.804341Z","caller":"traceutil/trace.go:171","msg":"trace[1487515160] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:314; }","duration":"309.351705ms","start":"2026-02-11T18:13:01.494979Z","end":"2026-02-11T18:13:01.804331Z","steps":["trace[1487515160] 'agreement among raft nodes before linearized reading' (duration: 309.055151ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:01.804419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:01.494963Z","time spent":"309.446685ms","remote":"127.0.0.1:54494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":7067,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"info","ts":"2026-02-11T18:13:02.020287Z","caller":"traceutil/trace.go:171","msg":"trace[2016258554] linearizableReadLoop","detail":"{readStateIndex:329; appliedIndex:328; }","duration":"116.4361ms","start":"2026-02-11T18:13:01.903826Z","end":"2026-02-11T18:13:02.020262Z","steps":["trace[2016258554] 'read index received' (duration: 20.765798ms)","trace[2016258554] 'applied index is now lower than readState.Index' (duration: 95.669402ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:13:02.020411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.568692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6688"} {"level":"info","ts":"2026-02-11T18:13:02.020441Z","caller":"traceutil/trace.go:171","msg":"trace[303393747] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:316; }","duration":"116.628322ms","start":"2026-02-11T18:13:01.903804Z","end":"2026-02-11T18:13:02.020432Z","steps":["trace[303393747] 'agreement among raft nodes before linearized reading' (duration: 116.539491ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:02.020663Z","caller":"traceutil/trace.go:171","msg":"trace[835009692] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"203.512823ms","start":"2026-02-11T18:13:01.817137Z","end":"2026-02-11T18:13:02.02065Z","steps":["trace[835009692] 'process raft request' (duration: 107.498717ms)","trace[835009692] 'compare' (duration: 95.36244ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:13:02.362748Z","caller":"traceutil/trace.go:171","msg":"trace[400252489] linearizableReadLoop","detail":"{readStateIndex:331; appliedIndex:330; }","duration":"262.303937ms","start":"2026-02-11T18:13:02.100423Z","end":"2026-02-11T18:13:02.362727Z","steps":["trace[400252489] 'read index received' (duration: 173.209647ms)","trace[400252489] 'applied index is now lower than readState.Index' (duration: 89.093409ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:13:02.363474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.031224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/pvc-protection-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T18:13:02.363534Z","caller":"traceutil/trace.go:171","msg":"trace[2046089202] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/pvc-protection-controller; range_end:; response_count:0; response_revision:318; }","duration":"263.123715ms","start":"2026-02-11T18:13:02.100387Z","end":"2026-02-11T18:13:02.363511Z","steps":["trace[2046089202] 'agreement among raft nodes before linearized reading' (duration: 262.420497ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:02.364964Z","caller":"traceutil/trace.go:171","msg":"trace[1359447942] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"333.628179ms","start":"2026-02-11T18:13:02.03017Z","end":"2026-02-11T18:13:02.363798Z","steps":["trace[1359447942] 'process raft request' (duration: 243.64686ms)","trace[1359447942] 'compare' (duration: 88.710905ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:13:02.365254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:02.030159Z","time spent":"334.915982ms","remote":"127.0.0.1:54494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6883,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T18:13:02.518253Z","caller":"traceutil/trace.go:171","msg":"trace[1022154721] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"142.79982ms","start":"2026-02-11T18:13:02.375429Z","end":"2026-02-11T18:13:02.518229Z","steps":["trace[1022154721] 'process raft request' (duration: 111.032848ms)","trace[1022154721] 'compare' (duration: 31.420318ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:13:02.791059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.838575ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-11T18:13:02.791617Z","caller":"traceutil/trace.go:171","msg":"trace[910718517] linearizableReadLoop","detail":"{readStateIndex:337; appliedIndex:336; }","duration":"109.2813ms","start":"2026-02-11T18:13:02.682313Z","end":"2026-02-11T18:13:02.791594Z","steps":["trace[910718517] 'read index received' (duration: 819.629µs)","trace[910718517] 'applied index is now lower than readState.Index' (duration: 108.459501ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:13:02.791922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.605053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-11T18:13:02.792071Z","caller":"traceutil/trace.go:171","msg":"trace[645952968] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:324; }","duration":"109.795786ms","start":"2026-02-11T18:13:02.682263Z","end":"2026-02-11T18:13:02.792059Z","steps":["trace[645952968] 'agreement among raft nodes before linearized reading' (duration: 109.508253ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:02.792489Z","caller":"traceutil/trace.go:171","msg":"trace[796477824] transaction","detail":"{read_only:false; response_revision:324; number_of_response:1; }","duration":"191.514598ms","start":"2026-02-11T18:13:02.600958Z","end":"2026-02-11T18:13:02.792473Z","steps":["trace[796477824] 'process raft request' (duration: 82.187998ms)","trace[796477824] 'compare' (duration: 107.40826ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:13:03.107704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.413244ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-11T18:13:03.107875Z","caller":"traceutil/trace.go:171","msg":"trace[827136734] transaction","detail":"{read_only:false; response_revision:327; number_of_response:1; }","duration":"250.250615ms","start":"2026-02-11T18:13:02.857598Z","end":"2026-02-11T18:13:03.107848Z","steps":["trace[827136734] 'process raft request' (duration: 74.627059ms)","trace[827136734] 'compare' (duration: 175.083231ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:13:03.993421Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880867362327150340,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-11T18:13:04.493568Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880867362327150340,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-11T18:13:04.995707Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880867362327150340,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-11T18:13:05.148733Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.797349372s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-11T18:13:05.260752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.787308ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-11T18:13:05.260893Z","caller":"traceutil/trace.go:171","msg":"trace[152808072] transaction","detail":"{read_only:false; response_revision:332; number_of_response:1; }","duration":"1.909582175s","start":"2026-02-11T18:13:03.351247Z","end":"2026-02-11T18:13:05.260829Z","steps":["trace[152808072] 'process raft request' (duration: 1.797661455s)","trace[152808072] 'compare' (duration: 111.660017ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:13:05.260986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:03.35123Z","time spent":"1.909731056s","remote":"127.0.0.1:54502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":194,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-11T18:13:05.267714Z","caller":"traceutil/trace.go:171","msg":"trace[484943645] linearizableReadLoop","detail":"{readStateIndex:346; appliedIndex:344; }","duration":"1.774783425s","start":"2026-02-11T18:13:03.4929Z","end":"2026-02-11T18:13:05.267683Z","steps":["trace[484943645] 'read index received' (duration: 1.656017915s)","trace[484943645] 'applied index is now lower than readState.Index' (duration: 118.76466ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:13:05.269597Z","caller":"traceutil/trace.go:171","msg":"trace[556516050] transaction","detail":"{read_only:false; response_revision:333; number_of_response:1; }","duration":"1.648600056s","start":"2026-02-11T18:13:03.620923Z","end":"2026-02-11T18:13:05.269523Z","steps":["trace[556516050] 'process raft request' (duration: 1.646404433s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:05.269936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:03.62089Z","time spent":"1.648864049s","remote":"127.0.0.1:54572","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-02-11T18:13:05.270335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.777432873s","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-02-11T18:13:05.270492Z","caller":"traceutil/trace.go:171","msg":"trace[3291494] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:333; }","duration":"1.777610115s","start":"2026-02-11T18:13:03.492873Z","end":"2026-02-11T18:13:05.270483Z","steps":["trace[3291494] 'agreement among raft nodes before linearized reading' (duration: 1.777429613s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:05.270685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:03.492861Z","time spent":"1.777815917s","remote":"127.0.0.1:54572","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-02-11T18:13:05.27051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.777595744s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-02-11T18:13:05.271239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.995978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T18:13:05.271291Z","caller":"traceutil/trace.go:171","msg":"trace[785444486] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:333; }","duration":"471.061619ms","start":"2026-02-11T18:13:04.800221Z","end":"2026-02-11T18:13:05.271283Z","steps":["trace[785444486] 'agreement among raft nodes before linearized reading' (duration: 470.994148ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:05.271427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:04.800214Z","time spent":"471.205291ms","remote":"127.0.0.1:54316","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-02-11T18:13:05.270839Z","caller":"traceutil/trace.go:171","msg":"trace[172508801] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:333; }","duration":"1.777973478s","start":"2026-02-11T18:13:03.492854Z","end":"2026-02-11T18:13:05.270828Z","steps":["trace[172508801] 'agreement among raft nodes before linearized reading' (duration: 1.777589854s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:05.271623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:03.492835Z","time spent":"1.778779546s","remote":"127.0.0.1:54572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-11T18:13:05.271968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.352793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-11T18:13:05.272018Z","caller":"traceutil/trace.go:171","msg":"trace[785261106] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:333; }","duration":"440.460323ms","start":"2026-02-11T18:13:04.831549Z","end":"2026-02-11T18:13:05.27201Z","steps":["trace[785261106] 'agreement among raft nodes before linearized reading' (duration: 440.375383ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:05.272086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:04.831527Z","time spent":"440.552434ms","remote":"127.0.0.1:54572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-11T18:13:05.272265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.655376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4260"} {"level":"info","ts":"2026-02-11T18:13:05.272289Z","caller":"traceutil/trace.go:171","msg":"trace[1463704726] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:333; }","duration":"503.711076ms","start":"2026-02-11T18:13:04.768572Z","end":"2026-02-11T18:13:05.272283Z","steps":["trace[1463704726] 'agreement among raft nodes before linearized reading' (duration: 503.664036ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:05.272401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.774258349s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-02-11T18:13:05.272563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:04.768555Z","time spent":"504.000979ms","remote":"127.0.0.1:54494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4282,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"info","ts":"2026-02-11T18:13:05.272752Z","caller":"traceutil/trace.go:171","msg":"trace[1323289228] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:333; }","duration":"1.774622794s","start":"2026-02-11T18:13:03.498093Z","end":"2026-02-11T18:13:05.272716Z","steps":["trace[1323289228] 'agreement among raft nodes before linearized reading' (duration: 1.77427635s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:05.27284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:03.498083Z","time spent":"1.774748495s","remote":"127.0.0.1:54572","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-02-11T18:13:05.272434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.055398692s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.229\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-11T18:13:05.273059Z","caller":"traceutil/trace.go:171","msg":"trace[319104739] range","detail":"{range_begin:/registry/masterleases/199.204.45.229; range_end:; response_count:1; response_revision:333; }","duration":"1.056042768s","start":"2026-02-11T18:13:04.217008Z","end":"2026-02-11T18:13:05.27305Z","steps":["trace[319104739] 'agreement among raft nodes before linearized reading' (duration: 1.055407612s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:05.27314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:04.216991Z","time spent":"1.05613772s","remote":"127.0.0.1:54338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.229\" "} {"level":"warn","ts":"2026-02-11T18:13:05.770255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.635005ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T18:13:05.770489Z","caller":"traceutil/trace.go:171","msg":"trace[283402580] transaction","detail":"{read_only:false; response_revision:334; number_of_response:1; }","duration":"483.338384ms","start":"2026-02-11T18:13:05.28712Z","end":"2026-02-11T18:13:05.770458Z","steps":["trace[283402580] 'process raft request' (duration: 228.420896ms)","trace[283402580] 'compare' (duration: 254.500333ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:13:05.770606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:05.287108Z","time spent":"483.422166ms","remote":"127.0.0.1:54572","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-02-11T18:13:05.770804Z","caller":"traceutil/trace.go:171","msg":"trace[2016969345] linearizableReadLoop","detail":"{readStateIndex:353; appliedIndex:347; }","duration":"423.960184ms","start":"2026-02-11T18:13:05.346701Z","end":"2026-02-11T18:13:05.770662Z","steps":["trace[2016969345] 'read index received' (duration: 168.847574ms)","trace[2016969345] 'applied index is now lower than readState.Index' (duration: 255.1114ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:13:05.770895Z","caller":"traceutil/trace.go:171","msg":"trace[24830128] transaction","detail":"{read_only:false; response_revision:337; number_of_response:1; }","duration":"462.982245ms","start":"2026-02-11T18:13:05.307906Z","end":"2026-02-11T18:13:05.770888Z","steps":["trace[24830128] 'process raft request' (duration: 462.587281ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:05.770927Z","caller":"traceutil/trace.go:171","msg":"trace[337086571] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"483.552067ms","start":"2026-02-11T18:13:05.287368Z","end":"2026-02-11T18:13:05.77092Z","steps":["trace[337086571] 'process raft request' (duration: 483.013121ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:05.770981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:05.287363Z","time spent":"483.580927ms","remote":"127.0.0.1:54494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4245,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T18:13:05.771008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:05.307902Z","time spent":"463.017886ms","remote":"127.0.0.1:54572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T18:13:05.771044Z","caller":"traceutil/trace.go:171","msg":"trace[883651855] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"463.249018ms","start":"2026-02-11T18:13:05.307789Z","end":"2026-02-11T18:13:05.771038Z","steps":["trace[883651855] 'process raft request' (duration: 462.677492ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:05.771073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:05.307776Z","time spent":"463.282108ms","remote":"127.0.0.1:54338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T18:13:05.771273Z","caller":"traceutil/trace.go:171","msg":"trace[452500499] transaction","detail":"{read_only:false; response_revision:338; number_of_response:1; }","duration":"460.854553ms","start":"2026-02-11T18:13:05.310408Z","end":"2026-02-11T18:13:05.771263Z","steps":["trace[452500499] 'process raft request' (duration: 460.123916ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:05.771354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.705377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-02-11T18:13:05.771383Z","caller":"traceutil/trace.go:171","msg":"trace[215089185] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:339; }","duration":"406.761878ms","start":"2026-02-11T18:13:05.364615Z","end":"2026-02-11T18:13:05.771377Z","steps":["trace[215089185] 'agreement among raft nodes before linearized reading' (duration: 406.702818ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:05.7714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:05.364602Z","time spent":"406.794248ms","remote":"127.0.0.1:54502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":219,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" "} {"level":"warn","ts":"2026-02-11T18:13:05.771397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:05.310402Z","time spent":"460.892993ms","remote":"127.0.0.1:54572","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-02-11T18:13:05.771478Z","caller":"traceutil/trace.go:171","msg":"trace[1009510131] transaction","detail":"{read_only:false; response_revision:339; number_of_response:1; }","duration":"458.511809ms","start":"2026-02-11T18:13:05.31296Z","end":"2026-02-11T18:13:05.771472Z","steps":["trace[1009510131] 'process raft request' (duration: 457.59366ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:05.771509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:05.312954Z","time spent":"458.538029ms","remote":"127.0.0.1:54572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T18:13:05.771564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.872213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-02-11T18:13:05.771576Z","caller":"traceutil/trace.go:171","msg":"trace[152172835] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:339; }","duration":"424.911964ms","start":"2026-02-11T18:13:05.346659Z","end":"2026-02-11T18:13:05.771571Z","steps":["trace[152172835] 'agreement among raft nodes before linearized reading' (duration: 424.888284ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:05.771589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:05.346642Z","time spent":"424.944094ms","remote":"127.0.0.1:54502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" "} {"level":"warn","ts":"2026-02-11T18:13:05.771655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.361872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-02-11T18:13:05.771668Z","caller":"traceutil/trace.go:171","msg":"trace[422184859] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:339; }","duration":"182.396313ms","start":"2026-02-11T18:13:05.589268Z","end":"2026-02-11T18:13:05.771664Z","steps":["trace[422184859] 'agreement among raft nodes before linearized reading' (duration: 182.369503ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:05.771734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.486781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-11T18:13:05.771745Z","caller":"traceutil/trace.go:171","msg":"trace[1911368034] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:339; }","duration":"209.498851ms","start":"2026-02-11T18:13:05.562243Z","end":"2026-02-11T18:13:05.771742Z","steps":["trace[1911368034] 'agreement among raft nodes before linearized reading' (duration: 209.474121ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:05.771801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.38753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"warn","ts":"2026-02-11T18:13:05.771819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.564396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-02-11T18:13:05.771838Z","caller":"traceutil/trace.go:171","msg":"trace[334318730] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:339; }","duration":"405.592466ms","start":"2026-02-11T18:13:05.366237Z","end":"2026-02-11T18:13:05.771829Z","steps":["trace[334318730] 'agreement among raft nodes before linearized reading' (duration: 405.559896ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:05.771829Z","caller":"traceutil/trace.go:171","msg":"trace[1292004114] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:339; }","duration":"395.434131ms","start":"2026-02-11T18:13:05.376386Z","end":"2026-02-11T18:13:05.77182Z","steps":["trace[1292004114] 'agreement among raft nodes before linearized reading' (duration: 395.35849ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:05.771871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:05.376376Z","time spent":"395.489141ms","remote":"127.0.0.1:54502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":240,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" "} {"level":"warn","ts":"2026-02-11T18:13:05.771993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.015901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-02-11T18:13:05.772009Z","caller":"traceutil/trace.go:171","msg":"trace[441444364] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:339; }","duration":"373.031291ms","start":"2026-02-11T18:13:05.398973Z","end":"2026-02-11T18:13:05.772005Z","steps":["trace[441444364] 'agreement among raft nodes before linearized reading' (duration: 372.9993ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:05.772021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:05.398937Z","time spent":"373.081632ms","remote":"127.0.0.1:54502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":236,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" "} {"level":"warn","ts":"2026-02-11T18:13:05.771851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:05.366229Z","time spent":"405.618886ms","remote":"127.0.0.1:54502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":225,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"warn","ts":"2026-02-11T18:13:05.772093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.603254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-02-11T18:13:05.772107Z","caller":"traceutil/trace.go:171","msg":"trace[378874469] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:339; }","duration":"359.628894ms","start":"2026-02-11T18:13:05.412474Z","end":"2026-02-11T18:13:05.772103Z","steps":["trace[378874469] 'agreement among raft nodes before linearized reading' (duration: 359.581433ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:05.772121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:05.412469Z","time spent":"359.649254ms","remote":"127.0.0.1:54502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":215,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" "} {"level":"warn","ts":"2026-02-11T18:13:05.772179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.108398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"warn","ts":"2026-02-11T18:13:05.771874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.589466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-02-11T18:13:05.772198Z","caller":"traceutil/trace.go:171","msg":"trace[1002281358] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:339; }","duration":"360.24054ms","start":"2026-02-11T18:13:05.411953Z","end":"2026-02-11T18:13:05.772193Z","steps":["trace[1002281358] 'agreement among raft nodes before linearized reading' (duration: 360.204819ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:05.772214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:05.411946Z","time spent":"360.26472ms","remote":"127.0.0.1:54502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":256,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "} {"level":"info","ts":"2026-02-11T18:13:05.772209Z","caller":"traceutil/trace.go:171","msg":"trace[32437300] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:339; }","duration":"406.9353ms","start":"2026-02-11T18:13:05.365264Z","end":"2026-02-11T18:13:05.772199Z","steps":["trace[32437300] 'agreement among raft nodes before linearized reading' (duration: 406.595476ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:05.772237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:05.365234Z","time spent":"406.99493ms","remote":"127.0.0.1:54502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" "} {"level":"warn","ts":"2026-02-11T18:13:05.772288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.00957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-11T18:13:05.772301Z","caller":"traceutil/trace.go:171","msg":"trace[1891679478] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:339; }","duration":"369.04539ms","start":"2026-02-11T18:13:05.403252Z","end":"2026-02-11T18:13:05.772297Z","steps":["trace[1891679478] 'agreement among raft nodes before linearized reading' (duration: 369.010929ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:05.772319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:05.40324Z","time spent":"369.071071ms","remote":"127.0.0.1:54502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":229,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" "} {"level":"info","ts":"2026-02-11T18:13:06.024816Z","caller":"traceutil/trace.go:171","msg":"trace[139489874] transaction","detail":"{read_only:false; response_revision:341; number_of_response:1; }","duration":"233.091203ms","start":"2026-02-11T18:13:05.791701Z","end":"2026-02-11T18:13:06.024792Z","steps":["trace[139489874] 'process raft request' (duration: 154.479937ms)","trace[139489874] 'compare' (duration: 77.765207ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:13:06.029081Z","caller":"traceutil/trace.go:171","msg":"trace[1530838190] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"234.562767ms","start":"2026-02-11T18:13:05.794509Z","end":"2026-02-11T18:13:06.029072Z","steps":["trace[1530838190] 'process raft request' (duration: 230.083422ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.030081Z","caller":"traceutil/trace.go:171","msg":"trace[1280796222] transaction","detail":"{read_only:false; response_revision:343; number_of_response:1; }","duration":"227.746498ms","start":"2026-02-11T18:13:05.802324Z","end":"2026-02-11T18:13:06.03007Z","steps":["trace[1280796222] 'process raft request' (duration: 226.838548ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.033461Z","caller":"traceutil/trace.go:171","msg":"trace[1566381521] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"156.468445ms","start":"2026-02-11T18:13:05.8769Z","end":"2026-02-11T18:13:06.033369Z","steps":["trace[1566381521] 'process raft request' (duration: 156.151252ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.034649Z","caller":"traceutil/trace.go:171","msg":"trace[1137357180] transaction","detail":"{read_only:false; response_revision:344; number_of_response:1; }","duration":"232.215203ms","start":"2026-02-11T18:13:05.802395Z","end":"2026-02-11T18:13:06.034611Z","steps":["trace[1137357180] 'process raft request' (duration: 227.405984ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.035361Z","caller":"traceutil/trace.go:171","msg":"trace[1646454918] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"232.86911ms","start":"2026-02-11T18:13:05.802406Z","end":"2026-02-11T18:13:06.035275Z","steps":["trace[1646454918] 'process raft request' (duration: 228.95312ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.036289Z","caller":"traceutil/trace.go:171","msg":"trace[2135401259] transaction","detail":"{read_only:false; response_revision:346; number_of_response:1; }","duration":"233.736499ms","start":"2026-02-11T18:13:05.80245Z","end":"2026-02-11T18:13:06.036187Z","steps":["trace[2135401259] 'process raft request' (duration: 230.078162ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.036981Z","caller":"traceutil/trace.go:171","msg":"trace[1685501693] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"234.070463ms","start":"2026-02-11T18:13:05.802843Z","end":"2026-02-11T18:13:06.036914Z","steps":["trace[1685501693] 'process raft request' (duration: 230.009161ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.037402Z","caller":"traceutil/trace.go:171","msg":"trace[653836979] linearizableReadLoop","detail":"{readStateIndex:361; appliedIndex:354; }","duration":"167.718401ms","start":"2026-02-11T18:13:05.869629Z","end":"2026-02-11T18:13:06.037348Z","steps":["trace[653836979] 'read index received' (duration: 76.594757ms)","trace[653836979] 'applied index is now lower than readState.Index' (duration: 91.122574ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:13:06.038555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.930024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-02-11T18:13:06.038905Z","caller":"traceutil/trace.go:171","msg":"trace[681614751] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:348; }","duration":"245.236827ms","start":"2026-02-11T18:13:05.793572Z","end":"2026-02-11T18:13:06.038808Z","steps":["trace[681614751] 'agreement among raft nodes before linearized reading' (duration: 244.838623ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:06.039764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.161906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-02-11T18:13:06.039884Z","caller":"traceutil/trace.go:171","msg":"trace[245965801] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:348; }","duration":"246.335068ms","start":"2026-02-11T18:13:05.793543Z","end":"2026-02-11T18:13:06.039878Z","steps":["trace[245965801] 'agreement among raft nodes before linearized reading' (duration: 246.089515ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:06.042085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.51922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-02-11T18:13:06.042277Z","caller":"traceutil/trace.go:171","msg":"trace[844184896] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:348; }","duration":"248.646661ms","start":"2026-02-11T18:13:05.793519Z","end":"2026-02-11T18:13:06.042165Z","steps":["trace[844184896] 'agreement among raft nodes before linearized reading' (duration: 248.464529ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:06.043358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.696693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-02-11T18:13:06.043414Z","caller":"traceutil/trace.go:171","msg":"trace[1901412631] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:348; }","duration":"251.776504ms","start":"2026-02-11T18:13:05.791626Z","end":"2026-02-11T18:13:06.043403Z","steps":["trace[1901412631] 'agreement among raft nodes before linearized reading' (duration: 251.653862ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:06.043513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.604713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-02-11T18:13:06.043528Z","caller":"traceutil/trace.go:171","msg":"trace[2083353494] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:348; }","duration":"254.627913ms","start":"2026-02-11T18:13:05.788897Z","end":"2026-02-11T18:13:06.043525Z","steps":["trace[2083353494] 'agreement among raft nodes before linearized reading' (duration: 254.596163ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:06.043629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.802495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-02-11T18:13:06.043648Z","caller":"traceutil/trace.go:171","msg":"trace[1015203381] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:348; }","duration":"254.826565ms","start":"2026-02-11T18:13:05.788816Z","end":"2026-02-11T18:13:06.043642Z","steps":["trace[1015203381] 'agreement among raft nodes before linearized reading' (duration: 254.797205ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:06.043697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.884076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-11T18:13:06.043715Z","caller":"traceutil/trace.go:171","msg":"trace[96415432] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:348; }","duration":"254.905976ms","start":"2026-02-11T18:13:05.788802Z","end":"2026-02-11T18:13:06.043708Z","steps":["trace[96415432] 'agreement among raft nodes before linearized reading' (duration: 254.879946ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:06.043775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.744885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-02-11T18:13:06.04379Z","caller":"traceutil/trace.go:171","msg":"trace[1466328041] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:348; }","duration":"109.783836ms","start":"2026-02-11T18:13:05.934002Z","end":"2026-02-11T18:13:06.043786Z","steps":["trace[1466328041] 'agreement among raft nodes before linearized reading' (duration: 109.756615ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:06.04401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.682774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5270"} {"level":"info","ts":"2026-02-11T18:13:06.044033Z","caller":"traceutil/trace.go:171","msg":"trace[2112623426] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:348; }","duration":"109.713775ms","start":"2026-02-11T18:13:05.934315Z","end":"2026-02-11T18:13:06.044029Z","steps":["trace[2112623426] 'agreement among raft nodes before linearized reading' (duration: 109.671245ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:06.044118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.806366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:4729"} {"level":"info","ts":"2026-02-11T18:13:06.044135Z","caller":"traceutil/trace.go:171","msg":"trace[714024247] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:348; }","duration":"109.822786ms","start":"2026-02-11T18:13:05.934308Z","end":"2026-02-11T18:13:06.044131Z","steps":["trace[714024247] 'agreement among raft nodes before linearized reading' (duration: 109.792476ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:06.044199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.903417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4068"} {"level":"info","ts":"2026-02-11T18:13:06.044214Z","caller":"traceutil/trace.go:171","msg":"trace[286178624] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:348; }","duration":"109.925907ms","start":"2026-02-11T18:13:05.934285Z","end":"2026-02-11T18:13:06.044211Z","steps":["trace[286178624] 'agreement among raft nodes before linearized reading' (duration: 109.897007ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:06.044276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.994678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7177"} {"level":"info","ts":"2026-02-11T18:13:06.044292Z","caller":"traceutil/trace.go:171","msg":"trace[655518212] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:348; }","duration":"110.017608ms","start":"2026-02-11T18:13:05.93427Z","end":"2026-02-11T18:13:06.044288Z","steps":["trace[655518212] 'agreement among raft nodes before linearized reading' (duration: 109.990168ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:06.044361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.107899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6820"} {"level":"info","ts":"2026-02-11T18:13:06.04438Z","caller":"traceutil/trace.go:171","msg":"trace[289792291] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:348; }","duration":"110.138869ms","start":"2026-02-11T18:13:05.934238Z","end":"2026-02-11T18:13:06.044376Z","steps":["trace[289792291] 'agreement among raft nodes before linearized reading' (duration: 110.103478ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:06.321147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.737597ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T18:13:06.322956Z","caller":"traceutil/trace.go:171","msg":"trace[281413449] linearizableReadLoop","detail":"{readStateIndex:365; appliedIndex:362; }","duration":"258.492922ms","start":"2026-02-11T18:13:06.064445Z","end":"2026-02-11T18:13:06.322937Z","steps":["trace[281413449] 'read index received' (duration: 125.957437ms)","trace[281413449] 'applied index is now lower than readState.Index' (duration: 132.534735ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:13:06.323322Z","caller":"traceutil/trace.go:171","msg":"trace[2130822449] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"248.4357ms","start":"2026-02-11T18:13:06.074857Z","end":"2026-02-11T18:13:06.323293Z","steps":["trace[2130822449] 'process raft request' (duration: 247.813434ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.324119Z","caller":"traceutil/trace.go:171","msg":"trace[454538292] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"248.50158ms","start":"2026-02-11T18:13:06.074896Z","end":"2026-02-11T18:13:06.323397Z","steps":["trace[454538292] 'process raft request' (duration: 247.808023ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.324528Z","caller":"traceutil/trace.go:171","msg":"trace[387625149] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"249.575822ms","start":"2026-02-11T18:13:06.074939Z","end":"2026-02-11T18:13:06.324515Z","steps":["trace[387625149] 'process raft request' (duration: 247.793883ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.32408Z","caller":"traceutil/trace.go:171","msg":"trace[1381153446] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"265.552315ms","start":"2026-02-11T18:13:06.058445Z","end":"2026-02-11T18:13:06.323997Z","steps":["trace[1381153446] 'process raft request' (duration: 131.865768ms)","trace[1381153446] 'compare' (duration: 130.614966ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:13:06.324997Z","caller":"traceutil/trace.go:171","msg":"trace[337747452] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"249.953845ms","start":"2026-02-11T18:13:06.075029Z","end":"2026-02-11T18:13:06.324983Z","steps":["trace[337747452] 'process raft request' (duration: 247.730743ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.32537Z","caller":"traceutil/trace.go:171","msg":"trace[538237351] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"249.264368ms","start":"2026-02-11T18:13:06.076093Z","end":"2026-02-11T18:13:06.325357Z","steps":["trace[538237351] 'process raft request' (duration: 246.695642ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.325693Z","caller":"traceutil/trace.go:171","msg":"trace[347316990] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"247.129147ms","start":"2026-02-11T18:13:06.078551Z","end":"2026-02-11T18:13:06.32568Z","steps":["trace[347316990] 'process raft request' (duration: 244.263597ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.325916Z","caller":"traceutil/trace.go:171","msg":"trace[761946227] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"247.299268ms","start":"2026-02-11T18:13:06.078607Z","end":"2026-02-11T18:13:06.325906Z","steps":["trace[761946227] 'process raft request' (duration: 244.239716ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:06.326215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.759966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4013"} {"level":"info","ts":"2026-02-11T18:13:06.326255Z","caller":"traceutil/trace.go:171","msg":"trace[667493273] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:361; }","duration":"261.816326ms","start":"2026-02-11T18:13:06.064429Z","end":"2026-02-11T18:13:06.326245Z","steps":["trace[667493273] 'agreement among raft nodes before linearized reading' (duration: 261.729535ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.329619Z","caller":"traceutil/trace.go:171","msg":"trace[113363349] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"270.614126ms","start":"2026-02-11T18:13:06.058994Z","end":"2026-02-11T18:13:06.329608Z","steps":["trace[113363349] 'process raft request' (duration: 263.035799ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.329903Z","caller":"traceutil/trace.go:171","msg":"trace[1396979222] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"270.690007ms","start":"2026-02-11T18:13:06.059205Z","end":"2026-02-11T18:13:06.329895Z","steps":["trace[1396979222] 'process raft request' (duration: 263.248571ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.331697Z","caller":"traceutil/trace.go:171","msg":"trace[954210602] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"264.877338ms","start":"2026-02-11T18:13:06.06681Z","end":"2026-02-11T18:13:06.331687Z","steps":["trace[954210602] 'process raft request' (duration: 255.711074ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.332382Z","caller":"traceutil/trace.go:171","msg":"trace[1140540688] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"261.553263ms","start":"2026-02-11T18:13:06.070789Z","end":"2026-02-11T18:13:06.332342Z","steps":["trace[1140540688] 'process raft request' (duration: 251.810964ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.332883Z","caller":"traceutil/trace.go:171","msg":"trace[1156922307] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"262.031318ms","start":"2026-02-11T18:13:06.070845Z","end":"2026-02-11T18:13:06.332876Z","steps":["trace[1156922307] 'process raft request' (duration: 251.789423ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:06.332045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.172279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4013"} {"level":"info","ts":"2026-02-11T18:13:06.333928Z","caller":"traceutil/trace.go:171","msg":"trace[1756355463] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:361; }","duration":"263.059859ms","start":"2026-02-11T18:13:06.070862Z","end":"2026-02-11T18:13:06.333922Z","steps":["trace[1756355463] 'agreement among raft nodes before linearized reading' (duration: 261.166009ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:06.332063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.24215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4013"} {"level":"info","ts":"2026-02-11T18:13:06.334087Z","caller":"traceutil/trace.go:171","msg":"trace[1213440666] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:361; }","duration":"263.269641ms","start":"2026-02-11T18:13:06.070811Z","end":"2026-02-11T18:13:06.334081Z","steps":["trace[1213440666] 'agreement among raft nodes before linearized reading' (duration: 261.24256ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:06.332081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.575405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4013"} {"level":"info","ts":"2026-02-11T18:13:06.334308Z","caller":"traceutil/trace.go:171","msg":"trace[100858906] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:361; }","duration":"269.806267ms","start":"2026-02-11T18:13:06.064497Z","end":"2026-02-11T18:13:06.334303Z","steps":["trace[100858906] 'agreement among raft nodes before linearized reading' (duration: 267.573945ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:06.332097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.603896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4013"} {"level":"info","ts":"2026-02-11T18:13:06.334512Z","caller":"traceutil/trace.go:171","msg":"trace[1521377039] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:361; }","duration":"270.024361ms","start":"2026-02-11T18:13:06.064482Z","end":"2026-02-11T18:13:06.334507Z","steps":["trace[1521377039] 'agreement among raft nodes before linearized reading' (duration: 267.605806ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:06.331916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.435014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4013"} {"level":"info","ts":"2026-02-11T18:13:06.334793Z","caller":"traceutil/trace.go:171","msg":"trace[513329662] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:361; }","duration":"270.314353ms","start":"2026-02-11T18:13:06.064466Z","end":"2026-02-11T18:13:06.33478Z","steps":["trace[513329662] 'agreement among raft nodes before linearized reading' (duration: 267.314003ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.553302Z","caller":"traceutil/trace.go:171","msg":"trace[314757064] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"146.370276ms","start":"2026-02-11T18:13:06.406903Z","end":"2026-02-11T18:13:06.553273Z","steps":["trace[314757064] 'process raft request' (duration: 146.332886ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.553969Z","caller":"traceutil/trace.go:171","msg":"trace[3873043] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"207.159888ms","start":"2026-02-11T18:13:06.346792Z","end":"2026-02-11T18:13:06.553952Z","steps":["trace[3873043] 'process raft request' (duration: 168.888267ms)","trace[3873043] 'compare' (duration: 37.052189ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:13:06.554112Z","caller":"traceutil/trace.go:171","msg":"trace[1362616827] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"207.156658ms","start":"2026-02-11T18:13:06.346945Z","end":"2026-02-11T18:13:06.554101Z","steps":["trace[1362616827] 'process raft request' (duration: 205.908195ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.554206Z","caller":"traceutil/trace.go:171","msg":"trace[1467312590] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"207.220159ms","start":"2026-02-11T18:13:06.346979Z","end":"2026-02-11T18:13:06.554199Z","steps":["trace[1467312590] 'process raft request' (duration: 205.917575ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.554297Z","caller":"traceutil/trace.go:171","msg":"trace[556150880] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"207.180249ms","start":"2026-02-11T18:13:06.347109Z","end":"2026-02-11T18:13:06.55429Z","steps":["trace[556150880] 'process raft request' (duration: 205.817835ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.554467Z","caller":"traceutil/trace.go:171","msg":"trace[713192461] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"203.616811ms","start":"2026-02-11T18:13:06.350842Z","end":"2026-02-11T18:13:06.554459Z","steps":["trace[713192461] 'process raft request' (duration: 202.138076ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.554606Z","caller":"traceutil/trace.go:171","msg":"trace[43860543] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"203.357489ms","start":"2026-02-11T18:13:06.351204Z","end":"2026-02-11T18:13:06.554562Z","steps":["trace[43860543] 'process raft request' (duration: 201.862774ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.555286Z","caller":"traceutil/trace.go:171","msg":"trace[84589446] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"204.037086ms","start":"2026-02-11T18:13:06.351233Z","end":"2026-02-11T18:13:06.55527Z","steps":["trace[84589446] 'process raft request' (duration: 201.860383ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.556663Z","caller":"traceutil/trace.go:171","msg":"trace[1828737302] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"205.375ms","start":"2026-02-11T18:13:06.351275Z","end":"2026-02-11T18:13:06.55665Z","steps":["trace[1828737302] 'process raft request' (duration: 201.855284ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.557781Z","caller":"traceutil/trace.go:171","msg":"trace[116501467] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"205.598082ms","start":"2026-02-11T18:13:06.352174Z","end":"2026-02-11T18:13:06.557772Z","steps":["trace[116501467] 'process raft request' (duration: 200.986075ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.557987Z","caller":"traceutil/trace.go:171","msg":"trace[1360113564] linearizableReadLoop","detail":"{readStateIndex:385; appliedIndex:376; }","duration":"153.982134ms","start":"2026-02-11T18:13:06.403995Z","end":"2026-02-11T18:13:06.557977Z","steps":["trace[1360113564] 'read index received' (duration: 111.598711ms)","trace[1360113564] 'applied index is now lower than readState.Index' (duration: 42.381983ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:13:06.558208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.176556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-rljms\" ","response":"range_response_count:1 size:3416"} {"level":"info","ts":"2026-02-11T18:13:06.558239Z","caller":"traceutil/trace.go:171","msg":"trace[165193788] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-rljms; range_end:; response_count:1; response_revision:373; }","duration":"154.262987ms","start":"2026-02-11T18:13:06.403968Z","end":"2026-02-11T18:13:06.558231Z","steps":["trace[165193788] 'agreement among raft nodes before linearized reading' (duration: 154.156676ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.558467Z","caller":"traceutil/trace.go:171","msg":"trace[1281372822] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"154.373798ms","start":"2026-02-11T18:13:06.404086Z","end":"2026-02-11T18:13:06.55846Z","steps":["trace[1281372822] 'process raft request' (duration: 149.120615ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.796002Z","caller":"traceutil/trace.go:171","msg":"trace[748931334] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"216.698716ms","start":"2026-02-11T18:13:06.57923Z","end":"2026-02-11T18:13:06.795928Z","steps":["trace[748931334] 'process raft request' (duration: 129.872708ms)","trace[748931334] 'compare' (duration: 79.066088ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:13:06.796749Z","caller":"traceutil/trace.go:171","msg":"trace[809514760] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"217.276001ms","start":"2026-02-11T18:13:06.579461Z","end":"2026-02-11T18:13:06.796736Z","steps":["trace[809514760] 'process raft request' (duration: 208.874645ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.798489Z","caller":"traceutil/trace.go:171","msg":"trace[279754391] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"218.991269ms","start":"2026-02-11T18:13:06.57949Z","end":"2026-02-11T18:13:06.798481Z","steps":["trace[279754391] 'process raft request' (duration: 208.941876ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.798771Z","caller":"traceutil/trace.go:171","msg":"trace[124708106] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"219.160821ms","start":"2026-02-11T18:13:06.579602Z","end":"2026-02-11T18:13:06.798763Z","steps":["trace[124708106] 'process raft request' (duration: 208.864415ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.799042Z","caller":"traceutil/trace.go:171","msg":"trace[5316201] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"219.373993ms","start":"2026-02-11T18:13:06.579661Z","end":"2026-02-11T18:13:06.799035Z","steps":["trace[5316201] 'process raft request' (duration: 208.840645ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.799465Z","caller":"traceutil/trace.go:171","msg":"trace[1421259141] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"219.689746ms","start":"2026-02-11T18:13:06.579767Z","end":"2026-02-11T18:13:06.799457Z","steps":["trace[1421259141] 'process raft request' (duration: 208.776034ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.800598Z","caller":"traceutil/trace.go:171","msg":"trace[1699930578] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"220.774657ms","start":"2026-02-11T18:13:06.579816Z","end":"2026-02-11T18:13:06.80059Z","steps":["trace[1699930578] 'process raft request' (duration: 215.079729ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.800794Z","caller":"traceutil/trace.go:171","msg":"trace[76705031] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"220.686516ms","start":"2026-02-11T18:13:06.580101Z","end":"2026-02-11T18:13:06.800787Z","steps":["trace[76705031] 'process raft request' (duration: 215.689435ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:06.801004Z","caller":"traceutil/trace.go:171","msg":"trace[1702466603] linearizableReadLoop","detail":"{readStateIndex:393; appliedIndex:387; }","duration":"221.290562ms","start":"2026-02-11T18:13:06.579703Z","end":"2026-02-11T18:13:06.800994Z","steps":["trace[1702466603] 'read index received' (duration: 65.773433ms)","trace[1702466603] 'applied index is now lower than readState.Index' (duration: 155.516299ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:13:06.80136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.640556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/kube-proxy\" ","response":"range_response_count:1 size:2879"} {"level":"info","ts":"2026-02-11T18:13:06.801478Z","caller":"traceutil/trace.go:171","msg":"trace[1240591772] range","detail":"{range_begin:/registry/daemonsets/kube-system/kube-proxy; range_end:; response_count:1; response_revision:382; }","duration":"221.786317ms","start":"2026-02-11T18:13:06.579684Z","end":"2026-02-11T18:13:06.80147Z","steps":["trace[1240591772] 'agreement among raft nodes before linearized reading' (duration: 221.635326ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:06.801765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.954738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:3684"} {"level":"info","ts":"2026-02-11T18:13:06.801873Z","caller":"traceutil/trace.go:171","msg":"trace[1785678717] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:382; }","duration":"221.07ms","start":"2026-02-11T18:13:06.580795Z","end":"2026-02-11T18:13:06.801865Z","steps":["trace[1785678717] 'agreement among raft nodes before linearized reading' (duration: 220.941589ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:06.802221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.39239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-02-11T18:13:06.802351Z","caller":"traceutil/trace.go:171","msg":"trace[1721792831] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:382; }","duration":"205.522361ms","start":"2026-02-11T18:13:06.596822Z","end":"2026-02-11T18:13:06.802344Z","steps":["trace[1721792831] 'agreement among raft nodes before linearized reading' (duration: 205.37392ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:07.170926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.82498ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-11T18:13:07.171032Z","caller":"traceutil/trace.go:171","msg":"trace[195075033] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"352.997781ms","start":"2026-02-11T18:13:06.818015Z","end":"2026-02-11T18:13:07.171013Z","steps":["trace[195075033] 'process raft request' (duration: 178.956249ms)","trace[195075033] 'compare' (duration: 173.699748ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:13:07.171801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:06.817998Z","time spent":"353.736178ms","remote":"127.0.0.1:54502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":164,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-11T18:13:07.228659Z","caller":"traceutil/trace.go:171","msg":"trace[1267555210] linearizableReadLoop","detail":"{readStateIndex:398; appliedIndex:396; }","duration":"410.160652ms","start":"2026-02-11T18:13:06.818475Z","end":"2026-02-11T18:13:07.228636Z","steps":["trace[1267555210] 'read index received' (duration: 178.450764ms)","trace[1267555210] 'applied index is now lower than readState.Index' (duration: 231.708848ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:13:07.228775Z","caller":"traceutil/trace.go:171","msg":"trace[1521622707] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"410.139802ms","start":"2026-02-11T18:13:06.818623Z","end":"2026-02-11T18:13:07.228763Z","steps":["trace[1521622707] 'process raft request' (duration: 409.90087ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:07.228778Z","caller":"traceutil/trace.go:171","msg":"trace[1231243362] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"410.358064ms","start":"2026-02-11T18:13:06.818394Z","end":"2026-02-11T18:13:07.228752Z","steps":["trace[1231243362] 'process raft request' (duration: 409.853319ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:07.228876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:06.818619Z","time spent":"410.180173ms","remote":"127.0.0.1:54494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3979,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T18:13:07.228901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:06.818388Z","time spent":"410.444225ms","remote":"127.0.0.1:54800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3737,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T18:13:07.22914Z","caller":"traceutil/trace.go:171","msg":"trace[1605493589] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"410.497885ms","start":"2026-02-11T18:13:06.818631Z","end":"2026-02-11T18:13:07.229128Z","steps":["trace[1605493589] 'process raft request' (duration: 409.930499ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:07.229203Z","caller":"traceutil/trace.go:171","msg":"trace[1398787019] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"410.678668ms","start":"2026-02-11T18:13:06.818513Z","end":"2026-02-11T18:13:07.229192Z","steps":["trace[1398787019] 'process raft request' (duration: 409.849619ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:07.229254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:06.818508Z","time spent":"410.720428ms","remote":"127.0.0.1:54408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1731,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-11T18:13:07.229395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:06.818625Z","time spent":"410.545445ms","remote":"127.0.0.1:54368","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-02-11T18:13:07.229696Z","caller":"traceutil/trace.go:171","msg":"trace[1083224430] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"410.732108ms","start":"2026-02-11T18:13:06.818951Z","end":"2026-02-11T18:13:07.229683Z","steps":["trace[1083224430] 'process raft request' (duration: 409.645547ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:07.229761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:06.818945Z","time spent":"410.781918ms","remote":"127.0.0.1:54768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3980,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T18:13:07.229901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.421995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/kube-proxy\" ","response":"range_response_count:1 size:2879"} {"level":"info","ts":"2026-02-11T18:13:07.229932Z","caller":"traceutil/trace.go:171","msg":"trace[1910887149] range","detail":"{range_begin:/registry/daemonsets/kube-system/kube-proxy; range_end:; response_count:1; response_revision:389; }","duration":"411.451615ms","start":"2026-02-11T18:13:06.818471Z","end":"2026-02-11T18:13:07.229923Z","steps":["trace[1910887149] 'agreement among raft nodes before linearized reading' (duration: 411.395414ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:07.22996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:06.818447Z","time spent":"411.506605ms","remote":"127.0.0.1:54792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":2901,"request content":"key:\"/registry/daemonsets/kube-system/kube-proxy\" "} {"level":"warn","ts":"2026-02-11T18:13:07.230139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.623747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-rljms\" ","response":"range_response_count:1 size:4421"} {"level":"info","ts":"2026-02-11T18:13:07.230167Z","caller":"traceutil/trace.go:171","msg":"trace[1085995849] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-rljms; range_end:; response_count:1; response_revision:389; }","duration":"411.690217ms","start":"2026-02-11T18:13:06.818468Z","end":"2026-02-11T18:13:07.230158Z","steps":["trace[1085995849] 'agreement among raft nodes before linearized reading' (duration: 411.629267ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:07.230194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:06.818454Z","time spent":"411.732148ms","remote":"127.0.0.1:54494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":4443,"request content":"key:\"/registry/pods/kube-system/kube-proxy-rljms\" "} {"level":"info","ts":"2026-02-11T18:13:07.231148Z","caller":"traceutil/trace.go:171","msg":"trace[784624004] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"412.573686ms","start":"2026-02-11T18:13:06.818555Z","end":"2026-02-11T18:13:07.231129Z","steps":["trace[784624004] 'process raft request' (duration: 409.844919ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:07.231647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:06.818545Z","time spent":"412.645137ms","remote":"127.0.0.1:54368","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-02-11T18:13:07.232131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.851609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5270"} {"level":"info","ts":"2026-02-11T18:13:07.232337Z","caller":"traceutil/trace.go:171","msg":"trace[1866046446] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:389; }","duration":"235.057521ms","start":"2026-02-11T18:13:06.997266Z","end":"2026-02-11T18:13:07.232324Z","steps":["trace[1866046446] 'agreement among raft nodes before linearized reading' (duration: 234.814949ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:07.232611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.999441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T18:13:07.232681Z","caller":"traceutil/trace.go:171","msg":"trace[1905476345] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:389; }","duration":"414.078052ms","start":"2026-02-11T18:13:06.818591Z","end":"2026-02-11T18:13:07.232669Z","steps":["trace[1905476345] 'agreement among raft nodes before linearized reading' (duration: 413.963691ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:07.232765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:06.818566Z","time spent":"414.189633ms","remote":"127.0.0.1:54316","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-02-11T18:13:07.581836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.325043ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T18:13:07.58192Z","caller":"traceutil/trace.go:171","msg":"trace[702820007] linearizableReadLoop","detail":"{readStateIndex:404; appliedIndex:403; }","duration":"333.827776ms","start":"2026-02-11T18:13:07.248077Z","end":"2026-02-11T18:13:07.581905Z","steps":["trace[702820007] 'read index received' (duration: 224.460733ms)","trace[702820007] 'applied index is now lower than readState.Index' (duration: 109.366063ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:13:07.58209Z","caller":"traceutil/trace.go:171","msg":"trace[1754955923] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"335.332512ms","start":"2026-02-11T18:13:07.246746Z","end":"2026-02-11T18:13:07.582079Z","steps":["trace[1754955923] 'process raft request' (duration: 225.693856ms)","trace[1754955923] 'compare' (duration: 109.101201ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:13:07.582151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:07.246735Z","time spent":"335.384762ms","remote":"127.0.0.1:54494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5083,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T18:13:07.582329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.24582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/kube-proxy\" ","response":"range_response_count:1 size:2879"} {"level":"info","ts":"2026-02-11T18:13:07.582357Z","caller":"traceutil/trace.go:171","msg":"trace[1179066792] range","detail":"{range_begin:/registry/daemonsets/kube-system/kube-proxy; range_end:; response_count:1; response_revision:390; }","duration":"334.288401ms","start":"2026-02-11T18:13:07.24806Z","end":"2026-02-11T18:13:07.582348Z","steps":["trace[1179066792] 'agreement among raft nodes before linearized reading' (duration: 334.2299ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:07.582386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:07.248053Z","time spent":"334.324461ms","remote":"127.0.0.1:54792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":2901,"request content":"key:\"/registry/daemonsets/kube-system/kube-proxy\" "} {"level":"warn","ts":"2026-02-11T18:13:07.662313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.628928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:3995"} {"level":"info","ts":"2026-02-11T18:13:07.662385Z","caller":"traceutil/trace.go:171","msg":"trace[2004539131] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:391; }","duration":"411.707739ms","start":"2026-02-11T18:13:07.250659Z","end":"2026-02-11T18:13:07.662367Z","steps":["trace[2004539131] 'agreement among raft nodes before linearized reading' (duration: 411.520987ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:07.662424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:07.250642Z","time spent":"411.773169ms","remote":"127.0.0.1:54768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":4017,"request content":"key:\"/registry/deployments/kube-system/coredns\" "} {"level":"info","ts":"2026-02-11T18:13:07.662415Z","caller":"traceutil/trace.go:171","msg":"trace[1056141131] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"413.000452ms","start":"2026-02-11T18:13:07.249393Z","end":"2026-02-11T18:13:07.662393Z","steps":["trace[1056141131] 'process raft request' (duration: 412.652359ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:07.662511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:07.249374Z","time spent":"413.081623ms","remote":"127.0.0.1:54800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3782,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T18:13:11.971621Z","caller":"traceutil/trace.go:171","msg":"trace[2070120134] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"169.536415ms","start":"2026-02-11T18:13:11.80206Z","end":"2026-02-11T18:13:11.971596Z","steps":["trace[2070120134] 'process raft request' (duration: 169.400554ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:11.978451Z","caller":"traceutil/trace.go:171","msg":"trace[177067631] linearizableReadLoop","detail":"{readStateIndex:424; appliedIndex:423; }","duration":"167.730307ms","start":"2026-02-11T18:13:11.810706Z","end":"2026-02-11T18:13:11.978437Z","steps":["trace[177067631] 'read index received' (duration: 161.580775ms)","trace[177067631] 'applied index is now lower than readState.Index' (duration: 6.148652ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:13:11.978793Z","caller":"traceutil/trace.go:171","msg":"trace[58220194] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"173.996809ms","start":"2026-02-11T18:13:11.804787Z","end":"2026-02-11T18:13:11.978784Z","steps":["trace[58220194] 'process raft request' (duration: 173.581745ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:11.979238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.513054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-11T18:13:11.980107Z","caller":"traceutil/trace.go:171","msg":"trace[444091462] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:408; }","duration":"169.405843ms","start":"2026-02-11T18:13:11.81069Z","end":"2026-02-11T18:13:11.980096Z","steps":["trace[444091462] 'agreement among raft nodes before linearized reading' (duration: 168.505114ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:11.980047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.210972ms","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-02-11T18:13:11.980289Z","caller":"traceutil/trace.go:171","msg":"trace[1081697001] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:408; }","duration":"168.467694ms","start":"2026-02-11T18:13:11.811813Z","end":"2026-02-11T18:13:11.980281Z","steps":["trace[1081697001] 'agreement among raft nodes before linearized reading' (duration: 168.181291ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:16.471409Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880867362327150498,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-11T18:13:16.810713Z","caller":"traceutil/trace.go:171","msg":"trace[1126635587] linearizableReadLoop","detail":"{readStateIndex:435; appliedIndex:435; }","duration":"839.593812ms","start":"2026-02-11T18:13:15.971093Z","end":"2026-02-11T18:13:16.810687Z","steps":["trace[1126635587] 'read index received' (duration: 839.587261ms)","trace[1126635587] 'applied index is now lower than readState.Index' (duration: 5.22µs)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:13:16.811116Z","caller":"traceutil/trace.go:171","msg":"trace[605119062] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"875.335019ms","start":"2026-02-11T18:13:15.935761Z","end":"2026-02-11T18:13:16.811096Z","steps":["trace[605119062] 'process raft request' (duration: 874.701631ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:16.811026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"839.890779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4019"} {"level":"info","ts":"2026-02-11T18:13:16.811572Z","caller":"traceutil/trace.go:171","msg":"trace[1469824895] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:418; }","duration":"840.470364ms","start":"2026-02-11T18:13:15.971084Z","end":"2026-02-11T18:13:16.811555Z","steps":["trace[1469824895] 'agreement among raft nodes before linearized reading' (duration: 839.754761ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:16.811763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:15.97103Z","time spent":"840.713359ms","remote":"127.0.0.1:54490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4041,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-11T18:13:16.811327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:15.935748Z","time spent":"875.470208ms","remote":"127.0.0.1:54494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7030,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T18:13:16.820286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"809.607483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-11T18:13:16.820325Z","caller":"traceutil/trace.go:171","msg":"trace[761099259] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:419; }","duration":"809.780353ms","start":"2026-02-11T18:13:16.010536Z","end":"2026-02-11T18:13:16.820317Z","steps":["trace[761099259] 'agreement among raft nodes before linearized reading' (duration: 809.678057ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:16.820348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:16.010519Z","time spent":"809.822766ms","remote":"127.0.0.1:54572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-11T18:13:16.820622Z","caller":"traceutil/trace.go:171","msg":"trace[235681138] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"311.228572ms","start":"2026-02-11T18:13:16.509384Z","end":"2026-02-11T18:13:16.820612Z","steps":["trace[235681138] 'process raft request' (duration: 310.739393ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:16.820684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:16.509355Z","time spent":"311.287256ms","remote":"127.0.0.1:54572","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-02-11T18:13:16.820843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.550896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-11T18:13:16.820862Z","caller":"traceutil/trace.go:171","msg":"trace[1048449281] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:419; }","duration":"655.609299ms","start":"2026-02-11T18:13:16.165247Z","end":"2026-02-11T18:13:16.820856Z","steps":["trace[1048449281] 'agreement among raft nodes before linearized reading' (duration: 655.576737ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:16.820878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:16.165228Z","time spent":"655.646041ms","remote":"127.0.0.1:54572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-11T18:13:16.820977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"759.008906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-11T18:13:16.820995Z","caller":"traceutil/trace.go:171","msg":"trace[125920703] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:419; }","duration":"759.07399ms","start":"2026-02-11T18:13:16.061915Z","end":"2026-02-11T18:13:16.820989Z","steps":["trace[125920703] 'agreement among raft nodes before linearized reading' (duration: 759.041348ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:16.821014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:16.061893Z","time spent":"759.117832ms","remote":"127.0.0.1:54572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-11T18:13:16.821095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"795.227967ms","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-02-11T18:13:16.821113Z","caller":"traceutil/trace.go:171","msg":"trace[1576863677] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:419; }","duration":"795.28755ms","start":"2026-02-11T18:13:16.02582Z","end":"2026-02-11T18:13:16.821108Z","steps":["trace[1576863677] 'agreement among raft nodes before linearized reading' (duration: 795.255588ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:16.821137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:16.02581Z","time spent":"795.316832ms","remote":"127.0.0.1:54572","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-02-11T18:13:16.962639Z","caller":"traceutil/trace.go:171","msg":"trace[320886014] transaction","detail":"{read_only:false; response_revision:422; number_of_response:1; }","duration":"125.802346ms","start":"2026-02-11T18:13:16.836822Z","end":"2026-02-11T18:13:16.962624Z","steps":["trace[320886014] 'process raft request' (duration: 125.723221ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:16.962797Z","caller":"traceutil/trace.go:171","msg":"trace[192991719] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"126.303296ms","start":"2026-02-11T18:13:16.836486Z","end":"2026-02-11T18:13:16.96279Z","steps":["trace[192991719] 'process raft request' (duration: 78.197149ms)","trace[192991719] 'compare' (duration: 47.776557ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:13:16.978305Z","caller":"traceutil/trace.go:171","msg":"trace[213172514] transaction","detail":"{read_only:false; response_revision:423; number_of_response:1; }","duration":"138.776427ms","start":"2026-02-11T18:13:16.839514Z","end":"2026-02-11T18:13:16.978291Z","steps":["trace[213172514] 'process raft request' (duration: 138.402635ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:16.978379Z","caller":"traceutil/trace.go:171","msg":"trace[1474405819] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"137.379793ms","start":"2026-02-11T18:13:16.840995Z","end":"2026-02-11T18:13:16.978375Z","steps":["trace[1474405819] 'process raft request' (duration: 136.99683ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:29.792153Z","caller":"traceutil/trace.go:171","msg":"trace[1917198167] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"142.680725ms","start":"2026-02-11T18:13:29.649449Z","end":"2026-02-11T18:13:29.792129Z","steps":["trace[1917198167] 'process raft request' (duration: 142.559459ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:29.792988Z","caller":"traceutil/trace.go:171","msg":"trace[77351926] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"143.658036ms","start":"2026-02-11T18:13:29.649276Z","end":"2026-02-11T18:13:29.792934Z","steps":["trace[77351926] 'process raft request' (duration: 91.507556ms)","trace[77351926] 'compare' (duration: 51.097165ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:13:33.376094Z","caller":"traceutil/trace.go:171","msg":"trace[1210802106] linearizableReadLoop","detail":"{readStateIndex:542; appliedIndex:541; }","duration":"269.253148ms","start":"2026-02-11T18:13:33.10682Z","end":"2026-02-11T18:13:33.376073Z","steps":["trace[1210802106] 'read index received' (duration: 269.040087ms)","trace[1210802106] 'applied index is now lower than readState.Index' (duration: 212.231µs)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:13:33.376435Z","caller":"traceutil/trace.go:171","msg":"trace[403013428] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"279.294654ms","start":"2026-02-11T18:13:33.097128Z","end":"2026-02-11T18:13:33.376423Z","steps":["trace[403013428] 'process raft request' (duration: 278.80024ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:33.376679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.840867ms","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-02-11T18:13:33.376734Z","caller":"traceutil/trace.go:171","msg":"trace[1597544238] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:521; }","duration":"269.90757ms","start":"2026-02-11T18:13:33.106795Z","end":"2026-02-11T18:13:33.376703Z","steps":["trace[1597544238] 'agreement among raft nodes before linearized reading' (duration: 269.815975ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:33.37722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.319155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-11T18:13:33.377361Z","caller":"traceutil/trace.go:171","msg":"trace[95249239] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:521; }","duration":"261.472172ms","start":"2026-02-11T18:13:33.115877Z","end":"2026-02-11T18:13:33.377349Z","steps":["trace[95249239] 'agreement among raft nodes before linearized reading' (duration: 261.136815ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:33.377597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.953497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-11T18:13:33.378785Z","caller":"traceutil/trace.go:171","msg":"trace[1124821839] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:521; }","duration":"262.149506ms","start":"2026-02-11T18:13:33.116614Z","end":"2026-02-11T18:13:33.378764Z","steps":["trace[1124821839] 'agreement among raft nodes before linearized reading' (duration: 260.666512ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:33.523083Z","caller":"traceutil/trace.go:171","msg":"trace[1175375120] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"140.171618ms","start":"2026-02-11T18:13:33.382869Z","end":"2026-02-11T18:13:33.523041Z","steps":["trace[1175375120] 'process raft request' (duration: 140.084074ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:33.526159Z","caller":"traceutil/trace.go:171","msg":"trace[765940954] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"140.761008ms","start":"2026-02-11T18:13:33.385379Z","end":"2026-02-11T18:13:33.52614Z","steps":["trace[765940954] 'process raft request' (duration: 140.440602ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:33.526724Z","caller":"traceutil/trace.go:171","msg":"trace[2104379754] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"141.042022ms","start":"2026-02-11T18:13:33.385464Z","end":"2026-02-11T18:13:33.526506Z","steps":["trace[2104379754] 'process raft request' (duration: 140.466793ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:43.638368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.102877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T18:13:43.638429Z","caller":"traceutil/trace.go:171","msg":"trace[172179978] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:566; }","duration":"123.203591ms","start":"2026-02-11T18:13:43.515213Z","end":"2026-02-11T18:13:43.638417Z","steps":["trace[172179978] 'range keys from in-memory index tree' (duration: 123.044434ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:43.63876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.283317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-11T18:13:43.638775Z","caller":"traceutil/trace.go:171","msg":"trace[1093872975] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:566; }","duration":"119.315289ms","start":"2026-02-11T18:13:43.519455Z","end":"2026-02-11T18:13:43.63877Z","steps":["trace[1093872975] 'range keys from in-memory index tree' (duration: 118.815286ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:44.719762Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880867362327150812,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-11T18:13:45.220428Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880867362327150812,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-11T18:13:45.350223Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.260373176s","expected-duration":"1s"} {"level":"info","ts":"2026-02-11T18:13:45.350634Z","caller":"traceutil/trace.go:171","msg":"trace[1344737100] linearizableReadLoop","detail":"{readStateIndex:596; appliedIndex:595; }","duration":"1.13168268s","start":"2026-02-11T18:13:44.218883Z","end":"2026-02-11T18:13:45.350565Z","steps":["trace[1344737100] 'read index received' (duration: 1.131475931s)","trace[1344737100] 'applied index is now lower than readState.Index' (duration: 205.929µs)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:13:45.350926Z","caller":"traceutil/trace.go:171","msg":"trace[1893388260] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"1.260988912s","start":"2026-02-11T18:13:44.089724Z","end":"2026-02-11T18:13:45.350713Z","steps":["trace[1893388260] 'process raft request' (duration: 1.260723071s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:45.351017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.943583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T18:13:45.3511Z","caller":"traceutil/trace.go:171","msg":"trace[389195862] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:573; }","duration":"549.034587ms","start":"2026-02-11T18:13:44.802021Z","end":"2026-02-11T18:13:45.351056Z","steps":["trace[389195862] 'agreement among raft nodes before linearized reading' (duration: 548.955884ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:45.351039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:44.089698Z","time spent":"1.261255094s","remote":"127.0.0.1:54494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T18:13:45.351131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:44.802005Z","time spent":"549.11932ms","remote":"127.0.0.1:54316","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-02-11T18:13:45.351353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.132455243s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.229\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-11T18:13:45.351369Z","caller":"traceutil/trace.go:171","msg":"trace[591152263] range","detail":"{range_begin:/registry/masterleases/199.204.45.229; range_end:; response_count:1; response_revision:573; }","duration":"1.132514545s","start":"2026-02-11T18:13:44.21885Z","end":"2026-02-11T18:13:45.351364Z","steps":["trace[591152263] 'agreement among raft nodes before linearized reading' (duration: 1.132429562s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:45.351386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:44.218829Z","time spent":"1.132552627s","remote":"127.0.0.1:54338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.229\" "} {"level":"warn","ts":"2026-02-11T18:13:47.535722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.604078279s","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-02-11T18:13:47.535839Z","caller":"traceutil/trace.go:171","msg":"trace[597212063] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:573; }","duration":"1.604202404s","start":"2026-02-11T18:13:45.931621Z","end":"2026-02-11T18:13:47.535823Z","steps":["trace[597212063] 'range keys from in-memory index tree' (duration: 1.604063778s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:47.536129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.677365275s","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"info","ts":"2026-02-11T18:13:47.536229Z","caller":"traceutil/trace.go:171","msg":"trace[2012375842] linearizableReadLoop","detail":"{readStateIndex:597; appliedIndex:596; }","duration":"1.848967597s","start":"2026-02-11T18:13:45.68724Z","end":"2026-02-11T18:13:47.536208Z","steps":["trace[2012375842] 'read index received' (duration: 171.496388ms)","trace[2012375842] 'applied index is now lower than readState.Index' (duration: 1.677470029s)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:13:47.536269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:45.356123Z","time spent":"2.180141208s","remote":"127.0.0.1:54338","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-11T18:13:47.536377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.849132024s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-11T18:13:47.536405Z","caller":"traceutil/trace.go:171","msg":"trace[966592099] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:573; }","duration":"1.849195476s","start":"2026-02-11T18:13:45.687202Z","end":"2026-02-11T18:13:47.536397Z","steps":["trace[966592099] 'agreement among raft nodes before linearized reading' (duration: 1.849077591s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:47.536437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:45.687185Z","time spent":"1.849243759s","remote":"127.0.0.1:54572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-11T18:13:47.74908Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.341012645s","expected-duration":"1s"} {"level":"info","ts":"2026-02-11T18:13:47.779683Z","caller":"traceutil/trace.go:171","msg":"trace[525734278] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:597; }","duration":"243.409286ms","start":"2026-02-11T18:13:47.536257Z","end":"2026-02-11T18:13:47.779667Z","steps":["trace[525734278] 'read index received' (duration: 212.995211ms)","trace[525734278] 'applied index is now lower than readState.Index' (duration: 30.413595ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:13:47.779829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.079772024s","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-02-11T18:13:47.779863Z","caller":"traceutil/trace.go:171","msg":"trace[1932792478] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:577; }","duration":"2.079854378s","start":"2026-02-11T18:13:45.7Z","end":"2026-02-11T18:13:47.779855Z","steps":["trace[1932792478] 'agreement among raft nodes before linearized reading' (duration: 2.079718423s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:47.779899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:45.699984Z","time spent":"2.07990623s","remote":"127.0.0.1:54572","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-02-11T18:13:47.780124Z","caller":"traceutil/trace.go:171","msg":"trace[929338482] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"1.372141931s","start":"2026-02-11T18:13:46.407972Z","end":"2026-02-11T18:13:47.780114Z","steps":["trace[929338482] 'process raft request' (duration: 1.341273806s)","trace[929338482] 'compare' (duration: 30.254558ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:13:47.780186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:46.407947Z","time spent":"1.372202153s","remote":"127.0.0.1:54572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T18:13:47.780283Z","caller":"traceutil/trace.go:171","msg":"trace[86197860] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"343.694646ms","start":"2026-02-11T18:13:47.436582Z","end":"2026-02-11T18:13:47.780277Z","steps":["trace[86197860] 'process raft request' (duration: 342.992397ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:47.780321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:47.436566Z","time spent":"343.735829ms","remote":"127.0.0.1:54572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T18:13:47.780392Z","caller":"traceutil/trace.go:171","msg":"trace[150173074] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"241.354368ms","start":"2026-02-11T18:13:47.539033Z","end":"2026-02-11T18:13:47.780388Z","steps":["trace[150173074] 'process raft request' (duration: 240.581645ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:47.780478Z","caller":"traceutil/trace.go:171","msg":"trace[1689724137] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"239.860185ms","start":"2026-02-11T18:13:47.540612Z","end":"2026-02-11T18:13:47.780472Z","steps":["trace[1689724137] 'process raft request' (duration: 239.03323ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:47.780595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"980.612312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T18:13:47.780618Z","caller":"traceutil/trace.go:171","msg":"trace[347443618] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:577; }","duration":"980.669945ms","start":"2026-02-11T18:13:46.799943Z","end":"2026-02-11T18:13:47.780613Z","steps":["trace[347443618] 'agreement among raft nodes before linearized reading' (duration: 980.636623ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:47.780634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:46.799925Z","time spent":"980.705145ms","remote":"127.0.0.1:54316","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-02-11T18:13:47.780722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.08062177s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-11T18:13:47.780743Z","caller":"traceutil/trace.go:171","msg":"trace[857357415] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:577; }","duration":"2.080656262s","start":"2026-02-11T18:13:45.700082Z","end":"2026-02-11T18:13:47.780738Z","steps":["trace[857357415] 'agreement among raft nodes before linearized reading' (duration: 2.080622461s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:47.780765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:45.700077Z","time spent":"2.080683743s","remote":"127.0.0.1:54572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-11T18:13:47.780842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.080767376s","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-02-11T18:13:47.780862Z","caller":"traceutil/trace.go:171","msg":"trace[126620513] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:577; }","duration":"2.080801058s","start":"2026-02-11T18:13:45.700057Z","end":"2026-02-11T18:13:47.780858Z","steps":["trace[126620513] 'agreement among raft nodes before linearized reading' (duration: 2.080769037s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:47.780878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:45.700052Z","time spent":"2.080822569s","remote":"127.0.0.1:54572","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":"info","ts":"2026-02-11T18:13:50.254713Z","caller":"traceutil/trace.go:171","msg":"trace[1529635493] linearizableReadLoop","detail":"{readStateIndex:617; appliedIndex:614; }","duration":"148.94305ms","start":"2026-02-11T18:13:50.105749Z","end":"2026-02-11T18:13:50.254692Z","steps":["trace[1529635493] 'read index received' (duration: 60.097461ms)","trace[1529635493] 'applied index is now lower than readState.Index' (duration: 88.844729ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:13:50.254912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.144799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-wwrlk\" ","response":"range_response_count:1 size:17171"} {"level":"info","ts":"2026-02-11T18:13:50.254949Z","caller":"traceutil/trace.go:171","msg":"trace[1137115992] range","detail":"{range_begin:/registry/pods/kube-system/cilium-wwrlk; range_end:; response_count:1; response_revision:592; }","duration":"149.224792ms","start":"2026-02-11T18:13:50.105711Z","end":"2026-02-11T18:13:50.254936Z","steps":["trace[1137115992] 'agreement among raft nodes before linearized reading' (duration: 149.062815ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:50.254995Z","caller":"traceutil/trace.go:171","msg":"trace[1197857777] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"436.342276ms","start":"2026-02-11T18:13:49.818624Z","end":"2026-02-11T18:13:50.254966Z","steps":["trace[1197857777] 'process raft request' (duration: 347.215946ms)","trace[1197857777] 'compare' (duration: 88.434652ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:13:50.255125Z","caller":"traceutil/trace.go:171","msg":"trace[713992069] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"435.702829ms","start":"2026-02-11T18:13:49.819409Z","end":"2026-02-11T18:13:50.255112Z","steps":["trace[713992069] 'process raft request' (duration: 435.132566ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:50.255136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:49.818616Z","time spent":"436.442261ms","remote":"127.0.0.1:54572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T18:13:50.255212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:49.819404Z","time spent":"435.747492ms","remote":"127.0.0.1:54572","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-02-11T18:13:50.255295Z","caller":"traceutil/trace.go:171","msg":"trace[331653379] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"429.432288ms","start":"2026-02-11T18:13:49.825855Z","end":"2026-02-11T18:13:50.255287Z","steps":["trace[331653379] 'process raft request' (duration: 428.797682ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:50.255332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:49.825844Z","time spent":"429.469759ms","remote":"127.0.0.1:54368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":722,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-11T18:13:50.429845Z","caller":"traceutil/trace.go:171","msg":"trace[1042907484] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"162.374366ms","start":"2026-02-11T18:13:50.267198Z","end":"2026-02-11T18:13:50.429572Z","steps":["trace[1042907484] 'process raft request' (duration: 162.161087ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:51.247106Z","caller":"traceutil/trace.go:171","msg":"trace[2076629270] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"124.203667ms","start":"2026-02-11T18:13:51.122883Z","end":"2026-02-11T18:13:51.247087Z","steps":["trace[2076629270] 'process raft request' (duration: 117.18456ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:52.278697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.582368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-11T18:13:52.27875Z","caller":"traceutil/trace.go:171","msg":"trace[2073301422] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:597; }","duration":"477.667371ms","start":"2026-02-11T18:13:51.801071Z","end":"2026-02-11T18:13:52.278738Z","steps":["trace[2073301422] 'range keys from in-memory index tree' (duration: 477.458362ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:52.278776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:51.801056Z","time spent":"477.714083ms","remote":"127.0.0.1:54572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-11T18:13:52.278831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.834476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-wwrlk\" ","response":"range_response_count:1 size:17415"} {"level":"info","ts":"2026-02-11T18:13:52.278884Z","caller":"traceutil/trace.go:171","msg":"trace[110382401] range","detail":"{range_begin:/registry/pods/kube-system/cilium-wwrlk; range_end:; response_count:1; response_revision:597; }","duration":"159.92247ms","start":"2026-02-11T18:13:52.118946Z","end":"2026-02-11T18:13:52.278869Z","steps":["trace[110382401] 'range keys from in-memory index tree' (duration: 159.738993ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:52.278919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.357774ms","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-02-11T18:13:52.278942Z","caller":"traceutil/trace.go:171","msg":"trace[491334664] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:597; }","duration":"472.402226ms","start":"2026-02-11T18:13:51.806532Z","end":"2026-02-11T18:13:52.278934Z","steps":["trace[491334664] 'range keys from in-memory index tree' (duration: 472.25839ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:52.278961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:51.806519Z","time spent":"472.438667ms","remote":"127.0.0.1:54572","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-02-11T18:13:52.534503Z","caller":"traceutil/trace.go:171","msg":"trace[2067831858] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"242.941551ms","start":"2026-02-11T18:13:52.291535Z","end":"2026-02-11T18:13:52.534477Z","steps":["trace[2067831858] 'process raft request' (duration: 242.840097ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:52.534938Z","caller":"traceutil/trace.go:171","msg":"trace[1278398359] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"247.87073ms","start":"2026-02-11T18:13:52.287042Z","end":"2026-02-11T18:13:52.534912Z","steps":["trace[1278398359] 'process raft request' (duration: 247.12561ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:52.535142Z","caller":"traceutil/trace.go:171","msg":"trace[1674065846] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"246.038606ms","start":"2026-02-11T18:13:52.289094Z","end":"2026-02-11T18:13:52.535132Z","steps":["trace[1674065846] 'process raft request' (duration: 245.200092ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:52.535251Z","caller":"traceutil/trace.go:171","msg":"trace[1289875219] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"243.987093ms","start":"2026-02-11T18:13:52.291257Z","end":"2026-02-11T18:13:52.535244Z","steps":["trace[1289875219] 'process raft request' (duration: 243.074396ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:54.070185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.883508ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-11T18:13:54.070299Z","caller":"traceutil/trace.go:171","msg":"trace[1268049864] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"635.009132ms","start":"2026-02-11T18:13:53.435269Z","end":"2026-02-11T18:13:54.070278Z","steps":["trace[1268049864] 'process raft request' (duration: 140.921516ms)","trace[1268049864] 'compare' (duration: 493.742012ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:13:54.070359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:53.435254Z","time spent":"635.080815ms","remote":"127.0.0.1:54368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":712,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-11T18:13:54.071084Z","caller":"traceutil/trace.go:171","msg":"trace[2002788066] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"618.773551ms","start":"2026-02-11T18:13:53.452292Z","end":"2026-02-11T18:13:54.071066Z","steps":["trace[2002788066] 'process raft request' (duration: 618.685087ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:54.071206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:53.452273Z","time spent":"618.872275ms","remote":"127.0.0.1:54352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9343,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-11T18:13:54.116419Z","caller":"traceutil/trace.go:171","msg":"trace[504008733] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"460.400098ms","start":"2026-02-11T18:13:53.656003Z","end":"2026-02-11T18:13:54.116403Z","steps":["trace[504008733] 'process raft request' (duration: 460.074185ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:54.116494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:53.655974Z","time spent":"460.484732ms","remote":"127.0.0.1:54352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12244,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-11T18:13:54.11661Z","caller":"traceutil/trace.go:171","msg":"trace[78255330] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"263.504961ms","start":"2026-02-11T18:13:53.853084Z","end":"2026-02-11T18:13:54.116589Z","steps":["trace[78255330] 'process raft request' (duration: 263.068303ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:54.800769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.615237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-02-11T18:13:54.800822Z","caller":"traceutil/trace.go:171","msg":"trace[1301435716] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:641; }","duration":"379.714641ms","start":"2026-02-11T18:13:54.421095Z","end":"2026-02-11T18:13:54.80081Z","steps":["trace[1301435716] 'range keys from in-memory index tree' (duration: 379.550704ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:54.800849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:54.421085Z","time spent":"379.758852ms","remote":"127.0.0.1:54582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"info","ts":"2026-02-11T18:13:54.800994Z","caller":"traceutil/trace.go:171","msg":"trace[1860354236] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"147.859064ms","start":"2026-02-11T18:13:54.653115Z","end":"2026-02-11T18:13:54.800975Z","steps":["trace[1860354236] 'process raft request' (duration: 147.820513ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:54.801133Z","caller":"traceutil/trace.go:171","msg":"trace[149439116] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"342.094598ms","start":"2026-02-11T18:13:54.459032Z","end":"2026-02-11T18:13:54.801126Z","steps":["trace[149439116] 'process raft request' (duration: 331.80106ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:54.801177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:54.458986Z","time spent":"342.163751ms","remote":"127.0.0.1:54352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4580,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-11T18:13:54.801274Z","caller":"traceutil/trace.go:171","msg":"trace[215071874] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:667; }","duration":"300.27967ms","start":"2026-02-11T18:13:54.500988Z","end":"2026-02-11T18:13:54.801268Z","steps":["trace[215071874] 'read index received' (duration: 289.871397ms)","trace[215071874] 'applied index is now lower than readState.Index' (duration: 10.407543ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:13:54.801359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.370553ms","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-02-11T18:13:54.801372Z","caller":"traceutil/trace.go:171","msg":"trace[937526766] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:643; }","duration":"300.420016ms","start":"2026-02-11T18:13:54.500948Z","end":"2026-02-11T18:13:54.801368Z","steps":["trace[937526766] 'agreement among raft nodes before linearized reading' (duration: 300.368274ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:54.801385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:13:54.500928Z","time spent":"300.452917ms","remote":"127.0.0.1:54582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":2,"response size":29,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "} {"level":"warn","ts":"2026-02-11T18:13:54.801522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.816015ms","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-02-11T18:13:54.801535Z","caller":"traceutil/trace.go:171","msg":"trace[1018468510] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:643; }","duration":"259.850016ms","start":"2026-02-11T18:13:54.54168Z","end":"2026-02-11T18:13:54.801531Z","steps":["trace[1018468510] 'agreement among raft nodes before linearized reading' (duration: 259.780814ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:13:54.801786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.498033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"warn","ts":"2026-02-11T18:13:54.801833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.694481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-11T18:13:54.80183Z","caller":"traceutil/trace.go:171","msg":"trace[1490303400] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:643; }","duration":"258.562626ms","start":"2026-02-11T18:13:54.543255Z","end":"2026-02-11T18:13:54.801817Z","steps":["trace[1490303400] 'agreement among raft nodes before linearized reading' (duration: 258.366648ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:54.801857Z","caller":"traceutil/trace.go:171","msg":"trace[1817675933] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:643; }","duration":"257.730012ms","start":"2026-02-11T18:13:54.544122Z","end":"2026-02-11T18:13:54.801852Z","steps":["trace[1817675933] 'agreement among raft nodes before linearized reading' (duration: 257.67671ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:55.341835Z","caller":"traceutil/trace.go:171","msg":"trace[783136297] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"135.878686ms","start":"2026-02-11T18:13:55.205921Z","end":"2026-02-11T18:13:55.3418Z","steps":["trace[783136297] 'process raft request' (duration: 59.800549ms)","trace[783136297] 'compare' (duration: 75.880269ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:13:55.428349Z","caller":"traceutil/trace.go:171","msg":"trace[1846718143] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"152.095493ms","start":"2026-02-11T18:13:55.276237Z","end":"2026-02-11T18:13:55.428332Z","steps":["trace[1846718143] 'process raft request' (duration: 151.839603ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:13:55.628079Z","caller":"traceutil/trace.go:171","msg":"trace[1574004663] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"101.469525ms","start":"2026-02-11T18:13:55.526584Z","end":"2026-02-11T18:13:55.628054Z","steps":["trace[1574004663] 'process raft request' (duration: 76.180382ms)","trace[1574004663] 'compare' (duration: 25.145507ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:13:58.528093Z","caller":"traceutil/trace.go:171","msg":"trace[1140747815] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"107.133235ms","start":"2026-02-11T18:13:58.420938Z","end":"2026-02-11T18:13:58.528071Z","steps":["trace[1140747815] 'process raft request' (duration: 65.83075ms)","trace[1140747815] 'compare' (duration: 41.039085ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:14:02.255223Z","caller":"traceutil/trace.go:171","msg":"trace[866523591] transaction","detail":"{read_only:false; response_revision:720; number_of_response:1; }","duration":"112.033241ms","start":"2026-02-11T18:14:02.143169Z","end":"2026-02-11T18:14:02.255202Z","steps":["trace[866523591] 'process raft request' (duration: 111.930427ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:14:03.16879Z","caller":"traceutil/trace.go:171","msg":"trace[768869659] transaction","detail":"{read_only:false; response_revision:732; number_of_response:1; }","duration":"135.698622ms","start":"2026-02-11T18:14:03.033074Z","end":"2026-02-11T18:14:03.168773Z","steps":["trace[768869659] 'process raft request' (duration: 135.662001ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:14:03.169096Z","caller":"traceutil/trace.go:171","msg":"trace[565852671] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"141.834405ms","start":"2026-02-11T18:14:03.027253Z","end":"2026-02-11T18:14:03.169088Z","steps":["trace[565852671] 'process raft request' (duration: 131.168077ms)","trace[565852671] 'compare' (duration: 10.023805ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:14:03.169199Z","caller":"traceutil/trace.go:171","msg":"trace[508021523] transaction","detail":"{read_only:false; response_revision:731; number_of_response:1; }","duration":"138.253716ms","start":"2026-02-11T18:14:03.030936Z","end":"2026-02-11T18:14:03.16919Z","steps":["trace[508021523] 'process raft request' (duration: 137.759158ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:14:03.318266Z","caller":"traceutil/trace.go:171","msg":"trace[379528272] transaction","detail":"{read_only:false; response_revision:733; number_of_response:1; }","duration":"135.709222ms","start":"2026-02-11T18:14:03.182532Z","end":"2026-02-11T18:14:03.318241Z","steps":["trace[379528272] 'process raft request' (duration: 135.594688ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:14:03.657423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.831608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-11T18:14:03.657764Z","caller":"traceutil/trace.go:171","msg":"trace[1633171292] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:748; }","duration":"125.17447ms","start":"2026-02-11T18:14:03.532549Z","end":"2026-02-11T18:14:03.657724Z","steps":["trace[1633171292] 'agreement among raft nodes before linearized reading' (duration: 123.471448ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:14:07.002379Z","caller":"traceutil/trace.go:171","msg":"trace[1681019440] transaction","detail":"{read_only:false; response_revision:771; number_of_response:1; }","duration":"102.225593ms","start":"2026-02-11T18:14:06.900133Z","end":"2026-02-11T18:14:07.002359Z","steps":["trace[1681019440] 'process raft request' (duration: 101.85028ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:14:07.360695Z","caller":"traceutil/trace.go:171","msg":"trace[262353209] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"151.893029ms","start":"2026-02-11T18:14:07.208181Z","end":"2026-02-11T18:14:07.360074Z","steps":["trace[262353209] 'process raft request' (duration: 127.569768ms)","trace[262353209] 'compare' (duration: 24.154716ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:14:11.326505Z","caller":"traceutil/trace.go:171","msg":"trace[1864151737] linearizableReadLoop","detail":"{readStateIndex:820; appliedIndex:819; }","duration":"111.811156ms","start":"2026-02-11T18:14:11.214672Z","end":"2026-02-11T18:14:11.326483Z","steps":["trace[1864151737] 'read index received' (duration: 111.618429ms)","trace[1864151737] 'applied index is now lower than readState.Index' (duration: 191.907µs)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:14:11.326869Z","caller":"traceutil/trace.go:171","msg":"trace[399419033] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"470.946928ms","start":"2026-02-11T18:14:10.85591Z","end":"2026-02-11T18:14:11.326857Z","steps":["trace[399419033] 'process raft request' (duration: 470.432591ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:14:11.326958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:14:10.855893Z","time spent":"471.005041ms","remote":"127.0.0.1:54572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T18:14:11.327249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.571111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-11T18:14:11.327289Z","caller":"traceutil/trace.go:171","msg":"trace[812818776] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:789; }","duration":"112.644693ms","start":"2026-02-11T18:14:11.214631Z","end":"2026-02-11T18:14:11.327275Z","steps":["trace[812818776] 'agreement among raft nodes before linearized reading' (duration: 112.53228ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:14:11.327463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.815786ms","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-02-11T18:14:11.327504Z","caller":"traceutil/trace.go:171","msg":"trace[35589869] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:789; }","duration":"103.881838ms","start":"2026-02-11T18:14:11.223613Z","end":"2026-02-11T18:14:11.327494Z","steps":["trace[35589869] 'agreement among raft nodes before linearized reading' (duration: 103.795265ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:14:11.862405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.120055ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T18:14:11.862533Z","caller":"traceutil/trace.go:171","msg":"trace[310987835] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"528.588431ms","start":"2026-02-11T18:14:11.333933Z","end":"2026-02-11T18:14:11.862521Z","steps":["trace[310987835] 'process raft request' (duration: 167.2964ms)","trace[310987835] 'compare' (duration: 360.908778ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:14:11.862588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:14:11.333917Z","time spent":"528.634592ms","remote":"127.0.0.1:54572","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-02-11T18:14:11.862737Z","caller":"traceutil/trace.go:171","msg":"trace[1286472528] linearizableReadLoop","detail":"{readStateIndex:822; appliedIndex:820; }","duration":"483.934533ms","start":"2026-02-11T18:14:11.378797Z","end":"2026-02-11T18:14:11.862732Z","steps":["trace[1286472528] 'read index received' (duration: 122.442805ms)","trace[1286472528] 'applied index is now lower than readState.Index' (duration: 361.491248ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:14:11.862807Z","caller":"traceutil/trace.go:171","msg":"trace[1727301827] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"528.704204ms","start":"2026-02-11T18:14:11.334099Z","end":"2026-02-11T18:14:11.862803Z","steps":["trace[1727301827] 'process raft request' (duration: 528.375263ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:14:11.862831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:14:11.334093Z","time spent":"528.723945ms","remote":"127.0.0.1:54572","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-02-11T18:14:11.862912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.115759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-11T18:14:11.862924Z","caller":"traceutil/trace.go:171","msg":"trace[1452445869] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:791; }","duration":"484.1551ms","start":"2026-02-11T18:14:11.378764Z","end":"2026-02-11T18:14:11.862919Z","steps":["trace[1452445869] 'agreement among raft nodes before linearized reading' (duration: 484.095538ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:14:11.862937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:14:11.378749Z","time spent":"484.185291ms","remote":"127.0.0.1:54572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-11T18:14:11.863123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.757562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-11T18:14:11.863185Z","caller":"traceutil/trace.go:171","msg":"trace[585797174] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:791; }","duration":"100.865117ms","start":"2026-02-11T18:14:11.762304Z","end":"2026-02-11T18:14:11.86317Z","steps":["trace[585797174] 'agreement among raft nodes before linearized reading' (duration: 100.713231ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:14:12.091375Z","caller":"traceutil/trace.go:171","msg":"trace[391681256] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"218.505732ms","start":"2026-02-11T18:14:11.872855Z","end":"2026-02-11T18:14:12.091361Z","steps":["trace[391681256] 'process raft request' (duration: 214.032682ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:14:12.621589Z","caller":"traceutil/trace.go:171","msg":"trace[1476120029] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"120.374579ms","start":"2026-02-11T18:14:12.5012Z","end":"2026-02-11T18:14:12.621575Z","steps":["trace[1476120029] 'process raft request' (duration: 120.145051ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:14:28.296351Z","caller":"traceutil/trace.go:171","msg":"trace[2079758859] linearizableReadLoop","detail":"{readStateIndex:876; appliedIndex:874; }","duration":"107.29934ms","start":"2026-02-11T18:14:28.189033Z","end":"2026-02-11T18:14:28.296333Z","steps":["trace[2079758859] 'read index received' (duration: 17.301016ms)","trace[2079758859] 'applied index is now lower than readState.Index' (duration: 89.997534ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:14:28.29651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.461404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-02-11T18:14:28.296531Z","caller":"traceutil/trace.go:171","msg":"trace[17760069] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:841; }","duration":"107.531066ms","start":"2026-02-11T18:14:28.188993Z","end":"2026-02-11T18:14:28.296525Z","steps":["trace[17760069] 'agreement among raft nodes before linearized reading' (duration: 107.407733ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:14:28.29674Z","caller":"traceutil/trace.go:171","msg":"trace[1266836114] transaction","detail":"{read_only:false; response_revision:841; number_of_response:1; }","duration":"114.382547ms","start":"2026-02-11T18:14:28.182348Z","end":"2026-02-11T18:14:28.29673Z","steps":["trace[1266836114] 'process raft request' (duration: 84.722639ms)","trace[1266836114] 'compare' (duration: 28.944457ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:14:29.741019Z","caller":"traceutil/trace.go:171","msg":"trace[161061392] linearizableReadLoop","detail":"{readStateIndex:881; appliedIndex:880; }","duration":"138.251194ms","start":"2026-02-11T18:14:29.602718Z","end":"2026-02-11T18:14:29.740969Z","steps":["trace[161061392] 'read index received' (duration: 42.03686ms)","trace[161061392] 'applied index is now lower than readState.Index' (duration: 96.212704ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:14:29.741234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.502161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-11T18:14:29.741256Z","caller":"traceutil/trace.go:171","msg":"trace[452288228] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:845; }","duration":"138.545483ms","start":"2026-02-11T18:14:29.602702Z","end":"2026-02-11T18:14:29.741248Z","steps":["trace[452288228] 'agreement among raft nodes before linearized reading' (duration: 138.387388ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:14:34.516187Z","caller":"traceutil/trace.go:171","msg":"trace[996331033] transaction","detail":"{read_only:false; response_revision:860; number_of_response:1; }","duration":"120.523567ms","start":"2026-02-11T18:14:34.395635Z","end":"2026-02-11T18:14:34.516159Z","steps":["trace[996331033] 'process raft request' (duration: 31.381146ms)","trace[996331033] 'compare' (duration: 88.800831ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:14:36.067501Z","caller":"traceutil/trace.go:171","msg":"trace[131759698] transaction","detail":"{read_only:false; response_revision:862; number_of_response:1; }","duration":"114.261665ms","start":"2026-02-11T18:14:35.953211Z","end":"2026-02-11T18:14:36.067473Z","steps":["trace[131759698] 'process raft request' (duration: 114.09889ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:14:36.509402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.756651ms","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-02-11T18:14:36.510033Z","caller":"traceutil/trace.go:171","msg":"trace[1871574559] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:863; }","duration":"122.44124ms","start":"2026-02-11T18:14:36.387563Z","end":"2026-02-11T18:14:36.510005Z","steps":["trace[1871574559] 'range keys from in-memory index tree' (duration: 121.551746ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:14:38.556297Z","caller":"traceutil/trace.go:171","msg":"trace[600438415] transaction","detail":"{read_only:false; response_revision:868; number_of_response:1; }","duration":"227.725956ms","start":"2026-02-11T18:14:38.328544Z","end":"2026-02-11T18:14:38.55627Z","steps":["trace[600438415] 'process raft request' (duration: 227.576962ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:14:38.71986Z","caller":"traceutil/trace.go:171","msg":"trace[946036655] transaction","detail":"{read_only:false; response_revision:869; number_of_response:1; }","duration":"149.074861ms","start":"2026-02-11T18:14:38.570758Z","end":"2026-02-11T18:14:38.719833Z","steps":["trace[946036655] 'process raft request' (duration: 110.479946ms)","trace[946036655] 'compare' (duration: 38.044761ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:14:40.221174Z","caller":"traceutil/trace.go:171","msg":"trace[299440930] transaction","detail":"{read_only:false; response_revision:874; number_of_response:1; }","duration":"106.391062ms","start":"2026-02-11T18:14:40.114756Z","end":"2026-02-11T18:14:40.221147Z","steps":["trace[299440930] 'process raft request' (duration: 105.844558ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:14:41.046085Z","caller":"traceutil/trace.go:171","msg":"trace[1966633282] transaction","detail":"{read_only:false; response_revision:877; number_of_response:1; }","duration":"203.221224ms","start":"2026-02-11T18:14:40.842831Z","end":"2026-02-11T18:14:41.046052Z","steps":["trace[1966633282] 'process raft request' (duration: 143.311101ms)","trace[1966633282] 'compare' (duration: 59.500082ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:14:41.046748Z","caller":"traceutil/trace.go:171","msg":"trace[1493501712] transaction","detail":"{read_only:false; response_revision:878; number_of_response:1; }","duration":"197.626405ms","start":"2026-02-11T18:14:40.84904Z","end":"2026-02-11T18:14:41.046666Z","steps":["trace[1493501712] 'process raft request' (duration: 196.723581ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:14:41.047405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.772929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4912"} {"level":"info","ts":"2026-02-11T18:14:41.047641Z","caller":"traceutil/trace.go:171","msg":"trace[409740489] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:878; }","duration":"161.098168ms","start":"2026-02-11T18:14:40.886527Z","end":"2026-02-11T18:14:41.047625Z","steps":["trace[409740489] 'agreement among raft nodes before linearized reading' (duration: 160.706228ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:14:41.04868Z","caller":"traceutil/trace.go:171","msg":"trace[2043725301] linearizableReadLoop","detail":"{readStateIndex:916; appliedIndex:913; }","duration":"159.196477ms","start":"2026-02-11T18:14:40.886601Z","end":"2026-02-11T18:14:41.045798Z","steps":["trace[2043725301] 'read index received' (duration: 21.216987ms)","trace[2043725301] 'applied index is now lower than readState.Index' (duration: 137.97866ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:14:42.806316Z","caller":"traceutil/trace.go:171","msg":"trace[1052481023] transaction","detail":"{read_only:false; response_revision:880; number_of_response:1; }","duration":"154.167753ms","start":"2026-02-11T18:14:42.652116Z","end":"2026-02-11T18:14:42.806284Z","steps":["trace[1052481023] 'process raft request' (duration: 153.686301ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:14:43.185287Z","caller":"traceutil/trace.go:171","msg":"trace[466878442] linearizableReadLoop","detail":"{readStateIndex:919; appliedIndex:918; }","duration":"121.716305ms","start":"2026-02-11T18:14:43.063545Z","end":"2026-02-11T18:14:43.185261Z","steps":["trace[466878442] 'read index received' (duration: 121.412937ms)","trace[466878442] 'applied index is now lower than readState.Index' (duration: 302.618µs)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:14:43.185755Z","caller":"traceutil/trace.go:171","msg":"trace[182040010] transaction","detail":"{read_only:false; response_revision:881; number_of_response:1; }","duration":"225.791627ms","start":"2026-02-11T18:14:42.959954Z","end":"2026-02-11T18:14:43.185746Z","steps":["trace[182040010] 'process raft request' (duration: 225.089468ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:14:43.186073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.515307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-11T18:14:43.186135Z","caller":"traceutil/trace.go:171","msg":"trace[945996294] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:881; }","duration":"122.675911ms","start":"2026-02-11T18:14:43.063448Z","end":"2026-02-11T18:14:43.186124Z","steps":["trace[945996294] 'agreement among raft nodes before linearized reading' (duration: 122.504046ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:14:43.186288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.549096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-11T18:14:43.186328Z","caller":"traceutil/trace.go:171","msg":"trace[537289552] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:881; }","duration":"112.644328ms","start":"2026-02-11T18:14:43.073678Z","end":"2026-02-11T18:14:43.186322Z","steps":["trace[537289552] 'agreement among raft nodes before linearized reading' (duration: 112.559946ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:14:44.989842Z","caller":"traceutil/trace.go:171","msg":"trace[908057448] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"171.321244ms","start":"2026-02-11T18:14:44.818486Z","end":"2026-02-11T18:14:44.989807Z","steps":["trace[908057448] 'process raft request' (duration: 171.16133ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:14:45.310565Z","caller":"traceutil/trace.go:171","msg":"trace[1970296450] transaction","detail":"{read_only:false; response_revision:887; number_of_response:1; }","duration":"104.21233ms","start":"2026-02-11T18:14:45.206267Z","end":"2026-02-11T18:14:45.31048Z","steps":["trace[1970296450] 'process raft request' (duration: 103.956613ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:14:45.446713Z","caller":"traceutil/trace.go:171","msg":"trace[1671401066] transaction","detail":"{read_only:false; response_revision:889; number_of_response:1; }","duration":"127.240345ms","start":"2026-02-11T18:14:45.319442Z","end":"2026-02-11T18:14:45.446683Z","steps":["trace[1671401066] 'process raft request' (duration: 120.09421ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:14:53.492668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.631202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329940"} {"level":"info","ts":"2026-02-11T18:14:53.492827Z","caller":"traceutil/trace.go:171","msg":"trace[946263170] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:908; }","duration":"218.820117ms","start":"2026-02-11T18:14:53.273987Z","end":"2026-02-11T18:14:53.492807Z","steps":["trace[946263170] 'range keys from in-memory index tree' (duration: 218.363806ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:14:54.654234Z","caller":"traceutil/trace.go:171","msg":"trace[662926339] linearizableReadLoop","detail":"{readStateIndex:954; appliedIndex:953; }","duration":"107.398013ms","start":"2026-02-11T18:14:54.546816Z","end":"2026-02-11T18:14:54.654214Z","steps":["trace[662926339] 'read index received' (duration: 107.247969ms)","trace[662926339] 'applied index is now lower than readState.Index' (duration: 149.384µs)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:14:54.654344Z","caller":"traceutil/trace.go:171","msg":"trace[502509503] transaction","detail":"{read_only:false; response_revision:913; number_of_response:1; }","duration":"165.100207ms","start":"2026-02-11T18:14:54.489234Z","end":"2026-02-11T18:14:54.654334Z","steps":["trace[502509503] 'process raft request' (duration: 164.874171ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:14:54.654718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.901865ms","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-02-11T18:14:54.654747Z","caller":"traceutil/trace.go:171","msg":"trace[1700981463] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:913; }","duration":"107.978627ms","start":"2026-02-11T18:14:54.54676Z","end":"2026-02-11T18:14:54.654739Z","steps":["trace[1700981463] 'agreement among raft nodes before linearized reading' (duration: 107.919545ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:14:55.696193Z","caller":"traceutil/trace.go:171","msg":"trace[1799337778] linearizableReadLoop","detail":"{readStateIndex:957; appliedIndex:956; }","duration":"104.489666ms","start":"2026-02-11T18:14:55.591679Z","end":"2026-02-11T18:14:55.696169Z","steps":["trace[1799337778] 'read index received' (duration: 54.442276ms)","trace[1799337778] 'applied index is now lower than readState.Index' (duration: 50.04651ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:14:55.696858Z","caller":"traceutil/trace.go:171","msg":"trace[385281391] transaction","detail":"{read_only:false; response_revision:916; number_of_response:1; }","duration":"110.528522ms","start":"2026-02-11T18:14:55.586313Z","end":"2026-02-11T18:14:55.696841Z","steps":["trace[385281391] 'process raft request' (duration: 109.736733ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:14:55.69716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.464189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-11T18:14:55.698177Z","caller":"traceutil/trace.go:171","msg":"trace[856407026] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:916; }","duration":"105.550502ms","start":"2026-02-11T18:14:55.591645Z","end":"2026-02-11T18:14:55.697196Z","steps":["trace[856407026] 'agreement among raft nodes before linearized reading' (duration: 104.629889ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:14:59.802924Z","caller":"traceutil/trace.go:171","msg":"trace[632038358] transaction","detail":"{read_only:false; response_revision:927; number_of_response:1; }","duration":"128.919681ms","start":"2026-02-11T18:14:59.673987Z","end":"2026-02-11T18:14:59.802907Z","steps":["trace[632038358] 'process raft request' (duration: 128.429239ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:15:00.009082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.065403ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T18:15:00.0092Z","caller":"traceutil/trace.go:171","msg":"trace[1642605715] transaction","detail":"{read_only:false; response_revision:929; number_of_response:1; }","duration":"179.060723ms","start":"2026-02-11T18:14:59.830127Z","end":"2026-02-11T18:15:00.009187Z","steps":["trace[1642605715] 'process raft request' (duration: 41.828006ms)","trace[1642605715] 'compare' (duration: 136.93746ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:15:04.22274Z","caller":"traceutil/trace.go:171","msg":"trace[1583993739] transaction","detail":"{read_only:false; response_revision:939; number_of_response:1; }","duration":"166.34056ms","start":"2026-02-11T18:15:04.056381Z","end":"2026-02-11T18:15:04.222722Z","steps":["trace[1583993739] 'process raft request' (duration: 165.9343ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:15:06.36218Z","caller":"traceutil/trace.go:171","msg":"trace[2072193280] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"100.761461ms","start":"2026-02-11T18:15:06.261402Z","end":"2026-02-11T18:15:06.362163Z","steps":["trace[2072193280] 'process raft request' (duration: 100.673899ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:15:09.575559Z","caller":"traceutil/trace.go:171","msg":"trace[1978448277] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"156.169949ms","start":"2026-02-11T18:15:09.419132Z","end":"2026-02-11T18:15:09.575302Z","steps":["trace[1978448277] 'process raft request' (duration: 156.039756ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:15:10.145032Z","caller":"traceutil/trace.go:171","msg":"trace[1044792408] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"205.04098ms","start":"2026-02-11T18:15:09.939973Z","end":"2026-02-11T18:15:10.145014Z","steps":["trace[1044792408] 'process raft request' (duration: 204.893097ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:15:10.378283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.787188ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T18:15:10.379098Z","caller":"traceutil/trace.go:171","msg":"trace[153349098] linearizableReadLoop","detail":"{readStateIndex:1012; appliedIndex:1010; }","duration":"236.489919ms","start":"2026-02-11T18:15:10.142521Z","end":"2026-02-11T18:15:10.379011Z","steps":["trace[153349098] 'read index received' (duration: 2.398953ms)","trace[153349098] 'applied index is now lower than readState.Index' (duration: 234.089456ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:15:10.379242Z","caller":"traceutil/trace.go:171","msg":"trace[1619436500] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"404.250299ms","start":"2026-02-11T18:15:09.974982Z","end":"2026-02-11T18:15:10.379233Z","steps":["trace[1619436500] 'process raft request' (duration: 253.446828ms)","trace[1619436500] 'compare' (duration: 149.702677ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:15:10.37945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:15:09.974958Z","time spent":"404.433233ms","remote":"127.0.0.1:54572","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-02-11T18:15:10.379783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.262016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-11T18:15:10.380017Z","caller":"traceutil/trace.go:171","msg":"trace[1027676756] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:967; }","duration":"237.520802ms","start":"2026-02-11T18:15:10.142485Z","end":"2026-02-11T18:15:10.380006Z","steps":["trace[1027676756] 'agreement among raft nodes before linearized reading' (duration: 237.251056ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:15:11.775254Z","caller":"traceutil/trace.go:171","msg":"trace[1090609817] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"193.282129ms","start":"2026-02-11T18:15:11.581942Z","end":"2026-02-11T18:15:11.775224Z","steps":["trace[1090609817] 'process raft request' (duration: 192.781648ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:15:13.280736Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880867362327151777,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-11T18:15:13.781596Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880867362327151777,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-11T18:15:13.990355Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.515799847s","expected-duration":"1s"} {"level":"info","ts":"2026-02-11T18:15:13.990962Z","caller":"traceutil/trace.go:171","msg":"trace[479620660] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"1.516482402s","start":"2026-02-11T18:15:12.474459Z","end":"2026-02-11T18:15:13.990942Z","steps":["trace[479620660] 'process raft request' (duration: 1.516296978s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:15:13.991163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:15:12.474438Z","time spent":"1.516584954s","remote":"127.0.0.1:54368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":852,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-11T18:15:14.422628Z","caller":"traceutil/trace.go:171","msg":"trace[54984146] linearizableReadLoop","detail":"{readStateIndex:1022; appliedIndex:1019; }","duration":"1.641921116s","start":"2026-02-11T18:15:12.780689Z","end":"2026-02-11T18:15:14.42261Z","steps":["trace[54984146] 'read index received' (duration: 1.210116047s)","trace[54984146] 'applied index is now lower than readState.Index' (duration: 431.804459ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:15:14.423066Z","caller":"traceutil/trace.go:171","msg":"trace[1346925462] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"1.945657682s","start":"2026-02-11T18:15:12.4774Z","end":"2026-02-11T18:15:14.423058Z","steps":["trace[1346925462] 'process raft request' (duration: 1.93542199s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:15:14.423211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:15:12.477383Z","time spent":"1.945767425s","remote":"127.0.0.1:54572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T18:15:14.423379Z","caller":"traceutil/trace.go:171","msg":"trace[983979919] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"1.944916636s","start":"2026-02-11T18:15:12.478455Z","end":"2026-02-11T18:15:14.423372Z","steps":["trace[983979919] 'process raft request' (duration: 1.944085608s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:15:14.423509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:15:12.478449Z","time spent":"1.945035809s","remote":"127.0.0.1:54572","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-02-11T18:15:14.42368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.642989609s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a3970de1-d5e1-4d3c-b0e2-232bb48fd333\" ","response":"range_response_count:1 size:3535"} {"level":"info","ts":"2026-02-11T18:15:14.423776Z","caller":"traceutil/trace.go:171","msg":"trace[475815741] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a3970de1-d5e1-4d3c-b0e2-232bb48fd333; range_end:; response_count:1; response_revision:977; }","duration":"1.643121892s","start":"2026-02-11T18:15:12.780646Z","end":"2026-02-11T18:15:14.423768Z","steps":["trace[475815741] 'agreement among raft nodes before linearized reading' (duration: 1.642964178s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:15:14.423821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:15:12.780626Z","time spent":"1.643184523s","remote":"127.0.0.1:54494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3557,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a3970de1-d5e1-4d3c-b0e2-232bb48fd333\" "} {"level":"warn","ts":"2026-02-11T18:15:14.424267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.296676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-02-11T18:15:14.424009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.625061767s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T18:15:14.424634Z","caller":"traceutil/trace.go:171","msg":"trace[1255664752] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:977; }","duration":"1.62572049s","start":"2026-02-11T18:15:12.798905Z","end":"2026-02-11T18:15:14.424625Z","steps":["trace[1255664752] 'agreement among raft nodes before linearized reading' (duration: 1.625082527s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:15:14.424673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:15:12.798885Z","time spent":"1.625779262s","remote":"127.0.0.1:54316","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-02-11T18:15:14.424825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.141931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.229\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-11T18:15:14.424915Z","caller":"traceutil/trace.go:171","msg":"trace[435283590] range","detail":"{range_begin:/registry/masterleases/199.204.45.229; range_end:; response_count:1; response_revision:977; }","duration":"200.269443ms","start":"2026-02-11T18:15:14.224638Z","end":"2026-02-11T18:15:14.424908Z","steps":["trace[435283590] 'agreement among raft nodes before linearized reading' (duration: 200.137191ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:15:14.424391Z","caller":"traceutil/trace.go:171","msg":"trace[73074785] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:977; }","duration":"195.452669ms","start":"2026-02-11T18:15:14.228916Z","end":"2026-02-11T18:15:14.424369Z","steps":["trace[73074785] 'agreement among raft nodes before linearized reading' (duration: 195.201803ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:15:14.425223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"949.555375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a3970de1-d5e1-4d3c-b0e2-232bb48fd333\" ","response":"range_response_count:1 size:3535"} {"level":"info","ts":"2026-02-11T18:15:14.425262Z","caller":"traceutil/trace.go:171","msg":"trace[601135787] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a3970de1-d5e1-4d3c-b0e2-232bb48fd333; range_end:; response_count:1; response_revision:977; }","duration":"949.620106ms","start":"2026-02-11T18:15:13.475633Z","end":"2026-02-11T18:15:14.425253Z","steps":["trace[601135787] 'agreement among raft nodes before linearized reading' (duration: 949.541874ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:15:14.425342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:15:13.475618Z","time spent":"949.717648ms","remote":"127.0.0.1:54494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3557,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a3970de1-d5e1-4d3c-b0e2-232bb48fd333\" "} {"level":"warn","ts":"2026-02-11T18:15:14.425483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.351715883s","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-02-11T18:15:14.425528Z","caller":"traceutil/trace.go:171","msg":"trace[1128420853] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:977; }","duration":"1.351870347s","start":"2026-02-11T18:15:13.073651Z","end":"2026-02-11T18:15:14.425521Z","steps":["trace[1128420853] 'agreement among raft nodes before linearized reading' (duration: 1.351790195s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:15:14.425562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:15:13.073631Z","time spent":"1.351924458s","remote":"127.0.0.1:54572","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-02-11T18:15:14.42513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"645.392534ms","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-02-11T18:15:14.426212Z","caller":"traceutil/trace.go:171","msg":"trace[307613982] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:977; }","duration":"646.503198ms","start":"2026-02-11T18:15:13.779701Z","end":"2026-02-11T18:15:14.426204Z","steps":["trace[307613982] 'agreement among raft nodes before linearized reading' (duration: 645.370993ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:15:14.426252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:15:13.779683Z","time spent":"646.560739ms","remote":"127.0.0.1:54572","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-02-11T18:15:14.764691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.517944ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"info","ts":"2026-02-11T18:15:14.764827Z","caller":"traceutil/trace.go:171","msg":"trace[1513230017] linearizableReadLoop","detail":"{readStateIndex:1023; appliedIndex:1022; }","duration":"333.623555ms","start":"2026-02-11T18:15:14.431165Z","end":"2026-02-11T18:15:14.764788Z","steps":["trace[1513230017] 'read index received' (duration: 142.096611ms)","trace[1513230017] 'applied index is now lower than readState.Index' (duration: 191.525214ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:15:14.764905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.728767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T18:15:14.764926Z","caller":"traceutil/trace.go:171","msg":"trace[725561459] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:977; }","duration":"333.773548ms","start":"2026-02-11T18:15:14.431144Z","end":"2026-02-11T18:15:14.764918Z","steps":["trace[725561459] 'agreement among raft nodes before linearized reading' (duration: 333.706847ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:15:14.764966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:15:14.431135Z","time spent":"333.812919ms","remote":"127.0.0.1:54326","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-02-11T18:15:14.765225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:15:14.43086Z","time spent":"334.33906ms","remote":"127.0.0.1:54338","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-11T18:15:14.860498Z","caller":"traceutil/trace.go:171","msg":"trace[822277314] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"423.707609ms","start":"2026-02-11T18:15:14.436769Z","end":"2026-02-11T18:15:14.860477Z","steps":["trace[822277314] 'process raft request' (duration: 423.664358ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:15:14.860836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:15:14.436758Z","time spent":"423.987134ms","remote":"127.0.0.1:54494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3621,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T18:15:14.860935Z","caller":"traceutil/trace.go:171","msg":"trace[865476457] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"426.53022ms","start":"2026-02-11T18:15:14.434372Z","end":"2026-02-11T18:15:14.860902Z","steps":["trace[865476457] 'process raft request' (duration: 425.887416ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:15:14.861292Z","caller":"traceutil/trace.go:171","msg":"trace[1848792828] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"424.528096ms","start":"2026-02-11T18:15:14.436755Z","end":"2026-02-11T18:15:14.861283Z","steps":["trace[1848792828] 'process raft request' (duration: 423.635507ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:15:14.861609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:15:14.436747Z","time spent":"424.824363ms","remote":"127.0.0.1:54572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T18:15:14.861416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:15:14.434355Z","time spent":"426.680494ms","remote":"127.0.0.1:54572","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-02-11T18:15:14.86146Z","caller":"traceutil/trace.go:171","msg":"trace[683819252] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"427.172804ms","start":"2026-02-11T18:15:14.434278Z","end":"2026-02-11T18:15:14.861451Z","steps":["trace[683819252] 'process raft request' (duration: 425.843685ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:15:14.862662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:15:14.434264Z","time spent":"428.3731ms","remote":"127.0.0.1:54572","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-02-11T18:15:15.009589Z","caller":"traceutil/trace.go:171","msg":"trace[1763881915] linearizableReadLoop","detail":"{readStateIndex:1028; appliedIndex:1023; }","duration":"237.46284ms","start":"2026-02-11T18:15:14.772106Z","end":"2026-02-11T18:15:15.009569Z","steps":["trace[1763881915] 'read index received' (duration: 88.0502ms)","trace[1763881915] 'applied index is now lower than readState.Index' (duration: 149.41181ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:15:15.009964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.845398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T18:15:15.010113Z","caller":"traceutil/trace.go:171","msg":"trace[888758395] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:982; }","duration":"238.028132ms","start":"2026-02-11T18:15:14.772075Z","end":"2026-02-11T18:15:15.010103Z","steps":["trace[888758395] 'agreement among raft nodes before linearized reading' (duration: 237.820438ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:15:15.010056Z","caller":"traceutil/trace.go:171","msg":"trace[1468418358] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"242.149281ms","start":"2026-02-11T18:15:14.767891Z","end":"2026-02-11T18:15:15.01004Z","steps":["trace[1468418358] 'process raft request' (duration: 231.03138ms)","trace[1468418358] 'compare' (duration: 10.361994ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:15:17.807528Z","caller":"traceutil/trace.go:171","msg":"trace[974722203] transaction","detail":"{read_only:false; number_of_response:1; response_revision:992; }","duration":"139.816087ms","start":"2026-02-11T18:15:17.667693Z","end":"2026-02-11T18:15:17.807509Z","steps":["trace[974722203] 'process raft request' (duration: 105.728029ms)","trace[974722203] 'compare' (duration: 33.920404ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:15:18.036542Z","caller":"traceutil/trace.go:171","msg":"trace[1448161531] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"128.300977ms","start":"2026-02-11T18:15:17.908212Z","end":"2026-02-11T18:15:18.036513Z","steps":["trace[1448161531] 'process raft request' (duration: 94.817746ms)","trace[1448161531] 'compare' (duration: 33.121174ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:15:18.590226Z","caller":"traceutil/trace.go:171","msg":"trace[781331500] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"150.569932ms","start":"2026-02-11T18:15:18.439638Z","end":"2026-02-11T18:15:18.590208Z","steps":["trace[781331500] 'process raft request' (duration: 150.288896ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:15:18.739159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.244497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:1 size:1465"} {"level":"info","ts":"2026-02-11T18:15:18.739249Z","caller":"traceutil/trace.go:171","msg":"trace[1581053766] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:1001; }","duration":"121.383451ms","start":"2026-02-11T18:15:18.617845Z","end":"2026-02-11T18:15:18.739229Z","steps":["trace[1581053766] 'range keys from in-memory index tree' (duration: 121.058494ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:15:18.787158Z","caller":"traceutil/trace.go:171","msg":"trace[1260910800] transaction","detail":"{read_only:false; response_revision:1002; number_of_response:1; }","duration":"168.804328ms","start":"2026-02-11T18:15:18.618329Z","end":"2026-02-11T18:15:18.787134Z","steps":["trace[1260910800] 'process raft request' (duration: 168.43516ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:15:19.532965Z","caller":"traceutil/trace.go:171","msg":"trace[534282706] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"111.854396ms","start":"2026-02-11T18:15:19.421075Z","end":"2026-02-11T18:15:19.53293Z","steps":["trace[534282706] 'process raft request' (duration: 111.681803ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:15:19.952857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.039974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T18:15:19.953012Z","caller":"traceutil/trace.go:171","msg":"trace[184752394] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1008; }","duration":"151.253778ms","start":"2026-02-11T18:15:19.801732Z","end":"2026-02-11T18:15:19.952986Z","steps":["trace[184752394] 'range keys from in-memory index tree' (duration: 150.979882ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:15:20.623725Z","caller":"traceutil/trace.go:171","msg":"trace[510169482] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"123.525139ms","start":"2026-02-11T18:15:20.500177Z","end":"2026-02-11T18:15:20.623702Z","steps":["trace[510169482] 'process raft request' (duration: 123.381216ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:15:20.625661Z","caller":"traceutil/trace.go:171","msg":"trace[523788035] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"121.540557ms","start":"2026-02-11T18:15:20.504091Z","end":"2026-02-11T18:15:20.625632Z","steps":["trace[523788035] 'process raft request' (duration: 121.337943ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:15:21.280048Z","caller":"traceutil/trace.go:171","msg":"trace[1215357644] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"266.140435ms","start":"2026-02-11T18:15:21.013783Z","end":"2026-02-11T18:15:21.279923Z","steps":["trace[1215357644] 'process raft request' (duration: 266.009122ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:15:21.344761Z","caller":"traceutil/trace.go:171","msg":"trace[1539343985] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"330.229678ms","start":"2026-02-11T18:15:21.014515Z","end":"2026-02-11T18:15:21.344744Z","steps":["trace[1539343985] 'process raft request' (duration: 330.140866ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:15:21.345055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:15:21.014508Z","time spent":"330.471252ms","remote":"127.0.0.1:54572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T18:15:23.469418Z","caller":"traceutil/trace.go:171","msg":"trace[1134882373] transaction","detail":"{read_only:false; response_revision:1020; number_of_response:1; }","duration":"117.704492ms","start":"2026-02-11T18:15:23.351686Z","end":"2026-02-11T18:15:23.46939Z","steps":["trace[1134882373] 'process raft request' (duration: 65.285645ms)","trace[1134882373] 'compare' (duration: 52.291995ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:15:25.076113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.891761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T18:15:25.076191Z","caller":"traceutil/trace.go:171","msg":"trace[80338306] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1022; }","duration":"275.010453ms","start":"2026-02-11T18:15:24.80116Z","end":"2026-02-11T18:15:25.076171Z","steps":["trace[80338306] 'range keys from in-memory index tree' (duration: 274.831129ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:15:25.07644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.866886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-11T18:15:25.076497Z","caller":"traceutil/trace.go:171","msg":"trace[237903053] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1022; }","duration":"329.966798ms","start":"2026-02-11T18:15:24.746517Z","end":"2026-02-11T18:15:25.076484Z","steps":["trace[237903053] 'range keys from in-memory index tree' (duration: 329.681842ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:15:25.076525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:15:24.746498Z","time spent":"330.019119ms","remote":"127.0.0.1:54572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-11T18:15:33.641773Z","caller":"traceutil/trace.go:171","msg":"trace[566803318] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"254.854587ms","start":"2026-02-11T18:15:33.386896Z","end":"2026-02-11T18:15:33.64175Z","steps":["trace[566803318] 'process raft request' (duration: 254.731775ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:15:33.767866Z","caller":"traceutil/trace.go:171","msg":"trace[1985171073] transaction","detail":"{read_only:false; response_revision:1055; number_of_response:1; }","duration":"120.401429ms","start":"2026-02-11T18:15:33.647431Z","end":"2026-02-11T18:15:33.767832Z","steps":["trace[1985171073] 'process raft request' (duration: 48.176006ms)","trace[1985171073] 'compare' (duration: 71.636722ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T18:15:34.733283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.853808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.229\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-11T18:15:34.733376Z","caller":"traceutil/trace.go:171","msg":"trace[1111606187] range","detail":"{range_begin:/registry/masterleases/199.204.45.229; range_end:; response_count:1; response_revision:1055; }","duration":"508.016972ms","start":"2026-02-11T18:15:34.225336Z","end":"2026-02-11T18:15:34.733353Z","steps":["trace[1111606187] 'range keys from in-memory index tree' (duration: 507.625364ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:15:34.73424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:15:34.225304Z","time spent":"508.916659ms","remote":"127.0.0.1:54338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.229\" "} {"level":"warn","ts":"2026-02-11T18:15:34.733971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.529851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T18:15:34.734778Z","caller":"traceutil/trace.go:171","msg":"trace[1758138887] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:1055; }","duration":"385.239905ms","start":"2026-02-11T18:15:34.349382Z","end":"2026-02-11T18:15:34.734622Z","steps":["trace[1758138887] 'count revisions from in-memory index tree' (duration: 384.456739ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:15:34.734837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T18:15:34.349361Z","time spent":"385.45822ms","remote":"127.0.0.1:55900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "} {"level":"info","ts":"2026-02-11T18:15:34.943019Z","caller":"traceutil/trace.go:171","msg":"trace[757202948] transaction","detail":"{read_only:false; response_revision:1056; number_of_response:1; }","duration":"145.878963ms","start":"2026-02-11T18:15:34.797121Z","end":"2026-02-11T18:15:34.943Z","steps":["trace[757202948] 'process raft request' (duration: 46.464778ms)","trace[757202948] 'compare' (duration: 99.269382ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:15:34.943372Z","caller":"traceutil/trace.go:171","msg":"trace[1905435397] linearizableReadLoop","detail":"{readStateIndex:1107; appliedIndex:1105; }","duration":"142.232281ms","start":"2026-02-11T18:15:34.801131Z","end":"2026-02-11T18:15:34.943363Z","steps":["trace[1905435397] 'read index received' (duration: 42.433268ms)","trace[1905435397] 'applied index is now lower than readState.Index' (duration: 99.798363ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:15:34.943518Z","caller":"traceutil/trace.go:171","msg":"trace[306452193] transaction","detail":"{read_only:false; response_revision:1057; number_of_response:1; }","duration":"142.619239ms","start":"2026-02-11T18:15:34.800893Z","end":"2026-02-11T18:15:34.943513Z","steps":["trace[306452193] 'process raft request' (duration: 142.072728ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:15:34.943646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.502476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T18:15:34.94367Z","caller":"traceutil/trace.go:171","msg":"trace[150202008] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1057; }","duration":"142.727961ms","start":"2026-02-11T18:15:34.800937Z","end":"2026-02-11T18:15:34.943665Z","steps":["trace[150202008] 'agreement among raft nodes before linearized reading' (duration: 142.455526ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:15:35.695242Z","caller":"traceutil/trace.go:171","msg":"trace[734717667] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1063; }","duration":"102.852925ms","start":"2026-02-11T18:15:35.592372Z","end":"2026-02-11T18:15:35.695225Z","steps":["trace[734717667] 'process raft request' (duration: 88.859549ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T18:16:06.159678Z","caller":"traceutil/trace.go:171","msg":"trace[1365886695] linearizableReadLoop","detail":"{readStateIndex:1205; appliedIndex:1204; }","duration":"295.265857ms","start":"2026-02-11T18:16:05.864385Z","end":"2026-02-11T18:16:06.159651Z","steps":["trace[1365886695] 'read index received' (duration: 295.002072ms)","trace[1365886695] 'applied index is now lower than readState.Index' (duration: 262.885µs)"],"step_count":2} {"level":"info","ts":"2026-02-11T18:16:06.159997Z","caller":"traceutil/trace.go:171","msg":"trace[635994764] transaction","detail":"{read_only:false; response_revision:1149; number_of_response:1; }","duration":"299.281828ms","start":"2026-02-11T18:16:05.860702Z","end":"2026-02-11T18:16:06.159984Z","steps":["trace[635994764] 'process raft request' (duration: 298.745958ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:16:06.1605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.375498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-11T18:16:06.160647Z","caller":"traceutil/trace.go:171","msg":"trace[412877682] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1149; }","duration":"135.567811ms","start":"2026-02-11T18:16:06.025065Z","end":"2026-02-11T18:16:06.160633Z","steps":["trace[412877682] 'agreement among raft nodes before linearized reading' (duration: 135.316497ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:16:06.160638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.534886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:79 size:58464"} {"level":"info","ts":"2026-02-11T18:16:06.160897Z","caller":"traceutil/trace.go:171","msg":"trace[1813878140] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:79; response_revision:1149; }","duration":"284.795811ms","start":"2026-02-11T18:16:05.876025Z","end":"2026-02-11T18:16:06.16082Z","steps":["trace[1813878140] 'agreement among raft nodes before linearized reading' (duration: 284.083718ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:16:06.161182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.200376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-11T18:16:06.16121Z","caller":"traceutil/trace.go:171","msg":"trace[129017336] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:1149; }","duration":"143.272098ms","start":"2026-02-11T18:16:06.017931Z","end":"2026-02-11T18:16:06.161203Z","steps":["trace[129017336] 'agreement among raft nodes before linearized reading' (duration: 143.219097ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T18:16:06.162096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.70976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:79 size:58464"} {"level":"info","ts":"2026-02-11T18:16:06.162127Z","caller":"traceutil/trace.go:171","msg":"trace[611937431] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:79; response_revision:1149; }","duration":"297.767222ms","start":"2026-02-11T18:16:05.864352Z","end":"2026-02-11T18:16:06.162119Z","steps":["trace[611937431] 'agreement among raft nodes before linearized reading' (duration: 297.470587ms)"],"step_count":1}