{"level":"warn","ts":"2026-04-15T04:02:03.936819Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-15T04:02:03.936951Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.62: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://162.253.55.62:2380","--initial-cluster=instance=https://162.253.55.62:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.62:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.62:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-15T04:02:03.937032Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-15T04:02:03.937045Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.62:2380"]} {"level":"info","ts":"2026-04-15T04:02:03.937064Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-15T04:02:03.937888Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.62:2379"]} {"level":"info","ts":"2026-04-15T04:02:03.937966Z","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://162.253.55.62:2380"],"listen-peer-urls":["https://162.253.55.62:2380"],"advertise-client-urls":["https://162.253.55.62:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.62:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.62:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-15T04:02:03.943028Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.37617ms"} {"level":"info","ts":"2026-04-15T04:02:03.950953Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"791a7e25b533cd26","cluster-id":"be484d2748da72cd"} {"level":"info","ts":"2026-04-15T04:02:03.95104Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 switched to configuration voters=()"} {"level":"info","ts":"2026-04-15T04:02:03.951202Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became follower at term 0"} {"level":"info","ts":"2026-04-15T04:02:03.95122Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 791a7e25b533cd26 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-15T04:02:03.95125Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became follower at term 1"} {"level":"info","ts":"2026-04-15T04:02:03.951295Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 switched to configuration voters=(8726425928402717990)"} {"level":"warn","ts":"2026-04-15T04:02:03.959133Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-15T04:02:03.960273Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-15T04:02:03.961805Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-15T04:02:03.96398Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"791a7e25b533cd26","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-15T04:02:03.964185Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"791a7e25b533cd26","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-15T04:02:03.964289Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-15T04:02:03.964364Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-15T04:02:03.964371Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-15T04:02:03.965085Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 switched to configuration voters=(8726425928402717990)"} {"level":"info","ts":"2026-04-15T04:02:03.965307Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"be484d2748da72cd","local-member-id":"791a7e25b533cd26","added-peer-id":"791a7e25b533cd26","added-peer-peer-urls":["https://162.253.55.62:2380"]} {"level":"info","ts":"2026-04-15T04:02:03.969107Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-15T04:02:03.969298Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.62:2380"} {"level":"info","ts":"2026-04-15T04:02:03.969332Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.62:2380"} {"level":"info","ts":"2026-04-15T04:02:03.970464Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"791a7e25b533cd26","initial-advertise-peer-urls":["https://162.253.55.62:2380"],"listen-peer-urls":["https://162.253.55.62:2380"],"advertise-client-urls":["https://162.253.55.62:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.62:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-15T04:02:03.970543Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-15T04:02:04.752367Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 is starting a new election at term 1"} {"level":"info","ts":"2026-04-15T04:02:04.752407Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-15T04:02:04.75243Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 received MsgPreVoteResp from 791a7e25b533cd26 at term 1"} {"level":"info","ts":"2026-04-15T04:02:04.752441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became candidate at term 2"} {"level":"info","ts":"2026-04-15T04:02:04.752447Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 received MsgVoteResp from 791a7e25b533cd26 at term 2"} {"level":"info","ts":"2026-04-15T04:02:04.752455Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became leader at term 2"} {"level":"info","ts":"2026-04-15T04:02:04.752463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 791a7e25b533cd26 elected leader 791a7e25b533cd26 at term 2"} {"level":"info","ts":"2026-04-15T04:02:04.753305Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"791a7e25b533cd26","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.62:2379]}","request-path":"/0/members/791a7e25b533cd26/attributes","cluster-id":"be484d2748da72cd","publish-timeout":"7s"} {"level":"info","ts":"2026-04-15T04:02:04.75333Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-15T04:02:04.753311Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-15T04:02:04.753515Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T04:02:04.75368Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-15T04:02:04.753717Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-15T04:02:04.754915Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"be484d2748da72cd","local-member-id":"791a7e25b533cd26","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T04:02:04.755138Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T04:02:04.7553Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T04:02:04.756976Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-15T04:02:04.757129Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.62:2379"} {"level":"info","ts":"2026-04-15T04:02:28.314859Z","caller":"traceutil/trace.go:171","msg":"trace[1317811525] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"217.029055ms","start":"2026-04-15T04:02:28.097805Z","end":"2026-04-15T04:02:28.314834Z","steps":["trace[1317811525] 'process raft request' (duration: 134.582916ms)","trace[1317811525] 'compare' (duration: 82.275777ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T04:02:28.315722Z","caller":"traceutil/trace.go:171","msg":"trace[776516678] linearizableReadLoop","detail":"{readStateIndex:541; appliedIndex:539; }","duration":"165.893277ms","start":"2026-04-15T04:02:28.149805Z","end":"2026-04-15T04:02:28.315698Z","steps":["trace[776516678] 'read index received' (duration: 82.654158ms)","trace[776516678] 'applied index is now lower than readState.Index' (duration: 83.237979ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T04:02:28.315791Z","caller":"traceutil/trace.go:171","msg":"trace[2016542308] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"186.081906ms","start":"2026-04-15T04:02:28.129681Z","end":"2026-04-15T04:02:28.315763Z","steps":["trace[2016542308] 'process raft request' (duration: 185.901693ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T04:02:28.315863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.042059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T04:02:28.315931Z","caller":"traceutil/trace.go:171","msg":"trace[1427561449] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:514; }","duration":"166.13618ms","start":"2026-04-15T04:02:28.149783Z","end":"2026-04-15T04:02:28.315919Z","steps":["trace[1427561449] 'agreement among raft nodes before linearized reading' (duration: 166.018468ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T04:02:28.494027Z","caller":"traceutil/trace.go:171","msg":"trace[15917573] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"156.618572ms","start":"2026-04-15T04:02:28.337387Z","end":"2026-04-15T04:02:28.494005Z","steps":["trace[15917573] 'process raft request' (duration: 154.551386ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T04:02:28.498209Z","caller":"traceutil/trace.go:171","msg":"trace[748384061] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"127.609729ms","start":"2026-04-15T04:02:28.37057Z","end":"2026-04-15T04:02:28.49818Z","steps":["trace[748384061] 'process raft request' (duration: 127.384987ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T04:02:34.662474Z","caller":"traceutil/trace.go:171","msg":"trace[1092275983] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"312.049738ms","start":"2026-04-15T04:02:34.350398Z","end":"2026-04-15T04:02:34.662447Z","steps":["trace[1092275983] 'process raft request' (duration: 311.898871ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T04:02:34.662668Z","caller":"traceutil/trace.go:171","msg":"trace[192520164] linearizableReadLoop","detail":"{readStateIndex:594; appliedIndex:594; }","duration":"306.098637ms","start":"2026-04-15T04:02:34.356531Z","end":"2026-04-15T04:02:34.66263Z","steps":["trace[192520164] 'read index received' (duration: 306.086027ms)","trace[192520164] 'applied index is now lower than readState.Index' (duration: 10.88µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T04:02:34.662973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.417602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-skdhr\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-15T04:02:34.663015Z","caller":"traceutil/trace.go:171","msg":"trace[1657914153] range","detail":"{range_begin:/registry/pods/kube-system/cilium-skdhr; range_end:; response_count:1; response_revision:566; }","duration":"306.510186ms","start":"2026-04-15T04:02:34.356494Z","end":"2026-04-15T04:02:34.663004Z","steps":["trace[1657914153] 'agreement among raft nodes before linearized reading' (duration: 306.281146ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T04:02:34.663052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T04:02:34.356476Z","time spent":"306.568119ms","remote":"127.0.0.1:35890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-skdhr\" "} {"level":"warn","ts":"2026-04-15T04:02:34.663044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T04:02:34.350322Z","time spent":"312.232917ms","remote":"127.0.0.1:35984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T04:02:34.773941Z","caller":"traceutil/trace.go:171","msg":"trace[859918214] linearizableReadLoop","detail":"{readStateIndex:595; appliedIndex:594; }","duration":"111.174778ms","start":"2026-04-15T04:02:34.662746Z","end":"2026-04-15T04:02:34.773921Z","steps":["trace[859918214] 'read index received' (duration: 110.629724ms)","trace[859918214] 'applied index is now lower than readState.Index' (duration: 544.264µs)"],"step_count":2} {"level":"info","ts":"2026-04-15T04:02:34.774036Z","caller":"traceutil/trace.go:171","msg":"trace[1027141180] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"340.287685ms","start":"2026-04-15T04:02:34.433724Z","end":"2026-04-15T04:02:34.774011Z","steps":["trace[1027141180] 'process raft request' (duration: 339.763021ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T04:02:34.774173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T04:02:34.4337Z","time spent":"340.394169ms","remote":"127.0.0.1:35796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T04:02:34.77422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.755905ms","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-04-15T04:02:34.774364Z","caller":"traceutil/trace.go:171","msg":"trace[1631487592] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:567; }","duration":"129.935844ms","start":"2026-04-15T04:02:34.644417Z","end":"2026-04-15T04:02:34.774353Z","steps":["trace[1631487592] 'agreement among raft nodes before linearized reading' (duration: 129.587168ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T04:02:34.823864Z","caller":"traceutil/trace.go:171","msg":"trace[29541475] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"148.864757ms","start":"2026-04-15T04:02:34.674979Z","end":"2026-04-15T04:02:34.823844Z","steps":["trace[29541475] 'process raft request' (duration: 148.71662ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T04:02:35.391915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.374641ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-15T04:02:35.392055Z","caller":"traceutil/trace.go:171","msg":"trace[1421210150] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"613.218583ms","start":"2026-04-15T04:02:34.778822Z","end":"2026-04-15T04:02:35.39204Z","steps":["trace[1421210150] 'process raft request' (duration: 396.54355ms)","trace[1421210150] 'compare' (duration: 215.796574ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T04:02:35.392119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T04:02:34.778796Z","time spent":"613.300717ms","remote":"127.0.0.1:35984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T04:02:35.39527Z","caller":"traceutil/trace.go:171","msg":"trace[1058760793] linearizableReadLoop","detail":"{readStateIndex:598; appliedIndex:596; }","duration":"244.976889ms","start":"2026-04-15T04:02:35.15028Z","end":"2026-04-15T04:02:35.395257Z","steps":["trace[1058760793] 'read index received' (duration: 25.179365ms)","trace[1058760793] 'applied index is now lower than readState.Index' (duration: 219.796704ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T04:02:35.39532Z","caller":"traceutil/trace.go:171","msg":"trace[618250108] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"549.930256ms","start":"2026-04-15T04:02:34.845382Z","end":"2026-04-15T04:02:35.395312Z","steps":["trace[618250108] 'process raft request' (duration: 549.79406ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T04:02:35.395361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T04:02:34.845357Z","time spent":"549.985678ms","remote":"127.0.0.1:35944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T04:02:35.395373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.077155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T04:02:35.395403Z","caller":"traceutil/trace.go:171","msg":"trace[1895850019] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:570; }","duration":"245.154717ms","start":"2026-04-15T04:02:35.150239Z","end":"2026-04-15T04:02:35.395394Z","steps":["trace[1895850019] 'agreement among raft nodes before linearized reading' (duration: 245.064023ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T04:02:35.61016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.42668ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-15T04:02:35.610376Z","caller":"traceutil/trace.go:171","msg":"trace[129909628] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"172.585818ms","start":"2026-04-15T04:02:35.437754Z","end":"2026-04-15T04:02:35.61034Z","steps":["trace[129909628] 'process raft request' (duration: 70.902586ms)","trace[129909628] 'compare' (duration: 101.280054ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T04:02:35.610429Z","caller":"traceutil/trace.go:171","msg":"trace[821265399] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"172.475523ms","start":"2026-04-15T04:02:35.437933Z","end":"2026-04-15T04:02:35.610408Z","steps":["trace[821265399] 'process raft request' (duration: 172.428141ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T04:02:35.61049Z","caller":"traceutil/trace.go:171","msg":"trace[1171978890] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"172.593489ms","start":"2026-04-15T04:02:35.43787Z","end":"2026-04-15T04:02:35.610464Z","steps":["trace[1171978890] 'process raft request' (duration: 172.40639ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T04:02:37.606543Z","caller":"traceutil/trace.go:171","msg":"trace[81000822] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"114.592985ms","start":"2026-04-15T04:02:37.491921Z","end":"2026-04-15T04:02:37.606514Z","steps":["trace[81000822] 'process raft request' (duration: 114.170317ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T04:02:50.02231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.877857ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-15T04:02:50.022541Z","caller":"traceutil/trace.go:171","msg":"trace[1940690128] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"321.609721ms","start":"2026-04-15T04:02:49.700883Z","end":"2026-04-15T04:02:50.022493Z","steps":["trace[1940690128] 'process raft request' (duration: 168.464104ms)","trace[1940690128] 'compare' (duration: 152.759883ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T04:02:50.022732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T04:02:49.700852Z","time spent":"321.782788ms","remote":"127.0.0.1:35984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T04:02:50.022497Z","caller":"traceutil/trace.go:171","msg":"trace[106500061] linearizableReadLoop","detail":"{readStateIndex:760; appliedIndex:759; }","duration":"106.709543ms","start":"2026-04-15T04:02:49.915751Z","end":"2026-04-15T04:02:50.022461Z","steps":["trace[106500061] 'read index received' (duration: 54.632µs)","trace[106500061] 'applied index is now lower than readState.Index' (duration: 106.653091ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T04:02:50.023084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.326048ms","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-04-15T04:02:50.023252Z","caller":"traceutil/trace.go:171","msg":"trace[364157154] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:727; }","duration":"107.540756ms","start":"2026-04-15T04:02:49.915674Z","end":"2026-04-15T04:02:50.023215Z","steps":["trace[364157154] 'agreement among raft nodes before linearized reading' (duration: 107.246095ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T04:05:12.003313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.17791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T04:05:12.003379Z","caller":"traceutil/trace.go:171","msg":"trace[1949382538] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:2153; }","duration":"154.278191ms","start":"2026-04-15T04:05:11.849087Z","end":"2026-04-15T04:05:12.003365Z","steps":["trace[1949382538] 'range keys from in-memory index tree' (duration: 154.119899ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T04:05:12.003395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.457199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T04:05:12.003457Z","caller":"traceutil/trace.go:171","msg":"trace[43024291] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:2153; }","duration":"169.546241ms","start":"2026-04-15T04:05:11.833891Z","end":"2026-04-15T04:05:12.003437Z","steps":["trace[43024291] 'count revisions from in-memory index tree' (duration: 169.383399ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T04:05:12.003535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.537231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-15T04:05:12.003611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.206717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-15T04:05:12.003644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.966465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T04:05:12.003659Z","caller":"traceutil/trace.go:171","msg":"trace[1889556341] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:2153; }","duration":"169.276887ms","start":"2026-04-15T04:05:11.834374Z","end":"2026-04-15T04:05:12.003651Z","steps":["trace[1889556341] 'range keys from in-memory index tree' (duration: 169.140226ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T04:05:12.003633Z","caller":"traceutil/trace.go:171","msg":"trace[1546125843] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:2153; }","duration":"169.670583ms","start":"2026-04-15T04:05:11.833942Z","end":"2026-04-15T04:05:12.003613Z","steps":["trace[1546125843] 'range keys from in-memory index tree' (duration: 169.497131ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T04:05:12.003692Z","caller":"traceutil/trace.go:171","msg":"trace[1724359159] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:2153; }","duration":"124.010116ms","start":"2026-04-15T04:05:11.879659Z","end":"2026-04-15T04:05:12.00367Z","steps":["trace[1724359159] 'range keys from in-memory index tree' (duration: 123.911014ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T04:05:12.003613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.189108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-15T04:05:12.003552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.015716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T04:05:12.00383Z","caller":"traceutil/trace.go:171","msg":"trace[1711714206] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:2153; }","duration":"124.374661ms","start":"2026-04-15T04:05:11.879447Z","end":"2026-04-15T04:05:12.003821Z","steps":["trace[1711714206] 'count revisions from in-memory index tree' (duration: 123.987745ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T04:05:12.003971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.553688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T04:05:12.003998Z","caller":"traceutil/trace.go:171","msg":"trace[759478006] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:2153; }","duration":"107.615909ms","start":"2026-04-15T04:05:11.896375Z","end":"2026-04-15T04:05:12.003991Z","steps":["trace[759478006] 'range keys from in-memory index tree' (duration: 107.528348ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T04:05:12.003794Z","caller":"traceutil/trace.go:171","msg":"trace[1402652374] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:2153; }","duration":"124.365601ms","start":"2026-04-15T04:05:11.879401Z","end":"2026-04-15T04:05:12.003767Z","steps":["trace[1402652374] 'range keys from in-memory index tree' (duration: 124.111637ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T04:05:12.004001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.61544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T04:05:12.004261Z","caller":"traceutil/trace.go:171","msg":"trace[819074509] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:2153; }","duration":"108.143547ms","start":"2026-04-15T04:05:11.896046Z","end":"2026-04-15T04:05:12.004189Z","steps":["trace[819074509] 'range keys from in-memory index tree' (duration: 107.589139ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T04:05:12.003293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.950232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T04:05:12.004468Z","caller":"traceutil/trace.go:171","msg":"trace[225100036] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:2153; }","duration":"138.124218ms","start":"2026-04-15T04:05:11.86631Z","end":"2026-04-15T04:05:12.004434Z","steps":["trace[225100036] 'range keys from in-memory index tree' (duration: 136.900622ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T04:05:12.004162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.972824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-15T04:05:12.00466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.680146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T04:05:12.004754Z","caller":"traceutil/trace.go:171","msg":"trace[199291236] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:2153; }","duration":"138.80911ms","start":"2026-04-15T04:05:11.865924Z","end":"2026-04-15T04:05:12.004733Z","steps":["trace[199291236] 'count revisions from in-memory index tree' (duration: 138.631916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T04:05:12.004677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.80919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T04:05:12.005021Z","caller":"traceutil/trace.go:171","msg":"trace[1252519818] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:2153; }","duration":"139.182564ms","start":"2026-04-15T04:05:11.865824Z","end":"2026-04-15T04:05:12.005006Z","steps":["trace[1252519818] 'range keys from in-memory index tree' (duration: 138.661216ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T04:05:12.005042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.56738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-15T04:05:12.004976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.006943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T04:05:12.005123Z","caller":"traceutil/trace.go:171","msg":"trace[1009523467] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:2153; }","duration":"155.175285ms","start":"2026-04-15T04:05:11.849939Z","end":"2026-04-15T04:05:12.005114Z","steps":["trace[1009523467] 'range keys from in-memory index tree' (duration: 154.960992ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T04:05:12.004625Z","caller":"traceutil/trace.go:171","msg":"trace[667029810] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:2153; }","duration":"108.430641ms","start":"2026-04-15T04:05:11.896181Z","end":"2026-04-15T04:05:12.004611Z","steps":["trace[667029810] 'count revisions from in-memory index tree' (duration: 107.949964ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T04:05:12.005097Z","caller":"traceutil/trace.go:171","msg":"trace[1144555595] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:2153; }","duration":"155.669812ms","start":"2026-04-15T04:05:11.849419Z","end":"2026-04-15T04:05:12.005089Z","steps":["trace[1144555595] 'count revisions from in-memory index tree' (duration: 155.54043ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T04:05:12.607597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.884336ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-15T04:05:12.607998Z","caller":"traceutil/trace.go:171","msg":"trace[1064622762] transaction","detail":"{read_only:false; response_revision:2155; number_of_response:1; }","duration":"538.298986ms","start":"2026-04-15T04:05:12.069661Z","end":"2026-04-15T04:05:12.60796Z","steps":["trace[1064622762] 'process raft request' (duration: 122.881294ms)","trace[1064622762] 'compare' (duration: 414.315116ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T04:05:12.608138Z","caller":"traceutil/trace.go:171","msg":"trace[253007960] linearizableReadLoop","detail":"{readStateIndex:2253; appliedIndex:2252; }","duration":"491.388414ms","start":"2026-04-15T04:05:12.116729Z","end":"2026-04-15T04:05:12.608117Z","steps":["trace[253007960] 'read index received' (duration: 75.727147ms)","trace[253007960] 'applied index is now lower than readState.Index' (duration: 415.658187ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T04:05:12.608314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T04:05:12.069647Z","time spent":"538.430549ms","remote":"127.0.0.1:35890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6131,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T04:05:12.608346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.608707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7a4115df-68fc-4f08-bdcc-874a01e68d34\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-04-15T04:05:12.608393Z","caller":"traceutil/trace.go:171","msg":"trace[953886259] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7a4115df-68fc-4f08-bdcc-874a01e68d34; range_end:; response_count:1; response_revision:2155; }","duration":"491.684018ms","start":"2026-04-15T04:05:12.116689Z","end":"2026-04-15T04:05:12.608373Z","steps":["trace[953886259] 'agreement among raft nodes before linearized reading' (duration: 491.498486ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T04:05:12.608444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T04:05:12.11667Z","time spent":"491.76443ms","remote":"127.0.0.1:35890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7a4115df-68fc-4f08-bdcc-874a01e68d34\" "} {"level":"warn","ts":"2026-04-15T04:05:12.608996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.684875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-15T04:05:12.609068Z","caller":"traceutil/trace.go:171","msg":"trace[1874045370] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2156; }","duration":"481.779986ms","start":"2026-04-15T04:05:12.127271Z","end":"2026-04-15T04:05:12.609051Z","steps":["trace[1874045370] 'agreement among raft nodes before linearized reading' (duration: 481.518362ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T04:05:12.609104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.531196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T04:05:12.60914Z","caller":"traceutil/trace.go:171","msg":"trace[1054947965] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2156; }","duration":"459.594697ms","start":"2026-04-15T04:05:12.149538Z","end":"2026-04-15T04:05:12.609132Z","steps":["trace[1054947965] 'agreement among raft nodes before linearized reading' (duration: 459.541706ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T04:05:12.609161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T04:05:12.149521Z","time spent":"459.636607ms","remote":"127.0.0.1:35662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-15T04:05:12.609255Z","caller":"traceutil/trace.go:171","msg":"trace[882566372] transaction","detail":"{read_only:false; response_revision:2156; number_of_response:1; }","duration":"310.131471ms","start":"2026-04-15T04:05:12.299097Z","end":"2026-04-15T04:05:12.609228Z","steps":["trace[882566372] 'process raft request' (duration: 308.995835ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T04:05:12.609314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.48872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-15T04:05:12.609339Z","caller":"traceutil/trace.go:171","msg":"trace[1343324361] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2156; }","duration":"359.535201ms","start":"2026-04-15T04:05:12.249797Z","end":"2026-04-15T04:05:12.609332Z","steps":["trace[1343324361] 'agreement among raft nodes before linearized reading' (duration: 359.46872ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T04:05:12.609319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.113383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-81f53ab9-2b40-4c4e-8257-ec562890fa52\" ","response":"range_response_count:1 size:3736"} {"level":"warn","ts":"2026-04-15T04:05:12.609361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T04:05:12.249783Z","time spent":"359.573401ms","remote":"127.0.0.1:35984","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-15T04:05:12.609377Z","caller":"traceutil/trace.go:171","msg":"trace[2055135352] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-81f53ab9-2b40-4c4e-8257-ec562890fa52; range_end:; response_count:1; response_revision:2156; }","duration":"469.193824ms","start":"2026-04-15T04:05:12.140171Z","end":"2026-04-15T04:05:12.609365Z","steps":["trace[2055135352] 'agreement among raft nodes before linearized reading' (duration: 468.954571ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T04:05:12.60941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T04:05:12.14016Z","time spent":"469.242816ms","remote":"127.0.0.1:35890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3759,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-81f53ab9-2b40-4c4e-8257-ec562890fa52\" "} {"level":"warn","ts":"2026-04-15T04:05:12.609106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T04:05:12.127261Z","time spent":"481.836686ms","remote":"127.0.0.1:35984","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-15T04:05:12.6094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T04:05:12.299073Z","time spent":"310.250622ms","remote":"127.0.0.1:35882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8107,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T04:05:32.016069Z","caller":"traceutil/trace.go:171","msg":"trace[1171074224] transaction","detail":"{read_only:false; response_revision:2339; number_of_response:1; }","duration":"165.727917ms","start":"2026-04-15T04:05:31.850322Z","end":"2026-04-15T04:05:32.01605Z","steps":["trace[1171074224] 'process raft request' (duration: 165.603916ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T04:05:40.873796Z","caller":"traceutil/trace.go:171","msg":"trace[470450109] transaction","detail":"{read_only:false; response_revision:2386; number_of_response:1; }","duration":"160.624413ms","start":"2026-04-15T04:05:40.713154Z","end":"2026-04-15T04:05:40.873778Z","steps":["trace[470450109] 'process raft request' (duration: 99.959094ms)","trace[470450109] 'compare' (duration: 60.447507ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T04:05:47.906942Z","caller":"traceutil/trace.go:171","msg":"trace[974346708] transaction","detail":"{read_only:false; response_revision:2436; number_of_response:1; }","duration":"118.920695ms","start":"2026-04-15T04:05:47.787988Z","end":"2026-04-15T04:05:47.906908Z","steps":["trace[974346708] 'process raft request' (duration: 99.852734ms)","trace[974346708] 'compare' (duration: 18.765026ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T04:05:48.417928Z","caller":"traceutil/trace.go:171","msg":"trace[1993485601] transaction","detail":"{read_only:false; response_revision:2437; number_of_response:1; }","duration":"115.363345ms","start":"2026-04-15T04:05:48.302538Z","end":"2026-04-15T04:05:48.417901Z","steps":["trace[1993485601] 'process raft request' (duration: 115.190112ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T04:08:08.49265Z","caller":"traceutil/trace.go:171","msg":"trace[142130429] transaction","detail":"{read_only:false; response_revision:3264; number_of_response:1; }","duration":"128.285693ms","start":"2026-04-15T04:08:08.364341Z","end":"2026-04-15T04:08:08.492627Z","steps":["trace[142130429] 'process raft request' (duration: 128.106447ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T04:10:02.267928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.602194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T04:10:02.268018Z","caller":"traceutil/trace.go:171","msg":"trace[1289946332] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4020; }","duration":"118.738427ms","start":"2026-04-15T04:10:02.149262Z","end":"2026-04-15T04:10:02.268Z","steps":["trace[1289946332] 'range keys from in-memory index tree' (duration: 118.509442ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T04:10:02.399446Z","caller":"traceutil/trace.go:171","msg":"trace[1749797716] transaction","detail":"{read_only:false; response_revision:4021; number_of_response:1; }","duration":"238.207809ms","start":"2026-04-15T04:10:02.161213Z","end":"2026-04-15T04:10:02.39942Z","steps":["trace[1749797716] 'process raft request' (duration: 238.043696ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T04:10:02.40012Z","caller":"traceutil/trace.go:171","msg":"trace[1010186355] linearizableReadLoop","detail":"{readStateIndex:4185; appliedIndex:4185; }","duration":"171.892761ms","start":"2026-04-15T04:10:02.228184Z","end":"2026-04-15T04:10:02.400077Z","steps":["trace[1010186355] 'read index received' (duration: 171.878511ms)","trace[1010186355] 'applied index is now lower than readState.Index' (duration: 11.6µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T04:10:02.400429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.289245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T04:10:02.400474Z","caller":"traceutil/trace.go:171","msg":"trace[175313768] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4021; }","duration":"131.405748ms","start":"2026-04-15T04:10:02.269055Z","end":"2026-04-15T04:10:02.400461Z","steps":["trace[175313768] 'agreement among raft nodes before linearized reading' (duration: 131.286955ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T04:10:02.400751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.922774ms","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-04-15T04:10:02.400845Z","caller":"traceutil/trace.go:171","msg":"trace[1218747589] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4021; }","duration":"166.033077ms","start":"2026-04-15T04:10:02.234761Z","end":"2026-04-15T04:10:02.400794Z","steps":["trace[1218747589] 'agreement among raft nodes before linearized reading' (duration: 165.531915ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T04:10:02.40142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.228901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-15T04:10:02.401479Z","caller":"traceutil/trace.go:171","msg":"trace[1858504781] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4021; }","duration":"173.320214ms","start":"2026-04-15T04:10:02.228143Z","end":"2026-04-15T04:10:02.401463Z","steps":["trace[1858504781] 'agreement among raft nodes before linearized reading' (duration: 172.070985ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T04:10:02.519251Z","caller":"traceutil/trace.go:171","msg":"trace[179720889] transaction","detail":"{read_only:false; response_revision:4023; number_of_response:1; }","duration":"110.270791ms","start":"2026-04-15T04:10:02.40895Z","end":"2026-04-15T04:10:02.519221Z","steps":["trace[179720889] 'process raft request' (duration: 63.647357ms)","trace[179720889] 'compare' (duration: 46.254625ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T04:10:02.519599Z","caller":"traceutil/trace.go:171","msg":"trace[1445065818] transaction","detail":"{read_only:false; response_revision:4024; number_of_response:1; }","duration":"110.578368ms","start":"2026-04-15T04:10:02.408985Z","end":"2026-04-15T04:10:02.519563Z","steps":["trace[1445065818] 'process raft request' (duration: 110.151148ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T04:10:02.520564Z","caller":"traceutil/trace.go:171","msg":"trace[1949537233] transaction","detail":"{read_only:false; response_revision:4025; number_of_response:1; }","duration":"111.533341ms","start":"2026-04-15T04:10:02.409011Z","end":"2026-04-15T04:10:02.520544Z","steps":["trace[1949537233] 'process raft request' (duration: 110.337613ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T04:10:02.520573Z","caller":"traceutil/trace.go:171","msg":"trace[1592667369] transaction","detail":"{read_only:false; response_revision:4026; number_of_response:1; }","duration":"111.246804ms","start":"2026-04-15T04:10:02.409303Z","end":"2026-04-15T04:10:02.520549Z","steps":["trace[1592667369] 'process raft request' (duration: 111.149362ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T04:11:00.709963Z","caller":"traceutil/trace.go:171","msg":"trace[2018585328] transaction","detail":"{read_only:false; response_revision:4522; number_of_response:1; }","duration":"124.700823ms","start":"2026-04-15T04:11:00.585216Z","end":"2026-04-15T04:11:00.709917Z","steps":["trace[2018585328] 'process raft request' (duration: 43.928836ms)","trace[2018585328] 'compare' (duration: 80.548193ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T04:11:00.710033Z","caller":"traceutil/trace.go:171","msg":"trace[2019080569] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4522; }","duration":"123.006508ms","start":"2026-04-15T04:11:00.587002Z","end":"2026-04-15T04:11:00.710008Z","steps":["trace[2019080569] 'process raft request' (duration: 122.835714ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T04:11:12.044006Z","caller":"traceutil/trace.go:171","msg":"trace[126133787] transaction","detail":"{read_only:false; response_revision:4654; number_of_response:1; }","duration":"123.271956ms","start":"2026-04-15T04:11:11.920706Z","end":"2026-04-15T04:11:12.043978Z","steps":["trace[126133787] 'process raft request' (duration: 122.985639ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T04:11:49.226278Z","caller":"traceutil/trace.go:171","msg":"trace[1060599276] linearizableReadLoop","detail":"{readStateIndex:5577; appliedIndex:5576; }","duration":"121.147062ms","start":"2026-04-15T04:11:49.105107Z","end":"2026-04-15T04:11:49.226254Z","steps":["trace[1060599276] 'read index received' (duration: 81.624144ms)","trace[1060599276] 'applied index is now lower than readState.Index' (duration: 39.522308ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T04:11:49.226373Z","caller":"traceutil/trace.go:171","msg":"trace[99331924] transaction","detail":"{read_only:false; response_revision:5369; number_of_response:1; }","duration":"121.377398ms","start":"2026-04-15T04:11:49.104987Z","end":"2026-04-15T04:11:49.226364Z","steps":["trace[99331924] 'process raft request' (duration: 81.612315ms)","trace[99331924] 'compare' (duration: 39.567538ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T04:11:49.226535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.424259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-04-15T04:11:49.226576Z","caller":"traceutil/trace.go:171","msg":"trace[1322764104] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:5369; }","duration":"121.49324ms","start":"2026-04-15T04:11:49.105074Z","end":"2026-04-15T04:11:49.226567Z","steps":["trace[1322764104] 'agreement among raft nodes before linearized reading' (duration: 121.339567ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T04:11:49.251438Z","caller":"traceutil/trace.go:171","msg":"trace[435226274] transaction","detail":"{read_only:false; response_revision:5371; number_of_response:1; }","duration":"142.19179ms","start":"2026-04-15T04:11:49.109216Z","end":"2026-04-15T04:11:49.251408Z","steps":["trace[435226274] 'process raft request' (duration: 141.924945ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T04:11:49.251599Z","caller":"traceutil/trace.go:171","msg":"trace[1831333944] transaction","detail":"{read_only:false; response_revision:5370; number_of_response:1; }","duration":"146.296629ms","start":"2026-04-15T04:11:49.105287Z","end":"2026-04-15T04:11:49.251584Z","steps":["trace[1831333944] 'process raft request' (duration: 145.710077ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T04:11:49.251847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.408559ms","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-04-15T04:11:49.251874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.348616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T04:11:49.251892Z","caller":"traceutil/trace.go:171","msg":"trace[829947445] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5372; }","duration":"109.523462ms","start":"2026-04-15T04:11:49.142358Z","end":"2026-04-15T04:11:49.251881Z","steps":["trace[829947445] 'agreement among raft nodes before linearized reading' (duration: 109.369149ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T04:11:49.251921Z","caller":"traceutil/trace.go:171","msg":"trace[579872950] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5372; }","duration":"103.440337ms","start":"2026-04-15T04:11:49.148469Z","end":"2026-04-15T04:11:49.251909Z","steps":["trace[579872950] 'agreement among raft nodes before linearized reading' (duration: 103.367986ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T04:11:49.254864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.124323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-15T04:11:49.254903Z","caller":"traceutil/trace.go:171","msg":"trace[1925809135] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5372; }","duration":"120.201534ms","start":"2026-04-15T04:11:49.134692Z","end":"2026-04-15T04:11:49.254893Z","steps":["trace[1925809135] 'agreement among raft nodes before linearized reading' (duration: 117.531874ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T04:12:04.836331Z","caller":"traceutil/trace.go:171","msg":"trace[1841441802] transaction","detail":"{read_only:false; response_revision:5618; number_of_response:1; }","duration":"203.082022ms","start":"2026-04-15T04:12:04.63322Z","end":"2026-04-15T04:12:04.836302Z","steps":["trace[1841441802] 'process raft request' (duration: 202.929959ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T04:12:04.869292Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2873} {"level":"info","ts":"2026-04-15T04:12:04.95567Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2873,"took":"85.436876ms","hash":1344775706,"current-db-size-bytes":54571008,"current-db-size":"55 MB","current-db-size-in-use-bytes":30642176,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-15T04:12:04.955735Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1344775706,"revision":2873,"compact-revision":-1}