{"level":"warn","ts":"2026-05-26T07:32:01.606316Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-26T07:32:01.606411Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.223:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.223:2380","--initial-cluster=instance=https://199.19.213.223:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.223:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.223: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-05-26T07:32:01.606488Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-26T07:32:01.6065Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.223:2380"]} {"level":"info","ts":"2026-05-26T07:32:01.606522Z","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-05-26T07:32:01.607393Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.223:2379"]} {"level":"info","ts":"2026-05-26T07:32:01.607479Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.223:2380"],"listen-peer-urls":["https://199.19.213.223:2380"],"advertise-client-urls":["https://199.19.213.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.223: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-05-26T07:32:01.611997Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.224663ms"} {"level":"info","ts":"2026-05-26T07:32:01.622297Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"12dd93b2fab6fcb","cluster-id":"8ac3bdb9c2c26b53"} {"level":"info","ts":"2026-05-26T07:32:01.622389Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"12dd93b2fab6fcb switched to configuration voters=()"} {"level":"info","ts":"2026-05-26T07:32:01.622413Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"12dd93b2fab6fcb became follower at term 0"} {"level":"info","ts":"2026-05-26T07:32:01.622426Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 12dd93b2fab6fcb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-26T07:32:01.622436Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"12dd93b2fab6fcb became follower at term 1"} {"level":"info","ts":"2026-05-26T07:32:01.622473Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"12dd93b2fab6fcb switched to configuration voters=(84962816215969739)"} {"level":"warn","ts":"2026-05-26T07:32:01.635111Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-26T07:32:01.637928Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-26T07:32:01.639691Z","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-05-26T07:32:01.642077Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"12dd93b2fab6fcb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-26T07:32:01.642194Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"12dd93b2fab6fcb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-26T07:32:01.642251Z","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-05-26T07:32:01.64237Z","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-05-26T07:32:01.642384Z","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-05-26T07:32:01.644291Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"12dd93b2fab6fcb switched to configuration voters=(84962816215969739)"} {"level":"info","ts":"2026-05-26T07:32:01.645439Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8ac3bdb9c2c26b53","local-member-id":"12dd93b2fab6fcb","added-peer-id":"12dd93b2fab6fcb","added-peer-peer-urls":["https://199.19.213.223:2380"]} {"level":"info","ts":"2026-05-26T07:32:01.646575Z","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-05-26T07:32:01.646851Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"12dd93b2fab6fcb","initial-advertise-peer-urls":["https://199.19.213.223:2380"],"listen-peer-urls":["https://199.19.213.223:2380"],"advertise-client-urls":["https://199.19.213.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-26T07:32:01.646902Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-26T07:32:01.647212Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.223:2380"} {"level":"info","ts":"2026-05-26T07:32:01.647228Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.223:2380"} {"level":"info","ts":"2026-05-26T07:32:02.223853Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"12dd93b2fab6fcb is starting a new election at term 1"} {"level":"info","ts":"2026-05-26T07:32:02.224041Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"12dd93b2fab6fcb became pre-candidate at term 1"} {"level":"info","ts":"2026-05-26T07:32:02.224106Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"12dd93b2fab6fcb received MsgPreVoteResp from 12dd93b2fab6fcb at term 1"} {"level":"info","ts":"2026-05-26T07:32:02.224198Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"12dd93b2fab6fcb became candidate at term 2"} {"level":"info","ts":"2026-05-26T07:32:02.224234Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"12dd93b2fab6fcb received MsgVoteResp from 12dd93b2fab6fcb at term 2"} {"level":"info","ts":"2026-05-26T07:32:02.224288Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"12dd93b2fab6fcb became leader at term 2"} {"level":"info","ts":"2026-05-26T07:32:02.22434Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 12dd93b2fab6fcb elected leader 12dd93b2fab6fcb at term 2"} {"level":"info","ts":"2026-05-26T07:32:02.262938Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T07:32:02.267493Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"12dd93b2fab6fcb","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.223:2379]}","request-path":"/0/members/12dd93b2fab6fcb/attributes","cluster-id":"8ac3bdb9c2c26b53","publish-timeout":"7s"} {"level":"info","ts":"2026-05-26T07:32:02.267602Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-26T07:32:02.267951Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-26T07:32:02.268005Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-26T07:32:02.268199Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-26T07:32:02.268528Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8ac3bdb9c2c26b53","local-member-id":"12dd93b2fab6fcb","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T07:32:02.268657Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T07:32:02.268688Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T07:32:02.270182Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.223:2379"} {"level":"info","ts":"2026-05-26T07:32:02.27785Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-26T07:32:03.899683Z","caller":"traceutil/trace.go:171","msg":"trace[695539216] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"230.425076ms","start":"2026-05-26T07:32:03.669229Z","end":"2026-05-26T07:32:03.899654Z","steps":["trace[695539216] 'process raft request' (duration: 230.240441ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:03.899747Z","caller":"traceutil/trace.go:171","msg":"trace[1870226086] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"230.307313ms","start":"2026-05-26T07:32:03.669405Z","end":"2026-05-26T07:32:03.899713Z","steps":["trace[1870226086] 'process raft request' (duration: 230.155979ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:03.899817Z","caller":"traceutil/trace.go:171","msg":"trace[500979736] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:6; }","duration":"144.926247ms","start":"2026-05-26T07:32:03.754872Z","end":"2026-05-26T07:32:03.899798Z","steps":["trace[500979736] 'read index received' (duration: 144.529138ms)","trace[500979736] 'applied index is now lower than readState.Index' (duration: 396.269µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T07:32:03.900041Z","caller":"traceutil/trace.go:171","msg":"trace[264138815] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"230.57201ms","start":"2026-05-26T07:32:03.669456Z","end":"2026-05-26T07:32:03.900028Z","steps":["trace[264138815] 'process raft request' (duration: 230.14877ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:03.900833Z","caller":"traceutil/trace.go:171","msg":"trace[1954095006] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"231.00249ms","start":"2026-05-26T07:32:03.669656Z","end":"2026-05-26T07:32:03.900658Z","steps":["trace[1954095006] 'process raft request' (duration: 230.016706ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:03.90083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.887405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"info","ts":"2026-05-26T07:32:03.900963Z","caller":"traceutil/trace.go:171","msg":"trace[1090492189] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"233.0468ms","start":"2026-05-26T07:32:03.667883Z","end":"2026-05-26T07:32:03.90093Z","steps":["trace[1090492189] 'agreement among raft nodes before linearized reading' (duration: 232.000584ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:03.900708Z","caller":"traceutil/trace.go:171","msg":"trace[1715544156] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"215.7419ms","start":"2026-05-26T07:32:03.684604Z","end":"2026-05-26T07:32:03.900345Z","steps":["trace[1715544156] 'process raft request' (duration: 215.167717ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:03.901178Z","caller":"traceutil/trace.go:171","msg":"trace[1506608244] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"231.464671ms","start":"2026-05-26T07:32:03.6695Z","end":"2026-05-26T07:32:03.900965Z","steps":["trace[1506608244] 'process raft request' (duration: 230.139349ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:03.901564Z","caller":"traceutil/trace.go:171","msg":"trace[614424776] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"231.341239ms","start":"2026-05-26T07:32:03.670206Z","end":"2026-05-26T07:32:03.901547Z","steps":["trace[614424776] 'process raft request' (duration: 229.501344ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:03.903278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.989787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-26T07:32:03.906331Z","caller":"traceutil/trace.go:171","msg":"trace[2063803511] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:11; }","duration":"238.104232ms","start":"2026-05-26T07:32:03.668205Z","end":"2026-05-26T07:32:03.906309Z","steps":["trace[2063803511] 'agreement among raft nodes before linearized reading' (duration: 234.30022ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:03.901527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.476993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-26T07:32:03.90398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.585799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-26T07:32:03.90421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.268638ms","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-05-26T07:32:03.904256Z","caller":"traceutil/trace.go:171","msg":"trace[1824941135] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"222.921744ms","start":"2026-05-26T07:32:03.68109Z","end":"2026-05-26T07:32:03.904012Z","steps":["trace[1824941135] 'process raft request' (duration: 218.642361ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:03.904268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.881344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-26T07:32:03.906004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.425591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-26T07:32:03.906869Z","caller":"traceutil/trace.go:171","msg":"trace[402169766] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"168.308913ms","start":"2026-05-26T07:32:03.738532Z","end":"2026-05-26T07:32:03.906841Z","steps":["trace[402169766] 'agreement among raft nodes before linearized reading' (duration: 161.462027ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:03.906876Z","caller":"traceutil/trace.go:171","msg":"trace[578534925] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:11; }","duration":"172.868372ms","start":"2026-05-26T07:32:03.733963Z","end":"2026-05-26T07:32:03.906832Z","steps":["trace[578534925] 'agreement among raft nodes before linearized reading' (duration: 167.119323ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:03.906572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.157742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-26T07:32:03.906963Z","caller":"traceutil/trace.go:171","msg":"trace[495825949] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"183.572522ms","start":"2026-05-26T07:32:03.72336Z","end":"2026-05-26T07:32:03.906933Z","steps":["trace[495825949] 'agreement among raft nodes before linearized reading' (duration: 180.447296ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:03.906912Z","caller":"traceutil/trace.go:171","msg":"trace[957385921] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"238.991083ms","start":"2026-05-26T07:32:03.667901Z","end":"2026-05-26T07:32:03.906892Z","steps":["trace[957385921] 'agreement among raft nodes before linearized reading' (duration: 236.268207ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:03.907146Z","caller":"traceutil/trace.go:171","msg":"trace[382634367] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"187.65104ms","start":"2026-05-26T07:32:03.719331Z","end":"2026-05-26T07:32:03.906982Z","steps":["trace[382634367] 'agreement among raft nodes before linearized reading' (duration: 184.612927ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:03.907122Z","caller":"traceutil/trace.go:171","msg":"trace[749307784] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"183.628253ms","start":"2026-05-26T07:32:03.723368Z","end":"2026-05-26T07:32:03.906996Z","steps":["trace[749307784] 'agreement among raft nodes before linearized reading' (duration: 176.605083ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:09.932753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"870.318315ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-26T07:32:09.932855Z","caller":"traceutil/trace.go:171","msg":"trace[1798977745] linearizableReadLoop","detail":"{readStateIndex:331; appliedIndex:330; }","duration":"405.747591ms","start":"2026-05-26T07:32:09.527093Z","end":"2026-05-26T07:32:09.93284Z","steps":["trace[1798977745] 'read index received' (duration: 86.022µs)","trace[1798977745] 'applied index is now lower than readState.Index' (duration: 405.660319ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T07:32:09.932934Z","caller":"traceutil/trace.go:171","msg":"trace[2064946037] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"1.068940258s","start":"2026-05-26T07:32:08.863924Z","end":"2026-05-26T07:32:09.932864Z","steps":["trace[2064946037] 'process raft request' (duration: 198.04194ms)","trace[2064946037] 'compare' (duration: 870.18499ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T07:32:09.932993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.915095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-26T07:32:09.933023Z","caller":"traceutil/trace.go:171","msg":"trace[407476379] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:317; }","duration":"406.025247ms","start":"2026-05-26T07:32:09.526989Z","end":"2026-05-26T07:32:09.933014Z","steps":["trace[407476379] 'agreement among raft nodes before linearized reading' (duration: 405.941985ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:09.933052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.806768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-26T07:32:09.933112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:08.863903Z","time spent":"1.069124522s","remote":"127.0.0.1:51480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":201,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T07:32:09.933143Z","caller":"traceutil/trace.go:171","msg":"trace[1821302922] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:317; }","duration":"112.943681ms","start":"2026-05-26T07:32:09.820178Z","end":"2026-05-26T07:32:09.933122Z","steps":["trace[1821302922] 'agreement among raft nodes before linearized reading' (duration: 112.780157ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:09.933068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:09.526949Z","time spent":"406.111579ms","remote":"127.0.0.1:51566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-26T07:32:10.850827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.901757ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T07:32:10.851141Z","caller":"traceutil/trace.go:171","msg":"trace[1935178573] linearizableReadLoop","detail":"{readStateIndex:333; appliedIndex:331; }","duration":"911.704352ms","start":"2026-05-26T07:32:09.939419Z","end":"2026-05-26T07:32:10.851123Z","steps":["trace[1935178573] 'read index received' (duration: 461.320584ms)","trace[1935178573] 'applied index is now lower than readState.Index' (duration: 450.382788ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T07:32:10.851269Z","caller":"traceutil/trace.go:171","msg":"trace[1802185768] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"913.864045ms","start":"2026-05-26T07:32:09.937394Z","end":"2026-05-26T07:32:10.851258Z","steps":["trace[1802185768] 'process raft request' (duration: 913.66603ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:10.851396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:09.937374Z","time spent":"913.957177ms","remote":"127.0.0.1:51566","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-05-26T07:32:10.851552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"830.98044ms","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-05-26T07:32:10.851395Z","caller":"traceutil/trace.go:171","msg":"trace[952206304] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"914.441848ms","start":"2026-05-26T07:32:09.93692Z","end":"2026-05-26T07:32:10.851361Z","steps":["trace[952206304] 'process raft request' (duration: 463.808113ms)","trace[952206304] 'compare' (duration: 449.58202ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T07:32:10.85161Z","caller":"traceutil/trace.go:171","msg":"trace[1097407294] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:319; }","duration":"831.057522ms","start":"2026-05-26T07:32:10.020541Z","end":"2026-05-26T07:32:10.851599Z","steps":["trace[1097407294] 'agreement among raft nodes before linearized reading' (duration: 830.932799ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:10.851651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:10.020499Z","time spent":"831.144144ms","remote":"127.0.0.1:51566","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-05-26T07:32:10.851661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:09.936899Z","time spent":"914.730486ms","remote":"127.0.0.1:51566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T07:32:10.851869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"912.45424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-05-26T07:32:10.851906Z","caller":"traceutil/trace.go:171","msg":"trace[782799556] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:319; }","duration":"912.513672ms","start":"2026-05-26T07:32:09.939383Z","end":"2026-05-26T07:32:10.851897Z","steps":["trace[782799556] 'agreement among raft nodes before linearized reading' (duration: 912.453581ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:10.85194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:09.939372Z","time spent":"912.559253ms","remote":"127.0.0.1:51480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":239,"request content":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" "} {"level":"warn","ts":"2026-05-26T07:32:10.851936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.181036ms","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-05-26T07:32:10.852039Z","caller":"traceutil/trace.go:171","msg":"trace[1017611326] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:319; }","duration":"599.32621ms","start":"2026-05-26T07:32:10.25269Z","end":"2026-05-26T07:32:10.852016Z","steps":["trace[1017611326] 'agreement among raft nodes before linearized reading' (duration: 599.144616ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:10.852099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:10.25267Z","time spent":"599.417092ms","remote":"127.0.0.1:51566","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":"info","ts":"2026-05-26T07:32:28.33259Z","caller":"traceutil/trace.go:171","msg":"trace[1167753834] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"192.790411ms","start":"2026-05-26T07:32:28.139768Z","end":"2026-05-26T07:32:28.332559Z","steps":["trace[1167753834] 'process raft request' (duration: 192.564765ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:28.548442Z","caller":"traceutil/trace.go:171","msg":"trace[2014935807] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"398.266496ms","start":"2026-05-26T07:32:28.150152Z","end":"2026-05-26T07:32:28.548418Z","steps":["trace[2014935807] 'process raft request' (duration: 398.01669ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:28.548497Z","caller":"traceutil/trace.go:171","msg":"trace[2115335543] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"406.33423ms","start":"2026-05-26T07:32:28.142105Z","end":"2026-05-26T07:32:28.548439Z","steps":["trace[2115335543] 'process raft request' (duration: 405.560762ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:28.548584Z","caller":"traceutil/trace.go:171","msg":"trace[2093279466] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"399.908426ms","start":"2026-05-26T07:32:28.148643Z","end":"2026-05-26T07:32:28.548552Z","steps":["trace[2093279466] 'process raft request' (duration: 399.456925ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:28.548614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:28.150145Z","time spent":"398.41165ms","remote":"127.0.0.1:51306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T07:32:28.548654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:28.142098Z","time spent":"406.482385ms","remote":"127.0.0.1:51306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T07:32:28.548792Z","caller":"traceutil/trace.go:171","msg":"trace[1049186533] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"398.583154ms","start":"2026-05-26T07:32:28.150192Z","end":"2026-05-26T07:32:28.548775Z","steps":["trace[1049186533] 'process raft request' (duration: 398.057831ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:28.548786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:28.148633Z","time spent":"400.027639ms","remote":"127.0.0.1:51306","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-05-26T07:32:28.548853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:28.150189Z","time spent":"398.633175ms","remote":"127.0.0.1:51306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T07:32:28.548902Z","caller":"traceutil/trace.go:171","msg":"trace[1831037203] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"392.057866ms","start":"2026-05-26T07:32:28.156795Z","end":"2026-05-26T07:32:28.548853Z","steps":["trace[1831037203] 'process raft request' (duration: 391.490583ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:28.549045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:28.156785Z","time spent":"392.171759ms","remote":"127.0.0.1:51306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T07:32:28.549144Z","caller":"traceutil/trace.go:171","msg":"trace[773131039] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"392.254791ms","start":"2026-05-26T07:32:28.156835Z","end":"2026-05-26T07:32:28.54909Z","steps":["trace[773131039] 'process raft request' (duration: 391.489813ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:28.549289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:28.156832Z","time spent":"392.387154ms","remote":"127.0.0.1:51306","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-05-26T07:32:28.549582Z","caller":"traceutil/trace.go:171","msg":"trace[1870008366] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"362.947714ms","start":"2026-05-26T07:32:28.18656Z","end":"2026-05-26T07:32:28.549507Z","steps":["trace[1870008366] 'process raft request' (duration: 362.695848ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:28.549697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:28.186541Z","time spent":"363.104409ms","remote":"127.0.0.1:51306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T07:32:28.549842Z","caller":"traceutil/trace.go:171","msg":"trace[1460322261] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"389.463224ms","start":"2026-05-26T07:32:28.160356Z","end":"2026-05-26T07:32:28.549819Z","steps":["trace[1460322261] 'process raft request' (duration: 388.639984ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:28.549922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:28.160346Z","time spent":"389.546116ms","remote":"127.0.0.1:51306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T07:32:28.54953Z","caller":"traceutil/trace.go:171","msg":"trace[1079148565] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"379.75541ms","start":"2026-05-26T07:32:28.169736Z","end":"2026-05-26T07:32:28.549491Z","steps":["trace[1079148565] 'process raft request' (duration: 379.405181ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:28.550002Z","caller":"traceutil/trace.go:171","msg":"trace[1685471084] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"337.550202ms","start":"2026-05-26T07:32:28.212419Z","end":"2026-05-26T07:32:28.549969Z","steps":["trace[1685471084] 'process raft request' (duration: 336.891837ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:28.550073Z","caller":"traceutil/trace.go:171","msg":"trace[430515607] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"246.716782ms","start":"2026-05-26T07:32:28.303337Z","end":"2026-05-26T07:32:28.550054Z","steps":["trace[430515607] 'process raft request' (duration: 246.526587ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:28.550133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:28.169725Z","time spent":"380.308803ms","remote":"127.0.0.1:51306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T07:32:28.550461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:28.212325Z","time spent":"337.728387ms","remote":"127.0.0.1:51306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T07:32:28.552295Z","caller":"traceutil/trace.go:171","msg":"trace[1330564598] transaction","detail":"{read_only:false; number_of_response:1; response_revision:513; }","duration":"212.283551ms","start":"2026-05-26T07:32:28.339989Z","end":"2026-05-26T07:32:28.552272Z","steps":["trace[1330564598] 'process raft request' (duration: 212.23829ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:28.552717Z","caller":"traceutil/trace.go:171","msg":"trace[1629070104] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"214.272369ms","start":"2026-05-26T07:32:28.338354Z","end":"2026-05-26T07:32:28.552626Z","steps":["trace[1629070104] 'process raft request' (duration: 213.593452ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:28.552938Z","caller":"traceutil/trace.go:171","msg":"trace[771375926] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"213.362037ms","start":"2026-05-26T07:32:28.339567Z","end":"2026-05-26T07:32:28.552929Z","steps":["trace[771375926] 'process raft request' (duration: 212.545487ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:28.862644Z","caller":"traceutil/trace.go:171","msg":"trace[1396647696] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"107.465381ms","start":"2026-05-26T07:32:28.755148Z","end":"2026-05-26T07:32:28.862614Z","steps":["trace[1396647696] 'process raft request' (duration: 11.381774ms)","trace[1396647696] 'compare' (duration: 95.940343ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T07:32:29.337894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.035712ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-26T07:32:29.338019Z","caller":"traceutil/trace.go:171","msg":"trace[1092914785] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"548.399646ms","start":"2026-05-26T07:32:28.789596Z","end":"2026-05-26T07:32:29.337996Z","steps":["trace[1092914785] 'process raft request' (duration: 203.107908ms)","trace[1092914785] 'compare' (duration: 344.812647ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T07:32:29.338092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:28.789573Z","time spent":"548.487118ms","remote":"127.0.0.1:51306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64392,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T07:32:29.338991Z","caller":"traceutil/trace.go:171","msg":"trace[967567694] linearizableReadLoop","detail":"{readStateIndex:565; appliedIndex:562; }","duration":"396.594195ms","start":"2026-05-26T07:32:28.94238Z","end":"2026-05-26T07:32:29.338975Z","steps":["trace[967567694] 'read index received' (duration: 50.338654ms)","trace[967567694] 'applied index is now lower than readState.Index' (duration: 346.254731ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T07:32:29.339302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.5691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-26T07:32:29.339278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.876991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-26T07:32:29.339342Z","caller":"traceutil/trace.go:171","msg":"trace[1107300267] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:544; }","duration":"395.653102ms","start":"2026-05-26T07:32:28.943679Z","end":"2026-05-26T07:32:29.339332Z","steps":["trace[1107300267] 'agreement among raft nodes before linearized reading' (duration: 395.57613ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:29.339373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:28.943671Z","time spent":"395.695213ms","remote":"127.0.0.1:51566","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":"info","ts":"2026-05-26T07:32:29.339417Z","caller":"traceutil/trace.go:171","msg":"trace[699639076] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:544; }","duration":"397.001535ms","start":"2026-05-26T07:32:28.942343Z","end":"2026-05-26T07:32:29.339345Z","steps":["trace[699639076] 'agreement among raft nodes before linearized reading' (duration: 396.852571ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:29.339458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:28.942327Z","time spent":"397.122438ms","remote":"127.0.0.1:51566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-26T07:32:29.339633Z","caller":"traceutil/trace.go:171","msg":"trace[411375240] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"451.855558ms","start":"2026-05-26T07:32:28.887766Z","end":"2026-05-26T07:32:29.339622Z","steps":["trace[411375240] 'process raft request' (duration: 451.018668ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:29.339713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:28.887746Z","time spent":"451.911229ms","remote":"127.0.0.1:51306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59607,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T07:32:29.339792Z","caller":"traceutil/trace.go:171","msg":"trace[1692040644] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"451.94574ms","start":"2026-05-26T07:32:28.887838Z","end":"2026-05-26T07:32:29.339784Z","steps":["trace[1692040644] 'process raft request' (duration: 451.065749ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:29.339841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:28.887833Z","time spent":"451.978011ms","remote":"127.0.0.1:51306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23066,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T07:32:29.33989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.570555ms","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-05-26T07:32:29.339918Z","caller":"traceutil/trace.go:171","msg":"trace[1707769140] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:544; }","duration":"384.614756ms","start":"2026-05-26T07:32:28.955294Z","end":"2026-05-26T07:32:29.339909Z","steps":["trace[1707769140] 'agreement among raft nodes before linearized reading' (duration: 384.570335ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:29.339944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:28.955284Z","time spent":"384.653897ms","remote":"127.0.0.1:51566","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-05-26T07:32:29.339846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.595529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T07:32:29.339997Z","caller":"traceutil/trace.go:171","msg":"trace[2039360809] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:544; }","duration":"198.773064ms","start":"2026-05-26T07:32:29.141212Z","end":"2026-05-26T07:32:29.339985Z","steps":["trace[2039360809] 'agreement among raft nodes before linearized reading' (duration: 198.60854ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:29.340073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.016788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-26T07:32:29.340099Z","caller":"traceutil/trace.go:171","msg":"trace[1807732577] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:544; }","duration":"388.057489ms","start":"2026-05-26T07:32:28.952033Z","end":"2026-05-26T07:32:29.340091Z","steps":["trace[1807732577] 'agreement among raft nodes before linearized reading' (duration: 388.016348ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:29.340123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:28.952024Z","time spent":"388.09361ms","remote":"127.0.0.1:51566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-26T07:32:34.671454Z","caller":"traceutil/trace.go:171","msg":"trace[116831009] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"101.358513ms","start":"2026-05-26T07:32:34.570076Z","end":"2026-05-26T07:32:34.671434Z","steps":["trace[116831009] 'process raft request' (duration: 101.258911ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:35.377248Z","caller":"traceutil/trace.go:171","msg":"trace[2015426081] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:623; }","duration":"237.683739ms","start":"2026-05-26T07:32:35.13954Z","end":"2026-05-26T07:32:35.377224Z","steps":["trace[2015426081] 'read index received' (duration: 236.813648ms)","trace[2015426081] 'applied index is now lower than readState.Index' (duration: 869.051µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T07:32:35.377302Z","caller":"traceutil/trace.go:171","msg":"trace[495714227] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"293.75437ms","start":"2026-05-26T07:32:35.083515Z","end":"2026-05-26T07:32:35.37727Z","steps":["trace[495714227] 'process raft request' (duration: 293.035053ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:35.377489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.492796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.223\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-05-26T07:32:35.377428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.863103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T07:32:35.377563Z","caller":"traceutil/trace.go:171","msg":"trace[743178768] range","detail":"{range_begin:/registry/masterleases/199.19.213.223; range_end:; response_count:1; response_revision:602; }","duration":"162.610289ms","start":"2026-05-26T07:32:35.214935Z","end":"2026-05-26T07:32:35.377546Z","steps":["trace[743178768] 'agreement among raft nodes before linearized reading' (duration: 162.461255ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:35.37771Z","caller":"traceutil/trace.go:171","msg":"trace[274075331] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:602; }","duration":"238.168181ms","start":"2026-05-26T07:32:35.139487Z","end":"2026-05-26T07:32:35.377655Z","steps":["trace[274075331] 'agreement among raft nodes before linearized reading' (duration: 237.815442ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:35.645354Z","caller":"traceutil/trace.go:171","msg":"trace[25458558] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"212.82848ms","start":"2026-05-26T07:32:35.432505Z","end":"2026-05-26T07:32:35.645333Z","steps":["trace[25458558] 'process raft request' (duration: 212.704647ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:35.645396Z","caller":"traceutil/trace.go:171","msg":"trace[128557747] linearizableReadLoop","detail":"{readStateIndex:625; appliedIndex:624; }","duration":"266.35489ms","start":"2026-05-26T07:32:35.379007Z","end":"2026-05-26T07:32:35.645362Z","steps":["trace[128557747] 'read index received' (duration: 175.013288ms)","trace[128557747] 'applied index is now lower than readState.Index' (duration: 91.336722ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T07:32:35.645641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.612406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T07:32:35.64584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.135139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-26T07:32:35.645921Z","caller":"traceutil/trace.go:171","msg":"trace[1285159020] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:603; }","duration":"250.237812ms","start":"2026-05-26T07:32:35.395669Z","end":"2026-05-26T07:32:35.645907Z","steps":["trace[1285159020] 'agreement among raft nodes before linearized reading' (duration: 250.111389ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:35.645841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.732147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-26T07:32:35.645967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.306613ms","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-05-26T07:32:35.646044Z","caller":"traceutil/trace.go:171","msg":"trace[50397636] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:603; }","duration":"250.379705ms","start":"2026-05-26T07:32:35.395639Z","end":"2026-05-26T07:32:35.646019Z","steps":["trace[50397636] 'agreement among raft nodes before linearized reading' (duration: 250.223211ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:35.646237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.390104ms","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-05-26T07:32:35.646011Z","caller":"traceutil/trace.go:171","msg":"trace[1870736022] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:603; }","duration":"263.939811ms","start":"2026-05-26T07:32:35.382055Z","end":"2026-05-26T07:32:35.645995Z","steps":["trace[1870736022] 'agreement among raft nodes before linearized reading' (duration: 263.727206ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:35.646321Z","caller":"traceutil/trace.go:171","msg":"trace[513896066] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:603; }","duration":"245.576569ms","start":"2026-05-26T07:32:35.400723Z","end":"2026-05-26T07:32:35.646299Z","steps":["trace[513896066] 'agreement among raft nodes before linearized reading' (duration: 245.1944ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:35.645941Z","caller":"traceutil/trace.go:171","msg":"trace[1976910709] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:603; }","duration":"266.757379ms","start":"2026-05-26T07:32:35.378978Z","end":"2026-05-26T07:32:35.645736Z","steps":["trace[1976910709] 'agreement among raft nodes before linearized reading' (duration: 266.467902ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:36.621651Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8055706507370289901,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-26T07:32:36.665295Z","caller":"traceutil/trace.go:171","msg":"trace[1709498356] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:634; }","duration":"544.027641ms","start":"2026-05-26T07:32:36.121244Z","end":"2026-05-26T07:32:36.665271Z","steps":["trace[1709498356] 'read index received' (duration: 543.203761ms)","trace[1709498356] 'applied index is now lower than readState.Index' (duration: 822.83µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T07:32:36.665381Z","caller":"traceutil/trace.go:171","msg":"trace[905533432] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"585.593203ms","start":"2026-05-26T07:32:36.07977Z","end":"2026-05-26T07:32:36.665363Z","steps":["trace[905533432] 'process raft request' (duration: 584.980599ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:36.665472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.198535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-zbg55\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-05-26T07:32:36.665497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:36.079737Z","time spent":"585.690126ms","remote":"127.0.0.1:51362","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T07:32:36.665512Z","caller":"traceutil/trace.go:171","msg":"trace[357564287] range","detail":"{range_begin:/registry/pods/kube-system/cilium-zbg55; range_end:; response_count:1; response_revision:612; }","duration":"544.296908ms","start":"2026-05-26T07:32:36.121204Z","end":"2026-05-26T07:32:36.665501Z","steps":["trace[357564287] 'agreement among raft nodes before linearized reading' (duration: 544.194475ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:36.665545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:36.121185Z","time spent":"544.352179ms","remote":"127.0.0.1:51474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-zbg55\" "} {"level":"warn","ts":"2026-05-26T07:32:37.07351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.039304ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T07:32:37.073678Z","caller":"traceutil/trace.go:171","msg":"trace[716224401] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"358.120831ms","start":"2026-05-26T07:32:36.71554Z","end":"2026-05-26T07:32:37.073661Z","steps":["trace[716224401] 'process raft request' (duration: 358.06717ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:37.073754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:36.715517Z","time spent":"358.212643ms","remote":"127.0.0.1:51526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T07:32:37.073748Z","caller":"traceutil/trace.go:171","msg":"trace[1162116480] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"392.420487ms","start":"2026-05-26T07:32:36.681291Z","end":"2026-05-26T07:32:37.073711Z","steps":["trace[1162116480] 'process raft request' (duration: 240.106477ms)","trace[1162116480] 'compare' (duration: 151.908581ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T07:32:37.073912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:36.681271Z","time spent":"392.553391ms","remote":"127.0.0.1:51474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T07:32:37.640095Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8055706507370289909,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-26T07:32:38.091708Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.001631127s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-26T07:32:38.321313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.302566ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-26T07:32:38.321591Z","caller":"traceutil/trace.go:171","msg":"trace[763730899] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"1.231549597s","start":"2026-05-26T07:32:37.089988Z","end":"2026-05-26T07:32:38.321538Z","steps":["trace[763730899] 'process raft request' (duration: 1.001953475s)","trace[763730899] 'compare' (duration: 229.07931ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T07:32:38.321786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:37.089972Z","time spent":"1.231728872s","remote":"127.0.0.1:51474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T07:32:38.321821Z","caller":"traceutil/trace.go:171","msg":"trace[985933469] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:637; }","duration":"1.182166717s","start":"2026-05-26T07:32:37.139585Z","end":"2026-05-26T07:32:38.321751Z","steps":["trace[985933469] 'read index received' (duration: 952.37858ms)","trace[985933469] 'applied index is now lower than readState.Index' (duration: 229.786777ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T07:32:38.321978Z","caller":"traceutil/trace.go:171","msg":"trace[1493688608] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"515.823469ms","start":"2026-05-26T07:32:37.806138Z","end":"2026-05-26T07:32:38.321962Z","steps":["trace[1493688608] 'process raft request' (duration: 515.358938ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:38.322101Z","caller":"traceutil/trace.go:171","msg":"trace[2025494265] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"759.781038ms","start":"2026-05-26T07:32:37.562267Z","end":"2026-05-26T07:32:38.322048Z","steps":["trace[2025494265] 'process raft request' (duration: 759.146813ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:38.322186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:37.806109Z","time spent":"516.021734ms","remote":"127.0.0.1:51566","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-05-26T07:32:38.322301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:37.562244Z","time spent":"759.955803ms","remote":"127.0.0.1:51460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T07:32:38.322437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.134109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-26T07:32:38.322481Z","caller":"traceutil/trace.go:171","msg":"trace[822838938] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:617; }","duration":"658.251162ms","start":"2026-05-26T07:32:37.664221Z","end":"2026-05-26T07:32:38.322472Z","steps":["trace[822838938] 'agreement among raft nodes before linearized reading' (duration: 657.881563ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:38.322513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:37.664199Z","time spent":"658.309133ms","remote":"127.0.0.1:51566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-26T07:32:38.322605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.183029208s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T07:32:38.322636Z","caller":"traceutil/trace.go:171","msg":"trace[1906151993] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:617; }","duration":"1.18310636s","start":"2026-05-26T07:32:37.139522Z","end":"2026-05-26T07:32:38.322628Z","steps":["trace[1906151993] 'agreement among raft nodes before linearized reading' (duration: 1.183060279s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:38.322708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:37.139501Z","time spent":"1.183200992s","remote":"127.0.0.1:51238","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-05-26T07:32:38.322894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.17343ms","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-05-26T07:32:38.322922Z","caller":"traceutil/trace.go:171","msg":"trace[573698430] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:617; }","duration":"658.222051ms","start":"2026-05-26T07:32:37.664693Z","end":"2026-05-26T07:32:38.322915Z","steps":["trace[573698430] 'agreement among raft nodes before linearized reading' (duration: 658.137799ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:38.322942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:37.664682Z","time spent":"658.254362ms","remote":"127.0.0.1:51566","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-05-26T07:32:38.323067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"657.634407ms","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-05-26T07:32:38.323092Z","caller":"traceutil/trace.go:171","msg":"trace[763053561] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:617; }","duration":"657.681128ms","start":"2026-05-26T07:32:37.665404Z","end":"2026-05-26T07:32:38.323085Z","steps":["trace[763053561] 'agreement among raft nodes before linearized reading' (duration: 657.600206ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:38.323113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:37.665391Z","time spent":"657.717149ms","remote":"127.0.0.1:51566","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-05-26T07:32:38.324121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.274797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-26T07:32:38.324236Z","caller":"traceutil/trace.go:171","msg":"trace[383595281] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:617; }","duration":"659.457521ms","start":"2026-05-26T07:32:37.664747Z","end":"2026-05-26T07:32:38.324205Z","steps":["trace[383595281] 'agreement among raft nodes before linearized reading' (duration: 657.975856ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:38.324304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:37.664727Z","time spent":"659.565973ms","remote":"127.0.0.1:51566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-26T07:32:40.643232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.814896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-26T07:32:40.643302Z","caller":"traceutil/trace.go:171","msg":"trace[1716118857] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:633; }","duration":"302.940649ms","start":"2026-05-26T07:32:40.340346Z","end":"2026-05-26T07:32:40.643287Z","steps":["trace[1716118857] 'range keys from in-memory index tree' (duration: 302.613551ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:40.643334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:40.340316Z","time spent":"303.011091ms","remote":"127.0.0.1:51566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-26T07:32:40.643429Z","caller":"traceutil/trace.go:171","msg":"trace[777889720] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"301.607656ms","start":"2026-05-26T07:32:40.341795Z","end":"2026-05-26T07:32:40.643403Z","steps":["trace[777889720] 'process raft request' (duration: 284.151025ms)","trace[777889720] 'compare' (duration: 17.134624ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T07:32:40.643583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:40.34177Z","time spent":"301.742ms","remote":"127.0.0.1:51566","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-05-26T07:32:40.643705Z","caller":"traceutil/trace.go:171","msg":"trace[1768245249] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"300.851478ms","start":"2026-05-26T07:32:40.342837Z","end":"2026-05-26T07:32:40.643688Z","steps":["trace[1768245249] 'process raft request' (duration: 300.593812ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:40.643809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:40.342822Z","time spent":"300.92296ms","remote":"127.0.0.1:51566","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-05-26T07:32:40.643754Z","caller":"traceutil/trace.go:171","msg":"trace[1640331815] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"300.242433ms","start":"2026-05-26T07:32:40.343453Z","end":"2026-05-26T07:32:40.643695Z","steps":["trace[1640331815] 'process raft request' (duration: 300.151661ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:40.644123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:40.343423Z","time spent":"300.558711ms","remote":"127.0.0.1:51566","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-05-26T07:32:43.48276Z","caller":"traceutil/trace.go:171","msg":"trace[709043956] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"109.969019ms","start":"2026-05-26T07:32:43.372776Z","end":"2026-05-26T07:32:43.482745Z","steps":["trace[709043956] 'process raft request' (duration: 109.842316ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:43.85906Z","caller":"traceutil/trace.go:171","msg":"trace[1546646460] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"122.304826ms","start":"2026-05-26T07:32:43.736734Z","end":"2026-05-26T07:32:43.859039Z","steps":["trace[1546646460] 'process raft request' (duration: 122.191093ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:44.177022Z","caller":"traceutil/trace.go:171","msg":"trace[835937404] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"177.893864ms","start":"2026-05-26T07:32:43.999091Z","end":"2026-05-26T07:32:44.176985Z","steps":["trace[835937404] 'process raft request' (duration: 138.973847ms)","trace[835937404] 'compare' (duration: 38.701872ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T07:32:44.501742Z","caller":"traceutil/trace.go:171","msg":"trace[1785095694] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"187.017774ms","start":"2026-05-26T07:32:44.314686Z","end":"2026-05-26T07:32:44.501704Z","steps":["trace[1785095694] 'process raft request' (duration: 186.668976ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:44.751486Z","caller":"traceutil/trace.go:171","msg":"trace[1023741433] linearizableReadLoop","detail":"{readStateIndex:721; appliedIndex:720; }","duration":"219.480166ms","start":"2026-05-26T07:32:44.531985Z","end":"2026-05-26T07:32:44.751466Z","steps":["trace[1023741433] 'read index received' (duration: 219.062036ms)","trace[1023741433] 'applied index is now lower than readState.Index' (duration: 417.25µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T07:32:44.751747Z","caller":"traceutil/trace.go:171","msg":"trace[1746476167] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"383.445295ms","start":"2026-05-26T07:32:44.368247Z","end":"2026-05-26T07:32:44.751692Z","steps":["trace[1746476167] 'process raft request' (duration: 382.762458ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:44.751934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:44.368224Z","time spent":"383.629329ms","remote":"127.0.0.1:51306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187455,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T07:32:44.75207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.06269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"info","ts":"2026-05-26T07:32:44.752162Z","caller":"traceutil/trace.go:171","msg":"trace[42702679] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:697; }","duration":"220.204724ms","start":"2026-05-26T07:32:44.531935Z","end":"2026-05-26T07:32:44.75214Z","steps":["trace[42702679] 'agreement among raft nodes before linearized reading' (duration: 219.953748ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:44.919459Z","caller":"traceutil/trace.go:171","msg":"trace[1126070087] linearizableReadLoop","detail":"{readStateIndex:722; appliedIndex:721; }","duration":"167.870803ms","start":"2026-05-26T07:32:44.751561Z","end":"2026-05-26T07:32:44.919432Z","steps":["trace[1126070087] 'read index received' (duration: 167.736209ms)","trace[1126070087] 'applied index is now lower than readState.Index' (duration: 133.343µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T07:32:44.919674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.718496ms","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-05-26T07:32:44.919709Z","caller":"traceutil/trace.go:171","msg":"trace[1513937824] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:698; }","duration":"264.803417ms","start":"2026-05-26T07:32:44.654895Z","end":"2026-05-26T07:32:44.919699Z","steps":["trace[1513937824] 'agreement among raft nodes before linearized reading' (duration: 264.650293ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:44.919796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.275914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-05-26T07:32:44.919856Z","caller":"traceutil/trace.go:171","msg":"trace[1932816358] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:698; }","duration":"188.393597ms","start":"2026-05-26T07:32:44.731448Z","end":"2026-05-26T07:32:44.919841Z","steps":["trace[1932816358] 'agreement among raft nodes before linearized reading' (duration: 188.212393ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:44.919998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.174782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-26T07:32:44.920039Z","caller":"traceutil/trace.go:171","msg":"trace[1383883257] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:698; }","duration":"259.260864ms","start":"2026-05-26T07:32:44.660769Z","end":"2026-05-26T07:32:44.920029Z","steps":["trace[1383883257] 'agreement among raft nodes before linearized reading' (duration: 259.161182ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:44.920159Z","caller":"traceutil/trace.go:171","msg":"trace[240753982] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"310.871227ms","start":"2026-05-26T07:32:44.60928Z","end":"2026-05-26T07:32:44.920152Z","steps":["trace[240753982] 'process raft request' (duration: 309.938544ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:44.920208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.425764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-26T07:32:44.920225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:44.609251Z","time spent":"310.926898ms","remote":"127.0.0.1:51306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188237,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T07:32:44.920242Z","caller":"traceutil/trace.go:171","msg":"trace[1239632472] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:698; }","duration":"263.475326ms","start":"2026-05-26T07:32:44.656755Z","end":"2026-05-26T07:32:44.92023Z","steps":["trace[1239632472] 'agreement among raft nodes before linearized reading' (duration: 263.402794ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:44.920413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.285605ms","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-05-26T07:32:44.920438Z","caller":"traceutil/trace.go:171","msg":"trace[671049287] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:698; }","duration":"264.332886ms","start":"2026-05-26T07:32:44.656099Z","end":"2026-05-26T07:32:44.920432Z","steps":["trace[671049287] 'agreement among raft nodes before linearized reading' (duration: 264.256054ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:45.102785Z","caller":"traceutil/trace.go:171","msg":"trace[1970881650] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"283.037116ms","start":"2026-05-26T07:32:44.819726Z","end":"2026-05-26T07:32:45.102764Z","steps":["trace[1970881650] 'process raft request' (duration: 282.413061ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:45.103156Z","caller":"traceutil/trace.go:171","msg":"trace[15601364] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"211.532574ms","start":"2026-05-26T07:32:44.89161Z","end":"2026-05-26T07:32:45.103142Z","steps":["trace[15601364] 'process raft request' (duration: 211.101803ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:45.10959Z","caller":"traceutil/trace.go:171","msg":"trace[199632575] linearizableReadLoop","detail":"{readStateIndex:728; appliedIndex:722; }","duration":"179.045031ms","start":"2026-05-26T07:32:44.930521Z","end":"2026-05-26T07:32:45.109566Z","steps":["trace[199632575] 'read index received' (duration: 171.469589ms)","trace[199632575] 'applied index is now lower than readState.Index' (duration: 7.574582ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T07:32:45.10996Z","caller":"traceutil/trace.go:171","msg":"trace[1584602446] transaction","detail":"{read_only:false; response_revision:701; number_of_response:1; }","duration":"180.640561ms","start":"2026-05-26T07:32:44.929306Z","end":"2026-05-26T07:32:45.109946Z","steps":["trace[1584602446] 'process raft request' (duration: 179.996245ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:45.110161Z","caller":"traceutil/trace.go:171","msg":"trace[1552180671] transaction","detail":"{read_only:false; response_revision:702; number_of_response:1; }","duration":"180.759643ms","start":"2026-05-26T07:32:44.929389Z","end":"2026-05-26T07:32:45.110149Z","steps":["trace[1552180671] 'process raft request' (duration: 180.045426ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:45.110278Z","caller":"traceutil/trace.go:171","msg":"trace[1207110040] transaction","detail":"{read_only:false; response_revision:703; number_of_response:1; }","duration":"180.886136ms","start":"2026-05-26T07:32:44.929383Z","end":"2026-05-26T07:32:45.110269Z","steps":["trace[1207110040] 'process raft request' (duration: 180.090747ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:45.110453Z","caller":"traceutil/trace.go:171","msg":"trace[1467702941] transaction","detail":"{read_only:false; response_revision:704; number_of_response:1; }","duration":"181.02159ms","start":"2026-05-26T07:32:44.929424Z","end":"2026-05-26T07:32:45.110446Z","steps":["trace[1467702941] 'process raft request' (duration: 180.076627ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:45.110659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.124048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"info","ts":"2026-05-26T07:32:45.110683Z","caller":"traceutil/trace.go:171","msg":"trace[1899410442] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:705; }","duration":"180.176499ms","start":"2026-05-26T07:32:44.930499Z","end":"2026-05-26T07:32:45.110675Z","steps":["trace[1899410442] 'agreement among raft nodes before linearized reading' (duration: 180.075147ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:45.110777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.13343ms","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-05-26T07:32:45.110793Z","caller":"traceutil/trace.go:171","msg":"trace[1844124986] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:705; }","duration":"166.173982ms","start":"2026-05-26T07:32:44.944614Z","end":"2026-05-26T07:32:45.110788Z","steps":["trace[1844124986] 'agreement among raft nodes before linearized reading' (duration: 166.134661ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:51.554122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.872702ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T07:32:51.554298Z","caller":"traceutil/trace.go:171","msg":"trace[1817349373] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"365.368044ms","start":"2026-05-26T07:32:51.188913Z","end":"2026-05-26T07:32:51.554281Z","steps":["trace[1817349373] 'process raft request' (duration: 145.250786ms)","trace[1817349373] 'compare' (duration: 219.750849ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T07:32:51.554374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:51.188885Z","time spent":"365.456457ms","remote":"127.0.0.1:51566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T07:32:51.554607Z","caller":"traceutil/trace.go:171","msg":"trace[1924190157] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"365.662471ms","start":"2026-05-26T07:32:51.18892Z","end":"2026-05-26T07:32:51.554583Z","steps":["trace[1924190157] 'process raft request' (duration: 365.309723ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:51.554635Z","caller":"traceutil/trace.go:171","msg":"trace[275656527] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"365.476446ms","start":"2026-05-26T07:32:51.189141Z","end":"2026-05-26T07:32:51.554617Z","steps":["trace[275656527] 'process raft request' (duration: 365.328893ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:51.554756Z","caller":"traceutil/trace.go:171","msg":"trace[101312469] transaction","detail":"{read_only:false; response_revision:758; number_of_response:1; }","duration":"364.79074ms","start":"2026-05-26T07:32:51.189938Z","end":"2026-05-26T07:32:51.554729Z","steps":["trace[101312469] 'process raft request' (duration: 364.623786ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:51.554792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.198013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-4jr6f\" ","response":"range_response_count:1 size:5047"} {"level":"info","ts":"2026-05-26T07:32:51.554839Z","caller":"traceutil/trace.go:171","msg":"trace[959972692] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-4jr6f; range_end:; response_count:1; response_revision:758; }","duration":"346.282334ms","start":"2026-05-26T07:32:51.208547Z","end":"2026-05-26T07:32:51.55483Z","steps":["trace[959972692] 'agreement among raft nodes before linearized reading' (duration: 346.129061ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:51.554696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:51.188887Z","time spent":"365.764084ms","remote":"127.0.0.1:51566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T07:32:51.554869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:51.208538Z","time spent":"346.324475ms","remote":"127.0.0.1:51474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":5070,"request content":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-4jr6f\" "} {"level":"info","ts":"2026-05-26T07:32:51.554624Z","caller":"traceutil/trace.go:171","msg":"trace[504726345] linearizableReadLoop","detail":"{readStateIndex:785; appliedIndex:781; }","duration":"346.024609ms","start":"2026-05-26T07:32:51.208576Z","end":"2026-05-26T07:32:51.5546Z","steps":["trace[504726345] 'read index received' (duration: 125.580033ms)","trace[504726345] 'applied index is now lower than readState.Index' (duration: 220.443586ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T07:32:51.554898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:51.189925Z","time spent":"364.909343ms","remote":"127.0.0.1:51566","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-05-26T07:32:51.554771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:51.18913Z","time spent":"365.548959ms","remote":"127.0.0.1:51566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T07:32:54.794266Z","caller":"traceutil/trace.go:171","msg":"trace[1602139192] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"568.311285ms","start":"2026-05-26T07:32:54.225923Z","end":"2026-05-26T07:32:54.794234Z","steps":["trace[1602139192] 'process raft request' (duration: 568.149241ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:54.794438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:54.225884Z","time spent":"568.470099ms","remote":"127.0.0.1:51474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4022,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T07:32:57.378515Z","caller":"traceutil/trace.go:171","msg":"trace[1937855057] linearizableReadLoop","detail":"{readStateIndex:815; appliedIndex:814; }","duration":"238.501868ms","start":"2026-05-26T07:32:57.13999Z","end":"2026-05-26T07:32:57.378492Z","steps":["trace[1937855057] 'read index received' (duration: 238.319534ms)","trace[1937855057] 'applied index is now lower than readState.Index' (duration: 177.254µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T07:32:57.378549Z","caller":"traceutil/trace.go:171","msg":"trace[301769554] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"338.649418ms","start":"2026-05-26T07:32:57.039874Z","end":"2026-05-26T07:32:57.378523Z","steps":["trace[301769554] 'process raft request' (duration: 338.404952ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:57.378703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:32:57.039862Z","time spent":"338.75212ms","remote":"127.0.0.1:51474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4210,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T07:32:57.378738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.108212ms","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-05-26T07:32:57.378763Z","caller":"traceutil/trace.go:171","msg":"trace[235418633] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:787; }","duration":"170.199554ms","start":"2026-05-26T07:32:57.208556Z","end":"2026-05-26T07:32:57.378755Z","steps":["trace[235418633] 'agreement among raft nodes before linearized reading' (duration: 170.059681ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:32:57.37874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.731093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T07:32:57.378822Z","caller":"traceutil/trace.go:171","msg":"trace[329159629] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:787; }","duration":"238.864217ms","start":"2026-05-26T07:32:57.139938Z","end":"2026-05-26T07:32:57.378802Z","steps":["trace[329159629] 'agreement among raft nodes before linearized reading' (duration: 238.718763ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:32:57.508836Z","caller":"traceutil/trace.go:171","msg":"trace[793656597] transaction","detail":"{read_only:false; response_revision:788; number_of_response:1; }","duration":"124.293799ms","start":"2026-05-26T07:32:57.384514Z","end":"2026-05-26T07:32:57.508808Z","steps":["trace[793656597] 'process raft request' (duration: 104.158705ms)","trace[793656597] 'compare' (duration: 20.004501ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T07:33:08.893346Z","caller":"traceutil/trace.go:171","msg":"trace[1399019873] transaction","detail":"{read_only:false; response_revision:935; number_of_response:1; }","duration":"172.272602ms","start":"2026-05-26T07:33:08.72105Z","end":"2026-05-26T07:33:08.893323Z","steps":["trace[1399019873] 'process raft request' (duration: 172.131298ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:33:09.037262Z","caller":"traceutil/trace.go:171","msg":"trace[1130657108] transaction","detail":"{read_only:false; response_revision:936; number_of_response:1; }","duration":"281.318993ms","start":"2026-05-26T07:33:08.755922Z","end":"2026-05-26T07:33:09.037241Z","steps":["trace[1130657108] 'process raft request' (duration: 281.20227ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:33:09.239663Z","caller":"traceutil/trace.go:171","msg":"trace[1274281416] transaction","detail":"{read_only:false; response_revision:938; number_of_response:1; }","duration":"191.210927ms","start":"2026-05-26T07:33:09.048395Z","end":"2026-05-26T07:33:09.239606Z","steps":["trace[1274281416] 'process raft request' (duration: 190.563751ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:33:30.379113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.414025ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-26T07:33:32.133565Z","caller":"traceutil/trace.go:171","msg":"trace[1327020817] linearizableReadLoop","detail":"{readStateIndex:1087; appliedIndex:1085; }","duration":"120.055662ms","start":"2026-05-26T07:33:32.013483Z","end":"2026-05-26T07:33:32.133539Z","steps":["trace[1327020817] 'read index received' (duration: 6.168578ms)","trace[1327020817] 'applied index is now lower than readState.Index' (duration: 113.885904ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T07:33:32.13376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.262418ms","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-05-26T07:33:32.133795Z","caller":"traceutil/trace.go:171","msg":"trace[11818059] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1051; }","duration":"120.339359ms","start":"2026-05-26T07:33:32.013449Z","end":"2026-05-26T07:33:32.133788Z","steps":["trace[11818059] 'agreement among raft nodes before linearized reading' (duration: 120.179306ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T07:33:32.133595Z","caller":"traceutil/trace.go:171","msg":"trace[1465894922] transaction","detail":"{read_only:false; response_revision:1051; number_of_response:1; }","duration":"124.762076ms","start":"2026-05-26T07:33:32.008814Z","end":"2026-05-26T07:33:32.133576Z","steps":["trace[1465894922] 'process raft request' (duration: 105.932204ms)","trace[1465894922] 'compare' (duration: 18.652278ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T07:33:44.069347Z","caller":"traceutil/trace.go:171","msg":"trace[904743302] linearizableReadLoop","detail":"{readStateIndex:1147; appliedIndex:1146; }","duration":"157.715535ms","start":"2026-05-26T07:33:43.911606Z","end":"2026-05-26T07:33:44.069321Z","steps":["trace[904743302] 'read index received' (duration: 157.474569ms)","trace[904743302] 'applied index is now lower than readState.Index' (duration: 239.986µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T07:33:44.069447Z","caller":"traceutil/trace.go:171","msg":"trace[1398997286] transaction","detail":"{read_only:false; response_revision:1108; number_of_response:1; }","duration":"368.430042ms","start":"2026-05-26T07:33:43.700982Z","end":"2026-05-26T07:33:44.069412Z","steps":["trace[1398997286] 'process raft request' (duration: 368.145575ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:33:44.06957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.9524ms","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-05-26T07:33:44.069607Z","caller":"traceutil/trace.go:171","msg":"trace[1271675296] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1108; }","duration":"158.049823ms","start":"2026-05-26T07:33:43.911547Z","end":"2026-05-26T07:33:44.069597Z","steps":["trace[1271675296] 'agreement among raft nodes before linearized reading' (duration: 157.880519ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T07:33:44.070366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T07:33:43.700952Z","time spent":"368.619307ms","remote":"127.0.0.1:51566","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-05-26T07:34:16.415432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.18209ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T07:34:16.415558Z","caller":"traceutil/trace.go:171","msg":"trace[1378041645] linearizableReadLoop","detail":"{readStateIndex:1267; appliedIndex:1266; }","duration":"131.240027ms","start":"2026-05-26T07:34:16.284296Z","end":"2026-05-26T07:34:16.415536Z","steps":["trace[1378041645] 'read index received' (duration: 13.868822ms)","trace[1378041645] 'applied index is now lower than readState.Index' (duration: 117.369815ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T07:34:16.415659Z","caller":"traceutil/trace.go:171","msg":"trace[891552368] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"134.024164ms","start":"2026-05-26T07:34:16.281614Z","end":"2026-05-26T07:34:16.415638Z","steps":["trace[891552368] 'process raft request' (duration: 16.550337ms)","trace[891552368] 'compare' (duration: 117.071918ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T07:34:16.415777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.473022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-zbg55\" ","response":"range_response_count:1 size:18525"} {"level":"info","ts":"2026-05-26T07:34:16.415892Z","caller":"traceutil/trace.go:171","msg":"trace[1091257487] range","detail":"{range_begin:/registry/pods/kube-system/cilium-zbg55; range_end:; response_count:1; response_revision:1220; }","duration":"131.607406ms","start":"2026-05-26T07:34:16.284259Z","end":"2026-05-26T07:34:16.415866Z","steps":["trace[1091257487] 'agreement among raft nodes before linearized reading' (duration: 131.37754ms)"],"step_count":1}