{"level":"warn","ts":"2026-04-08T01:22:18.242662Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-08T01:22:18.24279Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.3: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.3:2380","--initial-cluster=instance=https://199.204.45.3:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.3:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.3: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-04-08T01:22:18.242866Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-08T01:22:18.242875Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.3:2380"]} {"level":"info","ts":"2026-04-08T01:22:18.242892Z","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-04-08T01:22:18.243587Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"]} {"level":"info","ts":"2026-04-08T01:22:18.243681Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.3: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-04-08T01:22:18.250842Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.943553ms"} {"level":"info","ts":"2026-04-08T01:22:18.261149Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"597401b06ce1cf3d","cluster-id":"dfc54657ad8a2432"} {"level":"info","ts":"2026-04-08T01:22:18.261229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=()"} {"level":"info","ts":"2026-04-08T01:22:18.26125Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 0"} {"level":"info","ts":"2026-04-08T01:22:18.26127Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 597401b06ce1cf3d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-08T01:22:18.261282Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 1"} {"level":"info","ts":"2026-04-08T01:22:18.261325Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"} {"level":"warn","ts":"2026-04-08T01:22:18.269996Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-08T01:22:18.272357Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-08T01:22:18.27403Z","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-04-08T01:22:18.279786Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"597401b06ce1cf3d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-08T01:22:18.280041Z","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-04-08T01:22:18.282801Z","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-04-08T01:22:18.280017Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"597401b06ce1cf3d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-08T01:22:18.28301Z","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-04-08T01:22:18.288025Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"} {"level":"info","ts":"2026-04-08T01:22:18.289088Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","added-peer-id":"597401b06ce1cf3d","added-peer-peer-urls":["https://199.204.45.3:2380"]} {"level":"info","ts":"2026-04-08T01:22:18.289926Z","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-04-08T01:22:18.290172Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"597401b06ce1cf3d","initial-advertise-peer-urls":["https://199.204.45.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-08T01:22:18.290213Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-08T01:22:18.29074Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.3:2380"} {"level":"info","ts":"2026-04-08T01:22:18.290782Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.3:2380"} {"level":"info","ts":"2026-04-08T01:22:18.66154Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d is starting a new election at term 1"} {"level":"info","ts":"2026-04-08T01:22:18.661629Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became pre-candidate at term 1"} {"level":"info","ts":"2026-04-08T01:22:18.661661Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgPreVoteResp from 597401b06ce1cf3d at term 1"} {"level":"info","ts":"2026-04-08T01:22:18.661682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became candidate at term 2"} {"level":"info","ts":"2026-04-08T01:22:18.661693Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgVoteResp from 597401b06ce1cf3d at term 2"} {"level":"info","ts":"2026-04-08T01:22:18.661709Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became leader at term 2"} {"level":"info","ts":"2026-04-08T01:22:18.661722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 597401b06ce1cf3d elected leader 597401b06ce1cf3d at term 2"} {"level":"info","ts":"2026-04-08T01:22:18.66278Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"597401b06ce1cf3d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.3:2379]}","request-path":"/0/members/597401b06ce1cf3d/attributes","cluster-id":"dfc54657ad8a2432","publish-timeout":"7s"} {"level":"info","ts":"2026-04-08T01:22:18.663073Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T01:22:18.663791Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T01:22:18.664201Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T01:22:18.664448Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-08T01:22:18.664466Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-08T01:22:18.664498Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T01:22:18.66458Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T01:22:18.664603Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T01:22:18.667208Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.3:2379"} {"level":"info","ts":"2026-04-08T01:22:18.670356Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-08T01:22:20.166043Z","caller":"traceutil/trace.go:171","msg":"trace[776397816] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"202.333886ms","start":"2026-04-08T01:22:19.963679Z","end":"2026-04-08T01:22:20.166013Z","steps":["trace[776397816] 'process raft request' (duration: 202.092021ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:20.166132Z","caller":"traceutil/trace.go:171","msg":"trace[930296736] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:5; }","duration":"202.158153ms","start":"2026-04-08T01:22:19.963921Z","end":"2026-04-08T01:22:20.166079Z","steps":["trace[930296736] 'read index received' (duration: 202.135632ms)","trace[930296736] 'applied index is now lower than readState.Index' (duration: 18.49µs)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:22:20.166626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.669783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-08T01:22:20.167494Z","caller":"traceutil/trace.go:171","msg":"trace[1501616831] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:0; response_revision:2; }","duration":"203.581194ms","start":"2026-04-08T01:22:19.963867Z","end":"2026-04-08T01:22:20.167448Z","steps":["trace[1501616831] 'agreement among raft nodes before linearized reading' (duration: 202.439928ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:20.211342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.471864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-08T01:22:20.211413Z","caller":"traceutil/trace.go:171","msg":"trace[970990654] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:9; }","duration":"170.569737ms","start":"2026-04-08T01:22:20.040827Z","end":"2026-04-08T01:22:20.211397Z","steps":["trace[970990654] 'agreement among raft nodes before linearized reading' (duration: 170.407453ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:20.211373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.568107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-08T01:22:20.211521Z","caller":"traceutil/trace.go:171","msg":"trace[879482932] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:9; }","duration":"121.772522ms","start":"2026-04-08T01:22:20.08972Z","end":"2026-04-08T01:22:20.211492Z","steps":["trace[879482932] 'agreement among raft nodes before linearized reading' (duration: 121.460725ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:20.211587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.76886ms","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-04-08T01:22:20.211617Z","caller":"traceutil/trace.go:171","msg":"trace[1901072127] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:9; }","duration":"170.838623ms","start":"2026-04-08T01:22:20.040766Z","end":"2026-04-08T01:22:20.211604Z","steps":["trace[1901072127] 'agreement among raft nodes before linearized reading' (duration: 170.797472ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:20.211718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.938705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.3\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-08T01:22:20.211735Z","caller":"traceutil/trace.go:171","msg":"trace[1621477906] range","detail":"{range_begin:/registry/masterleases/199.204.45.3; range_end:; response_count:0; response_revision:9; }","duration":"175.964426ms","start":"2026-04-08T01:22:20.035765Z","end":"2026-04-08T01:22:20.21173Z","steps":["trace[1621477906] 'agreement among raft nodes before linearized reading' (duration: 175.934515ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:20.211843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.595057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-08T01:22:20.211868Z","caller":"traceutil/trace.go:171","msg":"trace[1368900388] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:9; }","duration":"199.635588ms","start":"2026-04-08T01:22:20.012224Z","end":"2026-04-08T01:22:20.211859Z","steps":["trace[1368900388] 'agreement among raft nodes before linearized reading' (duration: 199.602387ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:20.212054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.865365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3169"} {"level":"info","ts":"2026-04-08T01:22:20.212085Z","caller":"traceutil/trace.go:171","msg":"trace[787455213] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:9; }","duration":"245.911066ms","start":"2026-04-08T01:22:19.966165Z","end":"2026-04-08T01:22:20.212076Z","steps":["trace[787455213] 'agreement among raft nodes before linearized reading' (duration: 245.844345ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:20.212239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.228224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-08T01:22:20.212268Z","caller":"traceutil/trace.go:171","msg":"trace[1030895294] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:0; response_revision:9; }","duration":"246.268384ms","start":"2026-04-08T01:22:19.96599Z","end":"2026-04-08T01:22:20.212258Z","steps":["trace[1030895294] 'agreement among raft nodes before linearized reading' (duration: 246.223563ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:20.212283Z","caller":"traceutil/trace.go:171","msg":"trace[456733340] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"171.213351ms","start":"2026-04-08T01:22:20.041029Z","end":"2026-04-08T01:22:20.212243Z","steps":["trace[456733340] 'process raft request' (duration: 169.972803ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:20.212416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.612974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-08T01:22:20.212449Z","caller":"traceutil/trace.go:171","msg":"trace[770247928] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:0; response_revision:9; }","duration":"247.656895ms","start":"2026-04-08T01:22:19.964783Z","end":"2026-04-08T01:22:20.21244Z","steps":["trace[770247928] 'agreement among raft nodes before linearized reading' (duration: 247.610784ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:20.212541Z","caller":"traceutil/trace.go:171","msg":"trace[1546628771] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"174.016983ms","start":"2026-04-08T01:22:20.038512Z","end":"2026-04-08T01:22:20.212529Z","steps":["trace[1546628771] 'process raft request' (duration: 172.464178ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:20.21272Z","caller":"traceutil/trace.go:171","msg":"trace[2000668537] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"174.907873ms","start":"2026-04-08T01:22:20.037778Z","end":"2026-04-08T01:22:20.212686Z","steps":["trace[2000668537] 'process raft request' (duration: 172.863378ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:20.212913Z","caller":"traceutil/trace.go:171","msg":"trace[2008434408] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"174.721078ms","start":"2026-04-08T01:22:20.038181Z","end":"2026-04-08T01:22:20.212902Z","steps":["trace[2008434408] 'process raft request' (duration: 172.770555ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:20.213072Z","caller":"traceutil/trace.go:171","msg":"trace[810417309] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"152.861717ms","start":"2026-04-08T01:22:20.060143Z","end":"2026-04-08T01:22:20.213004Z","steps":["trace[810417309] 'process raft request' (duration: 150.877533ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:20.213505Z","caller":"traceutil/trace.go:171","msg":"trace[1358716432] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"174.220317ms","start":"2026-04-08T01:22:20.038066Z","end":"2026-04-08T01:22:20.212286Z","steps":["trace[1358716432] 'process raft request' (duration: 172.833096ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:20.21521Z","caller":"traceutil/trace.go:171","msg":"trace[1509748412] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"174.31993ms","start":"2026-04-08T01:22:20.038154Z","end":"2026-04-08T01:22:20.212474Z","steps":["trace[1509748412] 'process raft request' (duration: 172.777656ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:20.523284Z","caller":"traceutil/trace.go:171","msg":"trace[1095589596] transaction","detail":"{read_only:false; response_revision:55; number_of_response:1; }","duration":"105.560455ms","start":"2026-04-08T01:22:20.417697Z","end":"2026-04-08T01:22:20.523257Z","steps":["trace[1095589596] 'process raft request' (duration: 105.377901ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:20.52333Z","caller":"traceutil/trace.go:171","msg":"trace[1054623879] transaction","detail":"{read_only:false; response_revision:54; number_of_response:1; }","duration":"107.343485ms","start":"2026-04-08T01:22:20.415944Z","end":"2026-04-08T01:22:20.523288Z","steps":["trace[1054623879] 'process raft request' (duration: 17.091737ms)","trace[1054623879] 'compare' (duration: 89.87835ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:22:20.523762Z","caller":"traceutil/trace.go:171","msg":"trace[1750850959] transaction","detail":"{read_only:false; response_revision:56; number_of_response:1; }","duration":"100.559665ms","start":"2026-04-08T01:22:20.423118Z","end":"2026-04-08T01:22:20.523678Z","steps":["trace[1750850959] 'process raft request' (duration: 100.064455ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:21.209317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.280508ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-04-08T01:22:21.209531Z","caller":"traceutil/trace.go:171","msg":"trace[533062185] linearizableReadLoop","detail":"{readStateIndex:76; appliedIndex:75; }","duration":"273.544815ms","start":"2026-04-08T01:22:20.935958Z","end":"2026-04-08T01:22:21.209503Z","steps":["trace[533062185] 'read index received' (duration: 118.026049ms)","trace[533062185] 'applied index is now lower than readState.Index' (duration: 155.516466ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:22:21.209583Z","caller":"traceutil/trace.go:171","msg":"trace[1082299361] transaction","detail":"{read_only:false; response_revision:72; number_of_response:1; }","duration":"442.399434ms","start":"2026-04-08T01:22:20.767153Z","end":"2026-04-08T01:22:21.209553Z","steps":["trace[1082299361] 'process raft request' (duration: 286.891189ms)","trace[1082299361] 'compare' (duration: 154.070473ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:22:21.209698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.729649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-08T01:22:21.209698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:22:20.767139Z","time spent":"442.499576ms","remote":"127.0.0.1:50890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:22:21.209764Z","caller":"traceutil/trace.go:171","msg":"trace[1169038956] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:72; }","duration":"273.826561ms","start":"2026-04-08T01:22:20.935912Z","end":"2026-04-08T01:22:21.209739Z","steps":["trace[1169038956] 'agreement among raft nodes before linearized reading' (duration: 273.733699ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:21.209978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.667646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-08T01:22:21.209999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.833292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-08T01:22:21.210161Z","caller":"traceutil/trace.go:171","msg":"trace[1635223396] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:72; }","duration":"274.052786ms","start":"2026-04-08T01:22:20.93608Z","end":"2026-04-08T01:22:21.210132Z","steps":["trace[1635223396] 'agreement among raft nodes before linearized reading' (duration: 273.78354ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:21.21008Z","caller":"traceutil/trace.go:171","msg":"trace[1025923762] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:72; }","duration":"218.807049ms","start":"2026-04-08T01:22:20.991255Z","end":"2026-04-08T01:22:21.210062Z","steps":["trace[1025923762] 'agreement among raft nodes before linearized reading' (duration: 218.635856ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:21.449017Z","caller":"traceutil/trace.go:171","msg":"trace[1335172212] transaction","detail":"{read_only:false; response_revision:82; number_of_response:1; }","duration":"155.016015ms","start":"2026-04-08T01:22:21.293971Z","end":"2026-04-08T01:22:21.448987Z","steps":["trace[1335172212] 'process raft request' (duration: 154.939583ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:21.449222Z","caller":"traceutil/trace.go:171","msg":"trace[452070860] transaction","detail":"{read_only:false; response_revision:81; number_of_response:1; }","duration":"163.592153ms","start":"2026-04-08T01:22:21.285566Z","end":"2026-04-08T01:22:21.449158Z","steps":["trace[452070860] 'process raft request' (duration: 117.654892ms)","trace[452070860] 'compare' (duration: 45.466841ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:22:21.449261Z","caller":"traceutil/trace.go:171","msg":"trace[1999120772] linearizableReadLoop","detail":"{readStateIndex:86; appliedIndex:85; }","duration":"155.952844ms","start":"2026-04-08T01:22:21.293248Z","end":"2026-04-08T01:22:21.449201Z","steps":["trace[1999120772] 'read index received' (duration: 109.957801ms)","trace[1999120772] 'applied index is now lower than readState.Index' (duration: 45.986043ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:22:21.449581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.304122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/cluster-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-08T01:22:21.449658Z","caller":"traceutil/trace.go:171","msg":"trace[229791023] range","detail":"{range_begin:/registry/clusterroles/cluster-admin; range_end:; response_count:0; response_revision:82; }","duration":"156.426405ms","start":"2026-04-08T01:22:21.293213Z","end":"2026-04-08T01:22:21.44964Z","steps":["trace[229791023] 'agreement among raft nodes before linearized reading' (duration: 156.136619ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:48.479914Z","caller":"traceutil/trace.go:171","msg":"trace[512129365] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"251.255243ms","start":"2026-04-08T01:22:48.228632Z","end":"2026-04-08T01:22:48.479888Z","steps":["trace[512129365] 'process raft request' (duration: 251.030199ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:48.714919Z","caller":"traceutil/trace.go:171","msg":"trace[841112004] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"315.12002ms","start":"2026-04-08T01:22:48.399735Z","end":"2026-04-08T01:22:48.714855Z","steps":["trace[841112004] 'process raft request' (duration: 314.688711ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:48.715013Z","caller":"traceutil/trace.go:171","msg":"trace[1746969696] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"309.955816ms","start":"2026-04-08T01:22:48.404965Z","end":"2026-04-08T01:22:48.714921Z","steps":["trace[1746969696] 'process raft request' (duration: 309.770492ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:48.715055Z","caller":"traceutil/trace.go:171","msg":"trace[1524621405] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"302.555343ms","start":"2026-04-08T01:22:48.412439Z","end":"2026-04-08T01:22:48.714995Z","steps":["trace[1524621405] 'process raft request' (duration: 302.361279ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:48.71522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:22:48.404917Z","time spent":"310.210251ms","remote":"127.0.0.1:35412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T01:22:48.715244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:22:48.412416Z","time spent":"302.730607ms","remote":"127.0.0.1:35412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T01:22:48.71544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:22:48.399704Z","time spent":"315.330434ms","remote":"127.0.0.1:35412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T01:22:48.715489Z","caller":"traceutil/trace.go:171","msg":"trace[336151992] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"301.221774ms","start":"2026-04-08T01:22:48.414255Z","end":"2026-04-08T01:22:48.715477Z","steps":["trace[336151992] 'process raft request' (duration: 300.632191ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:48.715871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:22:48.414248Z","time spent":"301.596303ms","remote":"127.0.0.1:35412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T01:22:48.715598Z","caller":"traceutil/trace.go:171","msg":"trace[1194247463] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"300.856406ms","start":"2026-04-08T01:22:48.414733Z","end":"2026-04-08T01:22:48.715589Z","steps":["trace[1194247463] 'process raft request' (duration: 300.229782ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:48.715959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:22:48.414699Z","time spent":"301.241885ms","remote":"127.0.0.1:35412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T01:22:48.716034Z","caller":"traceutil/trace.go:171","msg":"trace[2026411313] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"298.431883ms","start":"2026-04-08T01:22:48.417591Z","end":"2026-04-08T01:22:48.716023Z","steps":["trace[2026411313] 'process raft request' (duration: 297.426461ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:48.716175Z","caller":"traceutil/trace.go:171","msg":"trace[1139985044] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"294.243371ms","start":"2026-04-08T01:22:48.421925Z","end":"2026-04-08T01:22:48.716169Z","steps":["trace[1139985044] 'process raft request' (duration: 294.050556ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:48.716315Z","caller":"traceutil/trace.go:171","msg":"trace[217562256] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"294.932847ms","start":"2026-04-08T01:22:48.421374Z","end":"2026-04-08T01:22:48.716307Z","steps":["trace[217562256] 'process raft request' (duration: 294.442516ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:48.716388Z","caller":"traceutil/trace.go:171","msg":"trace[1385476908] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"276.343466ms","start":"2026-04-08T01:22:48.440038Z","end":"2026-04-08T01:22:48.716381Z","steps":["trace[1385476908] 'process raft request' (duration: 276.04881ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:48.716449Z","caller":"traceutil/trace.go:171","msg":"trace[1119071478] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"293.509365ms","start":"2026-04-08T01:22:48.422933Z","end":"2026-04-08T01:22:48.716443Z","steps":["trace[1119071478] 'process raft request' (duration: 293.092056ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:48.716504Z","caller":"traceutil/trace.go:171","msg":"trace[528621783] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"265.296463ms","start":"2026-04-08T01:22:48.451202Z","end":"2026-04-08T01:22:48.716498Z","steps":["trace[528621783] 'process raft request' (duration: 264.950965ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:48.716603Z","caller":"traceutil/trace.go:171","msg":"trace[142391587] linearizableReadLoop","detail":"{readStateIndex:539; appliedIndex:526; }","duration":"254.222599ms","start":"2026-04-08T01:22:48.462348Z","end":"2026-04-08T01:22:48.716571Z","steps":["trace[142391587] 'read index received' (duration: 17.495735ms)","trace[142391587] 'applied index is now lower than readState.Index' (duration: 236.725814ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:22:48.716902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.538086ms","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-04-08T01:22:48.716965Z","caller":"traceutil/trace.go:171","msg":"trace[274717400] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:524; }","duration":"254.633678ms","start":"2026-04-08T01:22:48.462312Z","end":"2026-04-08T01:22:48.716946Z","steps":["trace[274717400] 'agreement among raft nodes before linearized reading' (duration: 254.421344ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:48.716972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.791863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-08T01:22:48.717058Z","caller":"traceutil/trace.go:171","msg":"trace[1626984822] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:524; }","duration":"151.947766ms","start":"2026-04-08T01:22:48.565086Z","end":"2026-04-08T01:22:48.717033Z","steps":["trace[1626984822] 'agreement among raft nodes before linearized reading' (duration: 151.678211ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:52.148712Z","caller":"traceutil/trace.go:171","msg":"trace[688305068] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"396.154675ms","start":"2026-04-08T01:22:51.752484Z","end":"2026-04-08T01:22:52.148638Z","steps":["trace[688305068] 'process raft request' (duration: 392.510185ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:52.148899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:22:51.752435Z","time spent":"396.38136ms","remote":"127.0.0.1:35468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036015,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T01:22:52.759526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.926538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T01:22:52.75962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.527892ms","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-04-08T01:22:52.759681Z","caller":"traceutil/trace.go:171","msg":"trace[551045057] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:599; }","duration":"543.100122ms","start":"2026-04-08T01:22:52.216518Z","end":"2026-04-08T01:22:52.759618Z","steps":["trace[551045057] 'range keys from in-memory index tree' (duration: 542.833616ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:52.759799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:22:52.216486Z","time spent":"543.269586ms","remote":"127.0.0.1:35364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-08T01:22:52.759748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.280757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:22:52.760074Z","caller":"traceutil/trace.go:171","msg":"trace[104976688] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:599; }","duration":"548.720647ms","start":"2026-04-08T01:22:52.211328Z","end":"2026-04-08T01:22:52.760048Z","steps":["trace[104976688] 'range keys from in-memory index tree' (duration: 548.104943ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:52.759875Z","caller":"traceutil/trace.go:171","msg":"trace[1458086014] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:599; }","duration":"262.694936ms","start":"2026-04-08T01:22:52.497004Z","end":"2026-04-08T01:22:52.759698Z","steps":["trace[1458086014] 'range keys from in-memory index tree' (duration: 262.329629ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:52.760146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:22:52.211298Z","time spent":"548.834288ms","remote":"127.0.0.1:50614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"info","ts":"2026-04-08T01:22:52.892582Z","caller":"traceutil/trace.go:171","msg":"trace[784517788] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"126.024386ms","start":"2026-04-08T01:22:52.766517Z","end":"2026-04-08T01:22:52.892541Z","steps":["trace[784517788] 'process raft request' (duration: 121.365033ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:52.89273Z","caller":"traceutil/trace.go:171","msg":"trace[1930827014] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"125.540085ms","start":"2026-04-08T01:22:52.767159Z","end":"2026-04-08T01:22:52.892699Z","steps":["trace[1930827014] 'process raft request' (duration: 125.301679ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:52.893712Z","caller":"traceutil/trace.go:171","msg":"trace[79613569] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"126.156109ms","start":"2026-04-08T01:22:52.767542Z","end":"2026-04-08T01:22:52.893698Z","steps":["trace[79613569] 'process raft request' (duration: 125.024204ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:56.451558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.895475ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:22:56.451775Z","caller":"traceutil/trace.go:171","msg":"trace[1201275836] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"700.324075ms","start":"2026-04-08T01:22:55.751427Z","end":"2026-04-08T01:22:56.451751Z","steps":["trace[1201275836] 'process raft request' (duration: 208.127613ms)","trace[1201275836] 'compare' (duration: 491.732702ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:22:56.451876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:22:55.751398Z","time spent":"700.443898ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17126,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:22:56.454185Z","caller":"traceutil/trace.go:171","msg":"trace[41194306] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:647; }","duration":"234.486535ms","start":"2026-04-08T01:22:56.219667Z","end":"2026-04-08T01:22:56.454154Z","steps":["trace[41194306] 'read index received' (duration: 233.486413ms)","trace[41194306] 'applied index is now lower than readState.Index' (duration: 998.742µs)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:22:56.454354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.671619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:22:56.454404Z","caller":"traceutil/trace.go:171","msg":"trace[1152603436] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:626; }","duration":"234.7324ms","start":"2026-04-08T01:22:56.219654Z","end":"2026-04-08T01:22:56.454386Z","steps":["trace[1152603436] 'agreement among raft nodes before linearized reading' (duration: 234.608367ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:56.454651Z","caller":"traceutil/trace.go:171","msg":"trace[1292094435] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"311.973711ms","start":"2026-04-08T01:22:56.142606Z","end":"2026-04-08T01:22:56.45458Z","steps":["trace[1292094435] 'process raft request' (duration: 310.865317ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:56.454967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:22:56.142559Z","time spent":"312.266907ms","remote":"127.0.0.1:35468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T01:22:57.370442Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265020956318239,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-08T01:22:57.471936Z","caller":"traceutil/trace.go:171","msg":"trace[2134253218] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:648; }","duration":"602.499011ms","start":"2026-04-08T01:22:56.869402Z","end":"2026-04-08T01:22:57.471901Z","steps":["trace[2134253218] 'read index received' (duration: 563.624475ms)","trace[2134253218] 'applied index is now lower than readState.Index' (duration: 38.872746ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:22:57.472001Z","caller":"traceutil/trace.go:171","msg":"trace[845367584] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"956.036437ms","start":"2026-04-08T01:22:56.515926Z","end":"2026-04-08T01:22:57.471962Z","steps":["trace[845367584] 'process raft request' (duration: 917.184232ms)","trace[845367584] 'compare' (duration: 38.048958ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:22:57.472153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:22:56.515893Z","time spent":"956.186231ms","remote":"127.0.0.1:50652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T01:22:57.4724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.962401ms","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-04-08T01:22:57.472565Z","caller":"traceutil/trace.go:171","msg":"trace[1225680109] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:627; }","duration":"603.174766ms","start":"2026-04-08T01:22:56.869351Z","end":"2026-04-08T01:22:57.472526Z","steps":["trace[1225680109] 'agreement among raft nodes before linearized reading' (duration: 602.721846ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:57.472608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.362899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-08T01:22:57.47263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:22:56.869329Z","time spent":"603.285187ms","remote":"127.0.0.1:50690","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-04-08T01:22:57.472656Z","caller":"traceutil/trace.go:171","msg":"trace[50737237] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:627; }","duration":"563.480892ms","start":"2026-04-08T01:22:56.909163Z","end":"2026-04-08T01:22:57.472644Z","steps":["trace[50737237] 'agreement among raft nodes before linearized reading' (duration: 563.283918ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:57.472693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:22:56.909132Z","time spent":"563.552603ms","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-08T01:22:57.47273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.090395ms","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-04-08T01:22:57.472792Z","caller":"traceutil/trace.go:171","msg":"trace[719335622] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:627; }","duration":"564.233739ms","start":"2026-04-08T01:22:56.908543Z","end":"2026-04-08T01:22:57.472777Z","steps":["trace[719335622] 'agreement among raft nodes before linearized reading' (duration: 563.555343ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:57.472827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:22:56.908517Z","time spent":"564.301581ms","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-08T01:22:57.47296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.219668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-08T01:22:57.473097Z","caller":"traceutil/trace.go:171","msg":"trace[923312379] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:627; }","duration":"564.419383ms","start":"2026-04-08T01:22:56.908657Z","end":"2026-04-08T01:22:57.473076Z","steps":["trace[923312379] 'agreement among raft nodes before linearized reading' (duration: 564.127287ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:57.473195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:22:56.908629Z","time spent":"564.530135ms","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-08T01:22:59.04569Z","caller":"traceutil/trace.go:171","msg":"trace[12328586] linearizableReadLoop","detail":"{readStateIndex:677; appliedIndex:676; }","duration":"117.321034ms","start":"2026-04-08T01:22:58.928337Z","end":"2026-04-08T01:22:59.045658Z","steps":["trace[12328586] 'read index received' (duration: 116.19523ms)","trace[12328586] 'applied index is now lower than readState.Index' (duration: 1.123334ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:22:59.045759Z","caller":"traceutil/trace.go:171","msg":"trace[1778266943] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"181.918767ms","start":"2026-04-08T01:22:58.863794Z","end":"2026-04-08T01:22:59.045712Z","steps":["trace[1778266943] 'process raft request' (duration: 180.506527ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:59.045996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.592671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:22:59.046178Z","caller":"traceutil/trace.go:171","msg":"trace[808843887] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:654; }","duration":"117.797214ms","start":"2026-04-08T01:22:58.928297Z","end":"2026-04-08T01:22:59.046094Z","steps":["trace[808843887] 'agreement among raft nodes before linearized reading' (duration: 117.504278ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:59.132703Z","caller":"traceutil/trace.go:171","msg":"trace[1899913219] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"160.071606ms","start":"2026-04-08T01:22:58.972605Z","end":"2026-04-08T01:22:59.132677Z","steps":["trace[1899913219] 'process raft request' (duration: 159.840831ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:59.133036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.75474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T01:22:59.133078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.502505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T01:22:59.133099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.65737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:22:59.13315Z","caller":"traceutil/trace.go:171","msg":"trace[457119576] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:655; }","duration":"184.919593ms","start":"2026-04-08T01:22:58.948206Z","end":"2026-04-08T01:22:59.133126Z","steps":["trace[457119576] 'agreement among raft nodes before linearized reading' (duration: 184.615747ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:59.133172Z","caller":"traceutil/trace.go:171","msg":"trace[272046430] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:655; }","duration":"204.707569ms","start":"2026-04-08T01:22:58.928444Z","end":"2026-04-08T01:22:59.133151Z","steps":["trace[272046430] 'agreement among raft nodes before linearized reading' (duration: 204.533105ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:59.133213Z","caller":"traceutil/trace.go:171","msg":"trace[1375404118] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:655; }","duration":"185.824993ms","start":"2026-04-08T01:22:58.947359Z","end":"2026-04-08T01:22:59.133184Z","steps":["trace[1375404118] 'agreement among raft nodes before linearized reading' (duration: 185.486635ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:59.133074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.160808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:22:59.133403Z","caller":"traceutil/trace.go:171","msg":"trace[1581870399] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:655; }","duration":"185.570927ms","start":"2026-04-08T01:22:58.947821Z","end":"2026-04-08T01:22:59.133392Z","steps":["trace[1581870399] 'agreement among raft nodes before linearized reading' (duration: 185.152478ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:23:02.087375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.859454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"} {"level":"info","ts":"2026-04-08T01:23:02.087499Z","caller":"traceutil/trace.go:171","msg":"trace[136328475] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:711; }","duration":"117.047878ms","start":"2026-04-08T01:23:01.970422Z","end":"2026-04-08T01:23:02.08747Z","steps":["trace[136328475] 'range keys from in-memory index tree' (duration: 116.626898ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:23:13.376799Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265020956318599,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-08T01:23:13.508305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:23:12.829626Z","time spent":"678.674616ms","remote":"127.0.0.1:35392","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-08T01:23:13.631011Z","caller":"traceutil/trace.go:171","msg":"trace[1752892365] linearizableReadLoop","detail":"{readStateIndex:817; appliedIndex:815; }","duration":"754.869522ms","start":"2026-04-08T01:23:12.876114Z","end":"2026-04-08T01:23:13.630983Z","steps":["trace[1752892365] 'read index received' (duration: 632.110566ms)","trace[1752892365] 'applied index is now lower than readState.Index' (duration: 122.757856ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:23:13.631249Z","caller":"traceutil/trace.go:171","msg":"trace[1588421781] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"791.685878ms","start":"2026-04-08T01:23:12.839517Z","end":"2026-04-08T01:23:13.631203Z","steps":["trace[1588421781] 'process raft request' (duration: 791.243438ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:23:13.631446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"755.304803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-08T01:23:13.631532Z","caller":"traceutil/trace.go:171","msg":"trace[172223083] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:790; }","duration":"755.451836ms","start":"2026-04-08T01:23:12.876062Z","end":"2026-04-08T01:23:13.631514Z","steps":["trace[172223083] 'agreement among raft nodes before linearized reading' (duration: 755.061558ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:23:13.63159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:23:12.876041Z","time spent":"755.530867ms","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-08T01:23:13.631596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:23:12.839497Z","time spent":"791.901613ms","remote":"127.0.0.1:50652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:23:13.712254Z","caller":"traceutil/trace.go:171","msg":"trace[197655809] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"202.440932ms","start":"2026-04-08T01:23:13.509766Z","end":"2026-04-08T01:23:13.712207Z","steps":["trace[197655809] 'process raft request' (duration: 202.104945ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:23:13.7123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.582651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-08T01:23:13.712516Z","caller":"traceutil/trace.go:171","msg":"trace[1030363008] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:791; }","duration":"102.862137ms","start":"2026-04-08T01:23:13.609635Z","end":"2026-04-08T01:23:13.712497Z","steps":["trace[1030363008] 'agreement among raft nodes before linearized reading' (duration: 102.502908ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:23:20.343113Z","caller":"traceutil/trace.go:171","msg":"trace[127439718] transaction","detail":"{read_only:false; response_revision:861; number_of_response:1; }","duration":"197.509833ms","start":"2026-04-08T01:23:20.145548Z","end":"2026-04-08T01:23:20.343058Z","steps":["trace[127439718] 'process raft request' (duration: 197.217507ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:23:20.343239Z","caller":"traceutil/trace.go:171","msg":"trace[408639659] linearizableReadLoop","detail":"{readStateIndex:889; appliedIndex:888; }","duration":"127.661036ms","start":"2026-04-08T01:23:20.215549Z","end":"2026-04-08T01:23:20.34321Z","steps":["trace[408639659] 'read index received' (duration: 127.173895ms)","trace[408639659] 'applied index is now lower than readState.Index' (duration: 485.491µs)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:23:20.343671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.081436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:23:20.344035Z","caller":"traceutil/trace.go:171","msg":"trace[524491049] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:861; }","duration":"128.555877ms","start":"2026-04-08T01:23:20.21545Z","end":"2026-04-08T01:23:20.344006Z","steps":["trace[524491049] 'agreement among raft nodes before linearized reading' (duration: 128.052536ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:23:34.021014Z","caller":"traceutil/trace.go:171","msg":"trace[1727289903] linearizableReadLoop","detail":"{readStateIndex:985; appliedIndex:984; }","duration":"146.188257ms","start":"2026-04-08T01:23:33.874803Z","end":"2026-04-08T01:23:34.020991Z","steps":["trace[1727289903] 'read index received' (duration: 145.87404ms)","trace[1727289903] 'applied index is now lower than readState.Index' (duration: 313.307µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:23:34.021142Z","caller":"traceutil/trace.go:171","msg":"trace[724024681] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"183.903892ms","start":"2026-04-08T01:23:33.837226Z","end":"2026-04-08T01:23:34.02113Z","steps":["trace[724024681] 'process raft request' (duration: 183.520144ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:23:34.021663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.81003ms","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-04-08T01:23:34.021798Z","caller":"traceutil/trace.go:171","msg":"trace[630152648] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:953; }","duration":"147.007854ms","start":"2026-04-08T01:23:33.874764Z","end":"2026-04-08T01:23:34.021772Z","steps":["trace[630152648] 'agreement among raft nodes before linearized reading' (duration: 146.573634ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:23:34.135009Z","caller":"traceutil/trace.go:171","msg":"trace[61189594] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"108.534893ms","start":"2026-04-08T01:23:34.026445Z","end":"2026-04-08T01:23:34.13498Z","steps":["trace[61189594] 'process raft request' (duration: 108.274257ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:23:34.135044Z","caller":"traceutil/trace.go:171","msg":"trace[990367350] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"107.479211ms","start":"2026-04-08T01:23:34.027531Z","end":"2026-04-08T01:23:34.13501Z","steps":["trace[990367350] 'process raft request' (duration: 107.330358ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:23:34.13516Z","caller":"traceutil/trace.go:171","msg":"trace[1410987789] transaction","detail":"{read_only:false; response_revision:957; number_of_response:1; }","duration":"107.349328ms","start":"2026-04-08T01:23:34.027789Z","end":"2026-04-08T01:23:34.135138Z","steps":["trace[1410987789] 'process raft request' (duration: 107.119593ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:23:49.362023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"859.935079ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-08T01:23:49.362178Z","caller":"traceutil/trace.go:171","msg":"trace[1161216258] linearizableReadLoop","detail":"{readStateIndex:1038; appliedIndex:1037; }","duration":"1.279087428s","start":"2026-04-08T01:23:48.083077Z","end":"2026-04-08T01:23:49.362164Z","steps":["trace[1161216258] 'read index received' (duration: 419.074447ms)","trace[1161216258] 'applied index is now lower than readState.Index' (duration: 860.010261ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:23:49.36235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.279266913s","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-04-08T01:23:49.362386Z","caller":"traceutil/trace.go:171","msg":"trace[315833120] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1002; }","duration":"1.279370085s","start":"2026-04-08T01:23:48.083005Z","end":"2026-04-08T01:23:49.362375Z","steps":["trace[315833120] 'agreement among raft nodes before linearized reading' (duration: 1.279252662s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:23:49.362415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:23:48.082983Z","time spent":"1.279425316s","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-08T01:23:49.36245Z","caller":"traceutil/trace.go:171","msg":"trace[12750877] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"1.181739583s","start":"2026-04-08T01:23:48.180685Z","end":"2026-04-08T01:23:49.362425Z","steps":["trace[12750877] 'process raft request' (duration: 1.181418856s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:23:49.362589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:23:48.180669Z","time spent":"1.181845747s","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T01:23:49.362942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"852.249978ms","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-04-08T01:23:49.363259Z","caller":"traceutil/trace.go:171","msg":"trace[1393716884] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1002; }","duration":"853.18883ms","start":"2026-04-08T01:23:48.510049Z","end":"2026-04-08T01:23:49.363238Z","steps":["trace[1393716884] 'range keys from in-memory index tree' (duration: 852.236818ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:23:49.368529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.179884413s","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-04-08T01:23:49.368598Z","caller":"traceutil/trace.go:171","msg":"trace[1349178191] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1003; }","duration":"1.179991196s","start":"2026-04-08T01:23:48.188589Z","end":"2026-04-08T01:23:49.36858Z","steps":["trace[1349178191] 'agreement among raft nodes before linearized reading' (duration: 1.174015374s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:23:49.368634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.168360138s","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-04-08T01:23:49.368645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.171022287s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-04-08T01:23:49.368646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:23:48.18854Z","time spent":"1.180092578s","remote":"127.0.0.1:50690","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-04-08T01:23:49.368698Z","caller":"traceutil/trace.go:171","msg":"trace[1880458135] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1003; }","duration":"1.16845248s","start":"2026-04-08T01:23:48.200226Z","end":"2026-04-08T01:23:49.368678Z","steps":["trace[1880458135] 'agreement among raft nodes before linearized reading' (duration: 1.162328925s)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:23:49.368724Z","caller":"traceutil/trace.go:171","msg":"trace[1584705767] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1003; }","duration":"1.171135829s","start":"2026-04-08T01:23:48.197549Z","end":"2026-04-08T01:23:49.368685Z","steps":["trace[1584705767] 'agreement among raft nodes before linearized reading' (duration: 1.165045505s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:23:49.36874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.225927653s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-04-08T01:23:49.368768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:23:48.197508Z","time spent":"1.171248282s","remote":"127.0.0.1:50690","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-04-08T01:23:49.368747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:23:48.20021Z","time spent":"1.168524211s","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-08T01:23:49.368783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.724563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:23:49.368814Z","caller":"traceutil/trace.go:171","msg":"trace[2048444766] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1003; }","duration":"1.226051525s","start":"2026-04-08T01:23:48.142744Z","end":"2026-04-08T01:23:49.368795Z","steps":["trace[2048444766] 'agreement among raft nodes before linearized reading' (duration: 1.219638583s)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:23:49.368836Z","caller":"traceutil/trace.go:171","msg":"trace[460748620] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1003; }","duration":"153.807105ms","start":"2026-04-08T01:23:49.215016Z","end":"2026-04-08T01:23:49.368823Z","steps":["trace[460748620] 'agreement among raft nodes before linearized reading' (duration: 147.548367ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:23:49.368857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:23:48.142726Z","time spent":"1.226121957s","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-08T01:23:49.368907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.148494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T01:23:49.368951Z","caller":"traceutil/trace.go:171","msg":"trace[1075000087] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1003; }","duration":"682.231625ms","start":"2026-04-08T01:23:48.686706Z","end":"2026-04-08T01:23:49.368937Z","steps":["trace[1075000087] 'agreement among raft nodes before linearized reading' (duration: 675.878114ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:23:49.369007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:23:48.686651Z","time spent":"682.327907ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":11,"response size":30,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"info","ts":"2026-04-08T01:23:55.649148Z","caller":"traceutil/trace.go:171","msg":"trace[1152407179] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"191.615933ms","start":"2026-04-08T01:23:55.4575Z","end":"2026-04-08T01:23:55.649116Z","steps":["trace[1152407179] 'process raft request' (duration: 187.515511ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:23:55.650092Z","caller":"traceutil/trace.go:171","msg":"trace[228748452] transaction","detail":"{read_only:false; response_revision:1027; number_of_response:1; }","duration":"192.481712ms","start":"2026-04-08T01:23:55.457595Z","end":"2026-04-08T01:23:55.650077Z","steps":["trace[228748452] 'process raft request' (duration: 192.292158ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:23:55.650282Z","caller":"traceutil/trace.go:171","msg":"trace[1342122215] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"192.233386ms","start":"2026-04-08T01:23:55.458011Z","end":"2026-04-08T01:23:55.650244Z","steps":["trace[1342122215] 'process raft request' (duration: 192.022552ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:24:13.979354Z","caller":"traceutil/trace.go:171","msg":"trace[1988702012] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"136.52211ms","start":"2026-04-08T01:24:13.842803Z","end":"2026-04-08T01:24:13.979325Z","steps":["trace[1988702012] 'process raft request' (duration: 118.189453ms)","trace[1988702012] 'compare' (duration: 18.152553ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:24:13.979477Z","caller":"traceutil/trace.go:171","msg":"trace[1936933759] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"136.018709ms","start":"2026-04-08T01:24:13.84343Z","end":"2026-04-08T01:24:13.979449Z","steps":["trace[1936933759] 'process raft request' (duration: 135.853876ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:14.513372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.804735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:24:14.513528Z","caller":"traceutil/trace.go:171","msg":"trace[2039163361] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1088; }","duration":"106.01608ms","start":"2026-04-08T01:24:14.407487Z","end":"2026-04-08T01:24:14.513503Z","steps":["trace[2039163361] 'count revisions from in-memory index tree' (duration: 105.706214ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:14.513564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.404507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:24:14.513688Z","caller":"traceutil/trace.go:171","msg":"trace[2048470109] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1088; }","duration":"298.590821ms","start":"2026-04-08T01:24:14.215078Z","end":"2026-04-08T01:24:14.513669Z","steps":["trace[2048470109] 'range keys from in-memory index tree' (duration: 298.290644ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:24:15.989262Z","caller":"traceutil/trace.go:171","msg":"trace[280974687] linearizableReadLoop","detail":"{readStateIndex:1130; appliedIndex:1129; }","duration":"344.522052ms","start":"2026-04-08T01:24:15.644714Z","end":"2026-04-08T01:24:15.989236Z","steps":["trace[280974687] 'read index received' (duration: 343.660924ms)","trace[280974687] 'applied index is now lower than readState.Index' (duration: 859.758µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:24:15.989359Z","caller":"traceutil/trace.go:171","msg":"trace[203134344] transaction","detail":"{read_only:false; response_revision:1089; number_of_response:1; }","duration":"493.700505ms","start":"2026-04-08T01:24:15.495627Z","end":"2026-04-08T01:24:15.989327Z","steps":["trace[203134344] 'process raft request' (duration: 492.866448ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:15.989547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.729795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-08T01:24:15.989589Z","caller":"traceutil/trace.go:171","msg":"trace[633667423] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1089; }","duration":"286.823837ms","start":"2026-04-08T01:24:15.702755Z","end":"2026-04-08T01:24:15.989579Z","steps":["trace[633667423] 'agreement among raft nodes before linearized reading' (duration: 286.653682ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:15.989665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.933393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-08T01:24:15.989823Z","caller":"traceutil/trace.go:171","msg":"trace[526960004] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1089; }","duration":"345.140627ms","start":"2026-04-08T01:24:15.644657Z","end":"2026-04-08T01:24:15.989798Z","steps":["trace[526960004] 'agreement among raft nodes before linearized reading' (duration: 344.724838ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:15.989909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:15.64463Z","time spent":"345.26701ms","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-08T01:24:15.989906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:15.4956Z","time spent":"493.863809ms","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T01:24:15.989825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.622649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T01:24:15.990025Z","caller":"traceutil/trace.go:171","msg":"trace[800484543] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1089; }","duration":"196.901695ms","start":"2026-04-08T01:24:15.793101Z","end":"2026-04-08T01:24:15.990003Z","steps":["trace[800484543] 'agreement among raft nodes before linearized reading' (duration: 196.538897ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:24:16.52548Z","caller":"traceutil/trace.go:171","msg":"trace[1645023073] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"530.643744ms","start":"2026-04-08T01:24:15.994619Z","end":"2026-04-08T01:24:16.525262Z","steps":["trace[1645023073] 'process raft request' (duration: 499.100992ms)","trace[1645023073] 'compare' (duration: 31.348548ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:24:16.525837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:15.9946Z","time spent":"531.148456ms","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:24:16.53641Z","caller":"traceutil/trace.go:171","msg":"trace[1932492130] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"541.632672ms","start":"2026-04-08T01:24:15.994757Z","end":"2026-04-08T01:24:16.536389Z","steps":["trace[1932492130] 'process raft request' (duration: 541.482328ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:16.536616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:15.994733Z","time spent":"541.731874ms","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:24:16.536761Z","caller":"traceutil/trace.go:171","msg":"trace[2021119187] transaction","detail":"{read_only:false; response_revision:1092; number_of_response:1; }","duration":"541.911238ms","start":"2026-04-08T01:24:15.994757Z","end":"2026-04-08T01:24:16.536668Z","steps":["trace[2021119187] 'process raft request' (duration: 541.57654ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:16.537039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:15.994733Z","time spent":"542.125193ms","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:24:16.537698Z","caller":"traceutil/trace.go:171","msg":"trace[1116220115] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"542.752396ms","start":"2026-04-08T01:24:15.99493Z","end":"2026-04-08T01:24:16.537682Z","steps":["trace[1116220115] 'process raft request' (duration: 541.425938ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:16.537785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:15.994924Z","time spent":"542.819648ms","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:24:16.53824Z","caller":"traceutil/trace.go:171","msg":"trace[1190201602] linearizableReadLoop","detail":"{readStateIndex:1135; appliedIndex:1130; }","duration":"321.915475ms","start":"2026-04-08T01:24:16.216307Z","end":"2026-04-08T01:24:16.538223Z","steps":["trace[1190201602] 'read index received' (duration: 277.362442ms)","trace[1190201602] 'applied index is now lower than readState.Index' (duration: 44.552093ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:24:16.538252Z","caller":"traceutil/trace.go:171","msg":"trace[1507790604] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"542.876668ms","start":"2026-04-08T01:24:15.995361Z","end":"2026-04-08T01:24:16.538238Z","steps":["trace[1507790604] 'process raft request' (duration: 542.770196ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:16.53834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.030837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:24:16.538375Z","caller":"traceutil/trace.go:171","msg":"trace[138886182] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1094; }","duration":"322.110879ms","start":"2026-04-08T01:24:16.216254Z","end":"2026-04-08T01:24:16.538365Z","steps":["trace[138886182] 'agreement among raft nodes before linearized reading' (duration: 322.037507ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:16.538458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:16.216235Z","time spent":"322.212201ms","remote":"127.0.0.1:35364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-08T01:24:16.538521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:15.995343Z","time spent":"542.960249ms","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:24:17.959826Z","caller":"traceutil/trace.go:171","msg":"trace[1222193016] transaction","detail":"{read_only:false; response_revision:1095; number_of_response:1; }","duration":"587.83959ms","start":"2026-04-08T01:24:17.371965Z","end":"2026-04-08T01:24:17.959805Z","steps":["trace[1222193016] 'process raft request' (duration: 587.719907ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:17.960098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:17.371941Z","time spent":"587.948132ms","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:24:18.130819Z","caller":"traceutil/trace.go:171","msg":"trace[1926501702] linearizableReadLoop","detail":"{readStateIndex:1137; appliedIndex:1136; }","duration":"168.998221ms","start":"2026-04-08T01:24:17.961791Z","end":"2026-04-08T01:24:18.130789Z","steps":["trace[1926501702] 'read index received' (duration: 79.481387ms)","trace[1926501702] 'applied index is now lower than readState.Index' (duration: 89.513574ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:24:18.130956Z","caller":"traceutil/trace.go:171","msg":"trace[2008938627] transaction","detail":"{read_only:false; response_revision:1096; number_of_response:1; }","duration":"135.253832ms","start":"2026-04-08T01:24:17.995595Z","end":"2026-04-08T01:24:18.130849Z","steps":["trace[2008938627] 'process raft request' (duration: 135.008557ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:18.170801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.987064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:24:18.17087Z","caller":"traceutil/trace.go:171","msg":"trace[616288672] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1096; }","duration":"209.078446ms","start":"2026-04-08T01:24:17.961776Z","end":"2026-04-08T01:24:18.170855Z","steps":["trace[616288672] 'agreement among raft nodes before linearized reading' (duration: 169.113193ms)","trace[616288672] 'count revisions from in-memory index tree' (duration: 39.82744ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:24:18.815248Z","caller":"traceutil/trace.go:171","msg":"trace[1643859939] linearizableReadLoop","detail":"{readStateIndex:1139; appliedIndex:1138; }","duration":"275.268397ms","start":"2026-04-08T01:24:18.539954Z","end":"2026-04-08T01:24:18.815222Z","steps":["trace[1643859939] 'read index received' (duration: 275.191685ms)","trace[1643859939] 'applied index is now lower than readState.Index' (duration: 74.782µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:24:18.815348Z","caller":"traceutil/trace.go:171","msg":"trace[2078863518] transaction","detail":"{read_only:false; response_revision:1097; number_of_response:1; }","duration":"279.761664ms","start":"2026-04-08T01:24:18.535554Z","end":"2026-04-08T01:24:18.815315Z","steps":["trace[2078863518] 'process raft request' (duration: 279.511078ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:18.815672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.10378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-08T01:24:18.815646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.637685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-08T01:24:18.815716Z","caller":"traceutil/trace.go:171","msg":"trace[1904563500] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1097; }","duration":"273.218382ms","start":"2026-04-08T01:24:18.542487Z","end":"2026-04-08T01:24:18.815705Z","steps":["trace[1904563500] 'agreement among raft nodes before linearized reading' (duration: 273.028088ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:18.815741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.650533ms","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-04-08T01:24:18.815767Z","caller":"traceutil/trace.go:171","msg":"trace[1382742166] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1097; }","duration":"275.811038ms","start":"2026-04-08T01:24:18.539929Z","end":"2026-04-08T01:24:18.81574Z","steps":["trace[1382742166] 'agreement among raft nodes before linearized reading' (duration: 275.42868ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:24:18.815838Z","caller":"traceutil/trace.go:171","msg":"trace[272203742] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1097; }","duration":"274.755835ms","start":"2026-04-08T01:24:18.54106Z","end":"2026-04-08T01:24:18.815816Z","steps":["trace[272203742] 'agreement among raft nodes before linearized reading' (duration: 274.50312ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:18.815802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.684366ms","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-04-08T01:24:18.815941Z","caller":"traceutil/trace.go:171","msg":"trace[9745135] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1097; }","duration":"275.93793ms","start":"2026-04-08T01:24:18.539976Z","end":"2026-04-08T01:24:18.815914Z","steps":["trace[9745135] 'agreement among raft nodes before linearized reading' (duration: 275.569543ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:19.716492Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265020956319298,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-08T01:24:19.991645Z","caller":"traceutil/trace.go:171","msg":"trace[838246148] transaction","detail":"{read_only:false; response_revision:1098; number_of_response:1; }","duration":"1.170737482s","start":"2026-04-08T01:24:18.820884Z","end":"2026-04-08T01:24:19.991621Z","steps":["trace[838246148] 'process raft request' (duration: 1.124147285s)","trace[838246148] 'compare' (duration: 45.977414ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:24:19.991868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:18.820859Z","time spent":"1.170838605s","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:24:20.07738Z","caller":"traceutil/trace.go:171","msg":"trace[1013325456] transaction","detail":"{read_only:false; response_revision:1099; number_of_response:1; }","duration":"1.256221829s","start":"2026-04-08T01:24:18.821128Z","end":"2026-04-08T01:24:20.07735Z","steps":["trace[1013325456] 'process raft request' (duration: 1.255853222s)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:24:20.077651Z","caller":"traceutil/trace.go:171","msg":"trace[1001650988] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"1.256458744s","start":"2026-04-08T01:24:18.821176Z","end":"2026-04-08T01:24:20.077634Z","steps":["trace[1001650988] 'process raft request' (duration: 1.256128277s)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:24:20.077589Z","caller":"traceutil/trace.go:171","msg":"trace[1957823246] linearizableReadLoop","detail":"{readStateIndex:1143; appliedIndex:1139; }","duration":"861.222986ms","start":"2026-04-08T01:24:19.216344Z","end":"2026-04-08T01:24:20.077567Z","steps":["trace[1957823246] 'read index received' (duration: 728.775705ms)","trace[1957823246] 'applied index is now lower than readState.Index' (duration: 132.445611ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:24:20.077742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:18.821142Z","time spent":"1.256558857s","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T01:24:20.077704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:18.821119Z","time spent":"1.256378493s","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:24:20.077838Z","caller":"traceutil/trace.go:171","msg":"trace[1885863667] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"1.255958883s","start":"2026-04-08T01:24:18.821841Z","end":"2026-04-08T01:24:20.0778Z","steps":["trace[1885863667] 'process raft request' (duration: 1.255639106s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:20.077786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"861.42981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:24:20.077969Z","caller":"traceutil/trace.go:171","msg":"trace[186515454] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1101; }","duration":"861.651115ms","start":"2026-04-08T01:24:19.216303Z","end":"2026-04-08T01:24:20.077954Z","steps":["trace[186515454] 'agreement among raft nodes before linearized reading' (duration: 861.433491ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:20.07802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:19.216283Z","time spent":"861.726356ms","remote":"127.0.0.1:35364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-08T01:24:20.078018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:18.821818Z","time spent":"1.256111446s","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T01:24:20.654161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.921693ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:24:20.654325Z","caller":"traceutil/trace.go:171","msg":"trace[1381455865] transaction","detail":"{read_only:false; response_revision:1102; number_of_response:1; }","duration":"517.786986ms","start":"2026-04-08T01:24:20.136491Z","end":"2026-04-08T01:24:20.654278Z","steps":["trace[1381455865] 'process raft request' (duration: 290.66036ms)","trace[1381455865] 'compare' (duration: 226.788059ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:24:20.65443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:20.136466Z","time spent":"517.914338ms","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:24:21.041418Z","caller":"traceutil/trace.go:171","msg":"trace[540887036] transaction","detail":"{read_only:false; response_revision:1103; number_of_response:1; }","duration":"179.159501ms","start":"2026-04-08T01:24:20.862214Z","end":"2026-04-08T01:24:21.041373Z","steps":["trace[540887036] 'process raft request' (duration: 178.64994ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:37.404449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.684286ms","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-04-08T01:24:37.404542Z","caller":"traceutil/trace.go:171","msg":"trace[1278087338] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1215; }","duration":"225.89983ms","start":"2026-04-08T01:24:37.178626Z","end":"2026-04-08T01:24:37.404525Z","steps":["trace[1278087338] 'range keys from in-memory index tree' (duration: 225.523852ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:37.404501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.287422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:24:37.40462Z","caller":"traceutil/trace.go:171","msg":"trace[468557077] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1215; }","duration":"191.458416ms","start":"2026-04-08T01:24:37.21314Z","end":"2026-04-08T01:24:37.404599Z","steps":["trace[468557077] 'range keys from in-memory index tree' (duration: 191.20564ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:24:37.839781Z","caller":"traceutil/trace.go:171","msg":"trace[2144277487] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"430.972031ms","start":"2026-04-08T01:24:37.408755Z","end":"2026-04-08T01:24:37.839727Z","steps":["trace[2144277487] 'process raft request' (duration: 430.801997ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:37.839994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:37.408733Z","time spent":"431.159644ms","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T01:24:39.117769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"843.80403ms","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-04-08T01:24:39.117857Z","caller":"traceutil/trace.go:171","msg":"trace[1526063131] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1217; }","duration":"843.948723ms","start":"2026-04-08T01:24:38.27389Z","end":"2026-04-08T01:24:39.117839Z","steps":["trace[1526063131] 'range keys from in-memory index tree' (duration: 843.601824ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:39.11789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:38.273858Z","time spent":"844.025645ms","remote":"127.0.0.1:50690","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-04-08T01:24:39.117841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"607.491114ms","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-04-08T01:24:39.117979Z","caller":"traceutil/trace.go:171","msg":"trace[1343532817] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1217; }","duration":"607.649847ms","start":"2026-04-08T01:24:38.510305Z","end":"2026-04-08T01:24:39.117955Z","steps":["trace[1343532817] 'range keys from in-memory index tree' (duration: 607.470824ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:39.118252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"903.133912ms","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-04-08T01:24:39.118276Z","caller":"traceutil/trace.go:171","msg":"trace[1565599389] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1217; }","duration":"903.186612ms","start":"2026-04-08T01:24:38.215081Z","end":"2026-04-08T01:24:39.118268Z","steps":["trace[1565599389] 'range keys from in-memory index tree' (duration: 902.988028ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:39.118308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:38.215035Z","time spent":"903.260074ms","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-08T01:24:39.118402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"839.842553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-08T01:24:39.118472Z","caller":"traceutil/trace.go:171","msg":"trace[385485097] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1217; }","duration":"839.965626ms","start":"2026-04-08T01:24:38.278489Z","end":"2026-04-08T01:24:39.118455Z","steps":["trace[385485097] 'range keys from in-memory index tree' (duration: 839.639739ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:39.118506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:38.278465Z","time spent":"840.032587ms","remote":"127.0.0.1:50690","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-04-08T01:24:39.11877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.620397ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:24:39.118827Z","caller":"traceutil/trace.go:171","msg":"trace[569780740] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"675.544584ms","start":"2026-04-08T01:24:38.443272Z","end":"2026-04-08T01:24:39.118817Z","steps":["trace[569780740] 'process raft request' (duration: 528.820925ms)","trace[569780740] 'compare' (duration: 146.068435ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:24:39.118867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:38.443251Z","time spent":"675.593985ms","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T01:24:39.637526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.694306ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:24:39.637645Z","caller":"traceutil/trace.go:171","msg":"trace[273690312] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"785.468519ms","start":"2026-04-08T01:24:38.852142Z","end":"2026-04-08T01:24:39.63761Z","steps":["trace[273690312] 'process raft request' (duration: 384.575908ms)","trace[273690312] 'compare' (duration: 400.586714ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:24:39.637728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:38.852123Z","time spent":"785.56106ms","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:24:39.649921Z","caller":"traceutil/trace.go:171","msg":"trace[85463874] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"527.643438ms","start":"2026-04-08T01:24:39.122258Z","end":"2026-04-08T01:24:39.649901Z","steps":["trace[85463874] 'process raft request' (duration: 527.516906ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:39.650009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:39.122233Z","time spent":"527.739031ms","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:24:39.650196Z","caller":"traceutil/trace.go:171","msg":"trace[1143319093] linearizableReadLoop","detail":"{readStateIndex:1270; appliedIndex:1266; }","duration":"433.956475ms","start":"2026-04-08T01:24:39.216221Z","end":"2026-04-08T01:24:39.650177Z","steps":["trace[1143319093] 'read index received' (duration: 20.593705ms)","trace[1143319093] 'applied index is now lower than readState.Index' (duration: 413.36177ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:24:39.650255Z","caller":"traceutil/trace.go:171","msg":"trace[1819558809] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"526.76248ms","start":"2026-04-08T01:24:39.123479Z","end":"2026-04-08T01:24:39.650241Z","steps":["trace[1819558809] 'process raft request' (duration: 526.605456ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:39.650293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.066577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T01:24:39.650306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:39.123467Z","time spent":"526.81255ms","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:24:39.650316Z","caller":"traceutil/trace.go:171","msg":"trace[1282333841] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1222; }","duration":"434.153809ms","start":"2026-04-08T01:24:39.216154Z","end":"2026-04-08T01:24:39.650307Z","steps":["trace[1282333841] 'agreement among raft nodes before linearized reading' (duration: 434.087578ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:39.650337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:39.216123Z","time spent":"434.209531ms","remote":"127.0.0.1:35364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-08T01:24:39.650341Z","caller":"traceutil/trace.go:171","msg":"trace[230183648] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"527.792572ms","start":"2026-04-08T01:24:39.122528Z","end":"2026-04-08T01:24:39.650321Z","steps":["trace[230183648] 'process raft request' (duration: 527.330461ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:39.650443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:39.122506Z","time spent":"527.875245ms","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:24:53.863998Z","caller":"traceutil/trace.go:171","msg":"trace[727356064] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"126.786719ms","start":"2026-04-08T01:24:53.737185Z","end":"2026-04-08T01:24:53.863972Z","steps":["trace[727356064] 'process raft request' (duration: 126.578624ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:24:54.231619Z","caller":"traceutil/trace.go:171","msg":"trace[1835606271] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"142.593091ms","start":"2026-04-08T01:24:54.089008Z","end":"2026-04-08T01:24:54.231601Z","steps":["trace[1835606271] 'process raft request' (duration: 91.095838ms)","trace[1835606271] 'compare' (duration: 51.287038ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:24:54.275288Z","caller":"traceutil/trace.go:171","msg":"trace[837625513] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"145.425651ms","start":"2026-04-08T01:24:54.129839Z","end":"2026-04-08T01:24:54.275265Z","steps":["trace[837625513] 'process raft request' (duration: 145.296019ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:24:56.240414Z","caller":"traceutil/trace.go:171","msg":"trace[89760127] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"226.238388ms","start":"2026-04-08T01:24:56.014149Z","end":"2026-04-08T01:24:56.240388Z","steps":["trace[89760127] 'process raft request' (duration: 226.065254ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:56.588925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.681516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-08T01:24:56.589004Z","caller":"traceutil/trace.go:171","msg":"trace[919817201] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1292; }","duration":"262.814628ms","start":"2026-04-08T01:24:56.326175Z","end":"2026-04-08T01:24:56.588989Z","steps":["trace[919817201] 'range keys from in-memory index tree' (duration: 262.501422ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:24:56.821329Z","caller":"traceutil/trace.go:171","msg":"trace[1619084502] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"273.256342ms","start":"2026-04-08T01:24:56.548037Z","end":"2026-04-08T01:24:56.821293Z","steps":["trace[1619084502] 'process raft request' (duration: 273.052448ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:24:56.837561Z","caller":"traceutil/trace.go:171","msg":"trace[1950204277] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"243.269685ms","start":"2026-04-08T01:24:56.594252Z","end":"2026-04-08T01:24:56.837521Z","steps":["trace[1950204277] 'process raft request' (duration: 242.503899ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:24:57.365696Z","caller":"traceutil/trace.go:171","msg":"trace[1387297340] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"113.273037ms","start":"2026-04-08T01:24:57.252394Z","end":"2026-04-08T01:24:57.365667Z","steps":["trace[1387297340] 'process raft request' (duration: 113.121333ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:24:57.714Z","caller":"traceutil/trace.go:171","msg":"trace[38393757] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"345.160647ms","start":"2026-04-08T01:24:57.368813Z","end":"2026-04-08T01:24:57.713974Z","steps":["trace[38393757] 'process raft request' (duration: 345.024534ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:57.714142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:57.368795Z","time spent":"345.279079ms","remote":"127.0.0.1:35440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":840,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T01:24:58.598673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"784.839625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:24:58.59877Z","caller":"traceutil/trace.go:171","msg":"trace[1147568369] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1297; }","duration":"785.000469ms","start":"2026-04-08T01:24:57.813748Z","end":"2026-04-08T01:24:58.598748Z","steps":["trace[1147568369] 'count revisions from in-memory index tree' (duration: 784.635741ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:58.598822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:57.813727Z","time spent":"785.082541ms","remote":"127.0.0.1:48834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-04-08T01:24:58.599013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:57.976595Z","time spent":"622.410726ms","remote":"127.0.0.1:36434","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-08T01:24:58.599732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.536254ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:24:58.599871Z","caller":"traceutil/trace.go:171","msg":"trace[1256316058] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"688.879402ms","start":"2026-04-08T01:24:57.910942Z","end":"2026-04-08T01:24:58.599822Z","steps":["trace[1256316058] 'process raft request' (duration: 437.143463ms)","trace[1256316058] 'compare' (duration: 251.098645ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:24:58.599962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:57.910896Z","time spent":"689.021285ms","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:24:58.722779Z","caller":"traceutil/trace.go:171","msg":"trace[675825590] linearizableReadLoop","detail":"{readStateIndex:1350; appliedIndex:1348; }","duration":"771.057457ms","start":"2026-04-08T01:24:57.951704Z","end":"2026-04-08T01:24:58.722762Z","steps":["trace[675825590] 'read index received' (duration: 396.381242ms)","trace[675825590] 'applied index is now lower than readState.Index' (duration: 374.675095ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:24:58.722879Z","caller":"traceutil/trace.go:171","msg":"trace[313680406] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"422.164751ms","start":"2026-04-08T01:24:58.300688Z","end":"2026-04-08T01:24:58.722853Z","steps":["trace[313680406] 'process raft request' (duration: 421.982047ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:58.722993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:58.300662Z","time spent":"422.275683ms","remote":"127.0.0.1:35556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T01:24:58.770964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.616723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T01:24:58.771064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"819.33943ms","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-04-08T01:24:58.771085Z","caller":"traceutil/trace.go:171","msg":"trace[113225068] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1299; }","duration":"555.782167ms","start":"2026-04-08T01:24:58.215265Z","end":"2026-04-08T01:24:58.771047Z","steps":["trace[113225068] 'agreement among raft nodes before linearized reading' (duration: 507.615916ms)","trace[113225068] 'range keys from in-memory index tree' (duration: 48.022848ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:24:58.771136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"773.393658ms","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-04-08T01:24:58.771163Z","caller":"traceutil/trace.go:171","msg":"trace[2020571265] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1299; }","duration":"819.513024ms","start":"2026-04-08T01:24:57.951626Z","end":"2026-04-08T01:24:58.771139Z","steps":["trace[2020571265] 'agreement among raft nodes before linearized reading' (duration: 771.225081ms)","trace[2020571265] 'range keys from in-memory index tree' (duration: 48.025087ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:24:58.771158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:58.21524Z","time spent":"555.906589ms","remote":"127.0.0.1:35364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-08T01:24:58.771201Z","caller":"traceutil/trace.go:171","msg":"trace[662460356] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1299; }","duration":"773.4975ms","start":"2026-04-08T01:24:57.997678Z","end":"2026-04-08T01:24:58.771176Z","steps":["trace[662460356] 'agreement among raft nodes before linearized reading' (duration: 725.206977ms)","trace[662460356] 'range keys from in-memory index tree' (duration: 48.148289ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:24:58.771254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:57.992967Z","time spent":"778.273344ms","remote":"127.0.0.1:50690","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-04-08T01:24:58.771211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:57.951598Z","time spent":"819.602796ms","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-08T01:24:58.771321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"790.876555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-08T01:24:58.771383Z","caller":"traceutil/trace.go:171","msg":"trace[352830289] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1299; }","duration":"790.958607ms","start":"2026-04-08T01:24:57.980403Z","end":"2026-04-08T01:24:58.771361Z","steps":["trace[352830289] 'agreement among raft nodes before linearized reading' (duration: 742.46086ms)","trace[352830289] 'range keys from in-memory index tree' (duration: 48.241602ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:24:58.77143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:57.980387Z","time spent":"791.034519ms","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-08T01:24:58.771065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.370059ms","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-04-08T01:24:58.771511Z","caller":"traceutil/trace.go:171","msg":"trace[1609169129] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1299; }","duration":"525.89743ms","start":"2026-04-08T01:24:58.245594Z","end":"2026-04-08T01:24:58.771491Z","steps":["trace[1609169129] 'agreement among raft nodes before linearized reading' (duration: 477.28223ms)","trace[1609169129] 'range keys from in-memory index tree' (duration: 47.979727ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:24:58.771569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:58.245572Z","time spent":"525.981472ms","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-08T01:25:02.245168Z","caller":"traceutil/trace.go:171","msg":"trace[687550587] transaction","detail":"{read_only:false; response_revision:1338; number_of_response:1; }","duration":"100.42626ms","start":"2026-04-08T01:25:02.144717Z","end":"2026-04-08T01:25:02.245143Z","steps":["trace[687550587] 'process raft request' (duration: 91.62726ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:25:02.865937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.184405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T01:25:02.866051Z","caller":"traceutil/trace.go:171","msg":"trace[139932253] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1346; }","duration":"131.351248ms","start":"2026-04-08T01:25:02.734675Z","end":"2026-04-08T01:25:02.866026Z","steps":["trace[139932253] 'count revisions from in-memory index tree' (duration: 131.069562ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:25:07.767468Z","caller":"traceutil/trace.go:171","msg":"trace[578241884] transaction","detail":"{read_only:false; response_revision:1374; number_of_response:1; }","duration":"249.569452ms","start":"2026-04-08T01:25:07.517868Z","end":"2026-04-08T01:25:07.767438Z","steps":["trace[578241884] 'process raft request' (duration: 249.388329ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:25:08.379832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.177286ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:25:08.380172Z","caller":"traceutil/trace.go:171","msg":"trace[422453542] transaction","detail":"{read_only:false; response_revision:1375; number_of_response:1; }","duration":"605.086592ms","start":"2026-04-08T01:25:07.775009Z","end":"2026-04-08T01:25:08.380095Z","steps":["trace[422453542] 'process raft request' (duration: 110.575509ms)","trace[422453542] 'compare' (duration: 493.920521ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:25:08.380525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:25:07.774991Z","time spent":"605.273566ms","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:25:08.470286Z","caller":"traceutil/trace.go:171","msg":"trace[1819711629] linearizableReadLoop","detail":"{readStateIndex:1429; appliedIndex:1427; }","duration":"254.750063ms","start":"2026-04-08T01:25:08.215509Z","end":"2026-04-08T01:25:08.470259Z","steps":["trace[1819711629] 'read index received' (duration: 29.271µs)","trace[1819711629] 'applied index is now lower than readState.Index' (duration: 254.719452ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:25:08.470539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.021179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:25:08.47061Z","caller":"traceutil/trace.go:171","msg":"trace[1115626688] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1375; }","duration":"255.147053ms","start":"2026-04-08T01:25:08.215452Z","end":"2026-04-08T01:25:08.470599Z","steps":["trace[1115626688] 'agreement among raft nodes before linearized reading' (duration: 254.98803ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:25:08.47062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.35772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T01:25:08.470657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.164292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-04-08T01:25:08.470686Z","caller":"traceutil/trace.go:171","msg":"trace[1013619665] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1375; }","duration":"107.466062ms","start":"2026-04-08T01:25:08.363202Z","end":"2026-04-08T01:25:08.470668Z","steps":["trace[1013619665] 'agreement among raft nodes before linearized reading' (duration: 107.36034ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:25:08.470731Z","caller":"traceutil/trace.go:171","msg":"trace[790524695] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1375; }","duration":"142.281513ms","start":"2026-04-08T01:25:08.328436Z","end":"2026-04-08T01:25:08.470718Z","steps":["trace[790524695] 'agreement among raft nodes before linearized reading' (duration: 142.0966ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:25:16.582845Z","caller":"traceutil/trace.go:171","msg":"trace[844749392] transaction","detail":"{read_only:false; response_revision:1415; number_of_response:1; }","duration":"103.157933ms","start":"2026-04-08T01:25:16.479648Z","end":"2026-04-08T01:25:16.582806Z","steps":["trace[844749392] 'process raft request' (duration: 96.099136ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:25:41.784452Z","caller":"traceutil/trace.go:171","msg":"trace[320465842] transaction","detail":"{read_only:false; response_revision:1546; number_of_response:1; }","duration":"116.096533ms","start":"2026-04-08T01:25:41.668319Z","end":"2026-04-08T01:25:41.784416Z","steps":["trace[320465842] 'process raft request' (duration: 108.814919ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:27:21.341606Z","caller":"traceutil/trace.go:171","msg":"trace[119301151] transaction","detail":"{read_only:false; response_revision:2047; number_of_response:1; }","duration":"135.155625ms","start":"2026-04-08T01:27:21.20643Z","end":"2026-04-08T01:27:21.341585Z","steps":["trace[119301151] 'process raft request' (duration: 134.986061ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:28:22.459404Z","caller":"traceutil/trace.go:171","msg":"trace[1020919005] linearizableReadLoop","detail":"{readStateIndex:2479; appliedIndex:2478; }","duration":"243.9224ms","start":"2026-04-08T01:28:22.215465Z","end":"2026-04-08T01:28:22.459388Z","steps":["trace[1020919005] 'read index received' (duration: 243.849658ms)","trace[1020919005] 'applied index is now lower than readState.Index' (duration: 71.762µs)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:28:22.459542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.076094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:28:22.459525Z","caller":"traceutil/trace.go:171","msg":"trace[1464531641] transaction","detail":"{read_only:false; response_revision:2386; number_of_response:1; }","duration":"340.205844ms","start":"2026-04-08T01:28:22.119289Z","end":"2026-04-08T01:28:22.459495Z","steps":["trace[1464531641] 'process raft request' (duration: 339.987539ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:28:22.459649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.661751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-08T01:28:22.459663Z","caller":"traceutil/trace.go:171","msg":"trace[1998373356] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2386; }","duration":"196.721383ms","start":"2026-04-08T01:28:22.262938Z","end":"2026-04-08T01:28:22.459659Z","steps":["trace[1998373356] 'agreement among raft nodes before linearized reading' (duration: 196.648431ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:28:22.459673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:28:22.119267Z","time spent":"340.327957ms","remote":"127.0.0.1:50690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T01:28:22.459714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.100326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-08T01:28:22.459785Z","caller":"traceutil/trace.go:171","msg":"trace[2063263458] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2386; }","duration":"220.227209ms","start":"2026-04-08T01:28:22.239544Z","end":"2026-04-08T01:28:22.459771Z","steps":["trace[2063263458] 'agreement among raft nodes before linearized reading' (duration: 220.020365ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:28:22.459795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.840689ms","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-04-08T01:28:22.459835Z","caller":"traceutil/trace.go:171","msg":"trace[1888769992] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2386; }","duration":"218.91397ms","start":"2026-04-08T01:28:22.240908Z","end":"2026-04-08T01:28:22.459822Z","steps":["trace[1888769992] 'agreement among raft nodes before linearized reading' (duration: 218.819817ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:28:22.459671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.961142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T01:28:22.459885Z","caller":"traceutil/trace.go:171","msg":"trace[1143449217] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:2386; }","duration":"161.240259ms","start":"2026-04-08T01:28:22.298635Z","end":"2026-04-08T01:28:22.459875Z","steps":["trace[1143449217] 'agreement among raft nodes before linearized reading' (duration: 160.959032ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:28:22.459566Z","caller":"traceutil/trace.go:171","msg":"trace[1491146557] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2386; }","duration":"244.119385ms","start":"2026-04-08T01:28:22.215441Z","end":"2026-04-08T01:28:22.45956Z","steps":["trace[1491146557] 'agreement among raft nodes before linearized reading' (duration: 244.044813ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:28:22.459909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.804802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-08T01:28:22.459982Z","caller":"traceutil/trace.go:171","msg":"trace[1037643304] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2386; }","duration":"199.916245ms","start":"2026-04-08T01:28:22.260047Z","end":"2026-04-08T01:28:22.459964Z","steps":["trace[1037643304] 'agreement among raft nodes before linearized reading' (duration: 199.618368ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:28:22.459969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.987623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-04-08T01:28:22.460366Z","caller":"traceutil/trace.go:171","msg":"trace[212042873] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2386; }","duration":"194.341091ms","start":"2026-04-08T01:28:22.265828Z","end":"2026-04-08T01:28:22.460169Z","steps":["trace[212042873] 'agreement among raft nodes before linearized reading' (duration: 193.847259ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:28:42.794576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.901856ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:28:42.79467Z","caller":"traceutil/trace.go:171","msg":"trace[2015186125] linearizableReadLoop","detail":"{readStateIndex:2598; appliedIndex:2597; }","duration":"149.787229ms","start":"2026-04-08T01:28:42.644868Z","end":"2026-04-08T01:28:42.794655Z","steps":["trace[2015186125] 'read index received' (duration: 43.74274ms)","trace[2015186125] 'applied index is now lower than readState.Index' (duration: 106.043219ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:28:42.794808Z","caller":"traceutil/trace.go:171","msg":"trace[739189205] transaction","detail":"{read_only:false; response_revision:2500; number_of_response:1; }","duration":"157.363366ms","start":"2026-04-08T01:28:42.637405Z","end":"2026-04-08T01:28:42.794769Z","steps":["trace[739189205] 'process raft request' (duration: 51.198765ms)","trace[739189205] 'compare' (duration: 105.813314ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:28:42.794857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.990033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-08T01:28:42.794889Z","caller":"traceutil/trace.go:171","msg":"trace[20526831] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2500; }","duration":"150.052115ms","start":"2026-04-08T01:28:42.644828Z","end":"2026-04-08T01:28:42.79488Z","steps":["trace[20526831] 'agreement among raft nodes before linearized reading' (duration: 149.936532ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:28:42.794888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.394126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-node-lease/\" range_end:\"/registry/pods/kube-node-lease0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:28:42.794942Z","caller":"traceutil/trace.go:171","msg":"trace[1408007916] range","detail":"{range_begin:/registry/pods/kube-node-lease/; range_end:/registry/pods/kube-node-lease0; response_count:0; response_revision:2500; }","duration":"138.478628ms","start":"2026-04-08T01:28:42.656446Z","end":"2026-04-08T01:28:42.794925Z","steps":["trace[1408007916] 'agreement among raft nodes before linearized reading' (duration: 138.386676ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:28:42.795066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.10103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/envoy-rate-limit\" ","response":"range_response_count:1 size:4456"} {"level":"info","ts":"2026-04-08T01:28:42.795115Z","caller":"traceutil/trace.go:171","msg":"trace[671972510] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/envoy-rate-limit; range_end:; response_count:1; response_revision:2500; }","duration":"133.166931ms","start":"2026-04-08T01:28:42.661933Z","end":"2026-04-08T01:28:42.795099Z","steps":["trace[671972510] 'agreement among raft nodes before linearized reading' (duration: 133.019046ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:28:42.967592Z","caller":"traceutil/trace.go:171","msg":"trace[1935479875] transaction","detail":"{read_only:false; response_revision:2503; number_of_response:1; }","duration":"112.79927ms","start":"2026-04-08T01:28:42.854761Z","end":"2026-04-08T01:28:42.967561Z","steps":["trace[1935479875] 'process raft request' (duration: 53.22479ms)","trace[1935479875] 'compare' (duration: 59.456237ms)"],"step_count":2}