{"level":"warn","ts":"2026-05-09T12:48:02.191099Z","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-09T12:48:02.191183Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.95:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.95:2380","--initial-cluster=instance=https://199.204.45.95:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.95:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.95: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-09T12:48:02.191242Z","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-09T12:48:02.19125Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.95:2380"]} {"level":"info","ts":"2026-05-09T12:48:02.191268Z","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-09T12:48:02.191922Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"]} {"level":"info","ts":"2026-05-09T12:48:02.191987Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.95:2380"],"listen-peer-urls":["https://199.204.45.95:2380"],"advertise-client-urls":["https://199.204.45.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.95: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-09T12:48:02.195074Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.906467ms"} {"level":"info","ts":"2026-05-09T12:48:02.201744Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"be773dfc027af3eb","cluster-id":"9ba5fbd7288fd5af"} {"level":"info","ts":"2026-05-09T12:48:02.201846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=()"} {"level":"info","ts":"2026-05-09T12:48:02.201898Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became follower at term 0"} {"level":"info","ts":"2026-05-09T12:48:02.20193Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft be773dfc027af3eb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-09T12:48:02.201952Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became follower at term 1"} {"level":"info","ts":"2026-05-09T12:48:02.20202Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=(13724506542017541099)"} {"level":"warn","ts":"2026-05-09T12:48:02.211224Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-09T12:48:02.212606Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-09T12:48:02.2139Z","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-09T12:48:02.215833Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"be773dfc027af3eb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-09T12:48:02.216108Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"be773dfc027af3eb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-09T12:48:02.217221Z","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-09T12:48:02.218364Z","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-09T12:48:02.218378Z","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-09T12:48:02.219171Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=(13724506542017541099)"} {"level":"info","ts":"2026-05-09T12:48:02.219272Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9ba5fbd7288fd5af","local-member-id":"be773dfc027af3eb","added-peer-id":"be773dfc027af3eb","added-peer-peer-urls":["https://199.204.45.95:2380"]} {"level":"info","ts":"2026-05-09T12:48:02.219875Z","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-09T12:48:02.22004Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.95:2380"} {"level":"info","ts":"2026-05-09T12:48:02.220105Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.95:2380"} {"level":"info","ts":"2026-05-09T12:48:02.220119Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"be773dfc027af3eb","initial-advertise-peer-urls":["https://199.204.45.95:2380"],"listen-peer-urls":["https://199.204.45.95:2380"],"advertise-client-urls":["https://199.204.45.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-09T12:48:02.220146Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-09T12:48:03.102734Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb is starting a new election at term 1"} {"level":"info","ts":"2026-05-09T12:48:03.10279Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became pre-candidate at term 1"} {"level":"info","ts":"2026-05-09T12:48:03.102832Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb received MsgPreVoteResp from be773dfc027af3eb at term 1"} {"level":"info","ts":"2026-05-09T12:48:03.102858Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became candidate at term 2"} {"level":"info","ts":"2026-05-09T12:48:03.102874Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb received MsgVoteResp from be773dfc027af3eb at term 2"} {"level":"info","ts":"2026-05-09T12:48:03.102891Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became leader at term 2"} {"level":"info","ts":"2026-05-09T12:48:03.10291Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: be773dfc027af3eb elected leader be773dfc027af3eb at term 2"} {"level":"info","ts":"2026-05-09T12:48:03.10385Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T12:48:03.104545Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"be773dfc027af3eb","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.95:2379]}","request-path":"/0/members/be773dfc027af3eb/attributes","cluster-id":"9ba5fbd7288fd5af","publish-timeout":"7s"} {"level":"info","ts":"2026-05-09T12:48:03.104549Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-09T12:48:03.104614Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-09T12:48:03.104768Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-09T12:48:03.104838Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-09T12:48:03.105168Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9ba5fbd7288fd5af","local-member-id":"be773dfc027af3eb","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T12:48:03.105423Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T12:48:03.105474Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T12:48:03.106364Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.95:2379"} {"level":"info","ts":"2026-05-09T12:48:03.10704Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-09T12:48:39.11079Z","caller":"traceutil/trace.go:171","msg":"trace[665920066] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:651; }","duration":"126.331999ms","start":"2026-05-09T12:48:38.984437Z","end":"2026-05-09T12:48:39.110769Z","steps":["trace[665920066] 'read index received' (duration: 126.087737ms)","trace[665920066] 'applied index is now lower than readState.Index' (duration: 243.252µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:48:39.110929Z","caller":"traceutil/trace.go:171","msg":"trace[478836471] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"147.817702ms","start":"2026-05-09T12:48:38.963086Z","end":"2026-05-09T12:48:39.110903Z","steps":["trace[478836471] 'process raft request' (duration: 147.50591ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:48:39.111098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.458009ms","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-05-09T12:48:39.111222Z","caller":"traceutil/trace.go:171","msg":"trace[606256925] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:629; }","duration":"122.63508ms","start":"2026-05-09T12:48:38.988568Z","end":"2026-05-09T12:48:39.111203Z","steps":["trace[606256925] 'agreement among raft nodes before linearized reading' (duration: 122.376558ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:48:39.111339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.880474ms","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-09T12:48:39.111492Z","caller":"traceutil/trace.go:171","msg":"trace[703265161] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:629; }","duration":"127.070415ms","start":"2026-05-09T12:48:38.9844Z","end":"2026-05-09T12:48:39.11147Z","steps":["trace[703265161] 'agreement among raft nodes before linearized reading' (duration: 126.644032ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:09.378204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.351221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-09T12:50:09.37828Z","caller":"traceutil/trace.go:171","msg":"trace[1318783232] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1854; }","duration":"185.467414ms","start":"2026-05-09T12:50:09.192794Z","end":"2026-05-09T12:50:09.378261Z","steps":["trace[1318783232] 'range keys from in-memory index tree' (duration: 185.193756ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:50:23.89978Z","caller":"traceutil/trace.go:171","msg":"trace[1481523830] transaction","detail":"{read_only:false; response_revision:1981; number_of_response:1; }","duration":"242.335573ms","start":"2026-05-09T12:50:23.657418Z","end":"2026-05-09T12:50:23.899753Z","steps":["trace[1481523830] 'process raft request' (duration: 242.137918ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:50:23.907469Z","caller":"traceutil/trace.go:171","msg":"trace[422839387] linearizableReadLoop","detail":"{readStateIndex:2059; appliedIndex:2057; }","duration":"226.964979ms","start":"2026-05-09T12:50:23.680483Z","end":"2026-05-09T12:50:23.907448Z","steps":["trace[422839387] 'read index received' (duration: 219.134224ms)","trace[422839387] 'applied index is now lower than readState.Index' (duration: 7.829695ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:50:23.90755Z","caller":"traceutil/trace.go:171","msg":"trace[1801171424] transaction","detail":"{read_only:false; response_revision:1982; number_of_response:1; }","duration":"246.344298ms","start":"2026-05-09T12:50:23.661173Z","end":"2026-05-09T12:50:23.907518Z","steps":["trace[1801171424] 'process raft request' (duration: 246.075852ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:50:23.907591Z","caller":"traceutil/trace.go:171","msg":"trace[138038692] transaction","detail":"{read_only:false; response_revision:1983; number_of_response:1; }","duration":"215.519098ms","start":"2026-05-09T12:50:23.692062Z","end":"2026-05-09T12:50:23.907581Z","steps":["trace[138038692] 'process raft request' (duration: 215.319423ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:23.9078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.304267ms","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-05-09T12:50:23.90783Z","caller":"traceutil/trace.go:171","msg":"trace[953086996] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1983; }","duration":"227.382659ms","start":"2026-05-09T12:50:23.680439Z","end":"2026-05-09T12:50:23.907821Z","steps":["trace[953086996] 'agreement among raft nodes before linearized reading' (duration: 227.269027ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:50:48.154898Z","caller":"traceutil/trace.go:171","msg":"trace[245563032] linearizableReadLoop","detail":"{readStateIndex:2201; appliedIndex:2199; }","duration":"153.045517ms","start":"2026-05-09T12:50:48.00183Z","end":"2026-05-09T12:50:48.154875Z","steps":["trace[245563032] 'read index received' (duration: 22.96629ms)","trace[245563032] 'applied index is now lower than readState.Index' (duration: 130.077777ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:50:48.15503Z","caller":"traceutil/trace.go:171","msg":"trace[1637789463] transaction","detail":"{read_only:false; response_revision:2119; number_of_response:1; }","duration":"175.352476ms","start":"2026-05-09T12:50:47.979658Z","end":"2026-05-09T12:50:48.155011Z","steps":["trace[1637789463] 'process raft request' (duration: 167.245947ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:48.155143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.294752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-09T12:50:48.155288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.025339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-05-09T12:50:48.15535Z","caller":"traceutil/trace.go:171","msg":"trace[1357734085] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2119; }","duration":"148.10223ms","start":"2026-05-09T12:50:48.007233Z","end":"2026-05-09T12:50:48.155336Z","steps":["trace[1357734085] 'agreement among raft nodes before linearized reading' (duration: 147.912136ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:48.155329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.366613ms","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-09T12:50:48.155458Z","caller":"traceutil/trace.go:171","msg":"trace[543899144] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2119; }","duration":"153.549237ms","start":"2026-05-09T12:50:48.001891Z","end":"2026-05-09T12:50:48.15544Z","steps":["trace[543899144] 'agreement among raft nodes before linearized reading' (duration: 153.230041ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:50:48.155205Z","caller":"traceutil/trace.go:171","msg":"trace[1331836218] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2119; }","duration":"153.407604ms","start":"2026-05-09T12:50:48.001787Z","end":"2026-05-09T12:50:48.155195Z","steps":["trace[1331836218] 'agreement among raft nodes before linearized reading' (duration: 153.228661ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:48.476725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.076313ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-09T12:50:48.47708Z","caller":"traceutil/trace.go:171","msg":"trace[1209670360] transaction","detail":"{read_only:false; response_revision:2122; number_of_response:1; }","duration":"315.455487ms","start":"2026-05-09T12:50:48.161607Z","end":"2026-05-09T12:50:48.477062Z","steps":["trace[1209670360] 'process raft request' (duration: 315.393166ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:48.477153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:48.161596Z","time spent":"315.523688ms","remote":"127.0.0.1:56878","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T12:50:48.477259Z","caller":"traceutil/trace.go:171","msg":"trace[1683178185] transaction","detail":"{read_only:false; response_revision:2121; number_of_response:1; }","duration":"316.306204ms","start":"2026-05-09T12:50:48.160932Z","end":"2026-05-09T12:50:48.477239Z","steps":["trace[1683178185] 'process raft request' (duration: 128.17872ms)","trace[1683178185] 'compare' (duration: 186.978791ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T12:50:48.477365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:48.160901Z","time spent":"316.408456ms","remote":"127.0.0.1:56878","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T12:50:48.47857Z","caller":"traceutil/trace.go:171","msg":"trace[1763650555] transaction","detail":"{read_only:false; response_revision:2123; number_of_response:1; }","duration":"154.066766ms","start":"2026-05-09T12:50:48.324485Z","end":"2026-05-09T12:50:48.478552Z","steps":["trace[1763650555] 'process raft request' (duration: 153.900763ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:52:12.97177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.563117ms","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-09T12:52:12.971844Z","caller":"traceutil/trace.go:171","msg":"trace[1203605342] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2685; }","duration":"114.671198ms","start":"2026-05-09T12:52:12.857158Z","end":"2026-05-09T12:52:12.97183Z","steps":["trace[1203605342] 'range keys from in-memory index tree' (duration: 114.430195ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:52:13.146473Z","caller":"traceutil/trace.go:171","msg":"trace[1852595287] transaction","detail":"{read_only:false; response_revision:2688; number_of_response:1; }","duration":"169.045647ms","start":"2026-05-09T12:52:12.97741Z","end":"2026-05-09T12:52:13.146456Z","steps":["trace[1852595287] 'process raft request' (duration: 168.996947ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:52:13.146602Z","caller":"traceutil/trace.go:171","msg":"trace[1488830627] transaction","detail":"{read_only:false; response_revision:2687; number_of_response:1; }","duration":"170.815381ms","start":"2026-05-09T12:52:12.975781Z","end":"2026-05-09T12:52:13.146596Z","steps":["trace[1488830627] 'process raft request' (duration: 170.523817ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:52:13.146665Z","caller":"traceutil/trace.go:171","msg":"trace[1961718406] linearizableReadLoop","detail":"{readStateIndex:2789; appliedIndex:2787; }","duration":"170.583788ms","start":"2026-05-09T12:52:12.976075Z","end":"2026-05-09T12:52:13.146659Z","steps":["trace[1961718406] 'read index received' (duration: 34.287497ms)","trace[1961718406] 'applied index is now lower than readState.Index' (duration: 136.295781ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:52:13.146978Z","caller":"traceutil/trace.go:171","msg":"trace[1757663720] transaction","detail":"{read_only:false; response_revision:2689; number_of_response:1; }","duration":"168.54898ms","start":"2026-05-09T12:52:12.978415Z","end":"2026-05-09T12:52:13.146964Z","steps":["trace[1757663720] 'process raft request' (duration: 168.014133ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:52:13.147187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.092325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18ade6b9a9cda55a\" ","response":"range_response_count:1 size:779"} {"level":"info","ts":"2026-05-09T12:52:13.147328Z","caller":"traceutil/trace.go:171","msg":"trace[524007559] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18ade6b9a9cda55a; range_end:; response_count:1; response_revision:2689; }","duration":"171.262637ms","start":"2026-05-09T12:52:12.976048Z","end":"2026-05-09T12:52:13.14731Z","steps":["trace[524007559] 'agreement among raft nodes before linearized reading' (duration: 171.030373ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:52:13.462475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.511602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:52:13.46258Z","caller":"traceutil/trace.go:171","msg":"trace[638295428] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:2690; }","duration":"178.946917ms","start":"2026-05-09T12:52:13.283599Z","end":"2026-05-09T12:52:13.462546Z","steps":["trace[638295428] 'count revisions from in-memory index tree' (duration: 178.392541ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:53:03.046391Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576315748472632115,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-09T12:53:03.426354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"948.88225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-09T12:53:03.426427Z","caller":"traceutil/trace.go:171","msg":"trace[133701705] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:2943; }","duration":"948.968421ms","start":"2026-05-09T12:53:02.477442Z","end":"2026-05-09T12:53:03.42641Z","steps":["trace[133701705] 'count revisions from in-memory index tree' (duration: 948.791179ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:53:03.426458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:53:02.477361Z","time spent":"949.088452ms","remote":"127.0.0.1:57146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":2,"response size":31,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-05-09T12:53:03.426606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.106377803s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-09T12:53:03.426631Z","caller":"traceutil/trace.go:171","msg":"trace[598681078] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2943; }","duration":"1.106439163s","start":"2026-05-09T12:53:02.320185Z","end":"2026-05-09T12:53:03.426625Z","steps":["trace[598681078] 'range keys from in-memory index tree' (duration: 1.106254381s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:53:03.426654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:53:02.320167Z","time spent":"1.106475715s","remote":"127.0.0.1:56878","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-09T12:53:03.429918Z","caller":"traceutil/trace.go:171","msg":"trace[1601519993] transaction","detail":"{read_only:false; response_revision:2944; number_of_response:1; }","duration":"936.555211ms","start":"2026-05-09T12:53:02.493352Z","end":"2026-05-09T12:53:03.429907Z","steps":["trace[1601519993] 'process raft request' (duration: 936.43857ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:53:03.430001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:53:02.493306Z","time spent":"936.644212ms","remote":"127.0.0.1:56878","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T12:53:03.43095Z","caller":"traceutil/trace.go:171","msg":"trace[1112129611] linearizableReadLoop","detail":"{readStateIndex:3059; appliedIndex:3055; }","duration":"890.278172ms","start":"2026-05-09T12:53:02.54066Z","end":"2026-05-09T12:53:03.430939Z","steps":["trace[1112129611] 'read index received' (duration: 889.139258ms)","trace[1112129611] 'applied index is now lower than readState.Index' (duration: 1.138254ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:53:03.431005Z","caller":"traceutil/trace.go:171","msg":"trace[1098058351] transaction","detail":"{read_only:false; response_revision:2947; number_of_response:1; }","duration":"431.972383ms","start":"2026-05-09T12:53:02.999026Z","end":"2026-05-09T12:53:03.430998Z","steps":["trace[1098058351] 'process raft request' (duration: 431.872902ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:53:03.431059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:53:02.998999Z","time spent":"432.032504ms","remote":"127.0.0.1:56878","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T12:53:03.43105Z","caller":"traceutil/trace.go:171","msg":"trace[668314212] transaction","detail":"{read_only:false; response_revision:2945; number_of_response:1; }","duration":"720.571971ms","start":"2026-05-09T12:53:02.710444Z","end":"2026-05-09T12:53:03.431016Z","steps":["trace[668314212] 'process raft request' (duration: 720.363168ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:53:03.431182Z","caller":"traceutil/trace.go:171","msg":"trace[614507880] transaction","detail":"{read_only:false; response_revision:2948; number_of_response:1; }","duration":"309.563637ms","start":"2026-05-09T12:53:03.121609Z","end":"2026-05-09T12:53:03.431173Z","steps":["trace[614507880] 'process raft request' (duration: 309.308794ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:53:03.431216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:53:02.710421Z","time spent":"720.711353ms","remote":"127.0.0.1:56878","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T12:53:03.431226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:53:03.121579Z","time spent":"309.626377ms","remote":"127.0.0.1:56634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T12:53:03.431418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"890.748227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:53:03.431481Z","caller":"traceutil/trace.go:171","msg":"trace[1489954129] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:2949; }","duration":"890.823348ms","start":"2026-05-09T12:53:02.540642Z","end":"2026-05-09T12:53:03.431465Z","steps":["trace[1489954129] 'agreement among raft nodes before linearized reading' (duration: 890.688667ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:53:03.431535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:53:02.540621Z","time spent":"890.90569ms","remote":"127.0.0.1:44416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-09T12:53:03.43157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.098354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18ade6b9a9cda55a\" ","response":"range_response_count:1 size:779"} {"level":"info","ts":"2026-05-09T12:53:03.431591Z","caller":"traceutil/trace.go:171","msg":"trace[965415264] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18ade6b9a9cda55a; range_end:; response_count:1; response_revision:2949; }","duration":"456.160006ms","start":"2026-05-09T12:53:02.975423Z","end":"2026-05-09T12:53:03.431583Z","steps":["trace[965415264] 'agreement among raft nodes before linearized reading' (duration: 456.092595ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:53:03.431606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.580482ms","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-05-09T12:53:03.431648Z","caller":"traceutil/trace.go:171","msg":"trace[511538579] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2949; }","duration":"152.623732ms","start":"2026-05-09T12:53:03.279012Z","end":"2026-05-09T12:53:03.431636Z","steps":["trace[511538579] 'agreement among raft nodes before linearized reading' (duration: 152.46376ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:53:03.431444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"656.003451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"warn","ts":"2026-05-09T12:53:03.431689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.417265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-09T12:53:03.431744Z","caller":"traceutil/trace.go:171","msg":"trace[941963635] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2949; }","duration":"502.538086ms","start":"2026-05-09T12:53:02.929198Z","end":"2026-05-09T12:53:03.431737Z","steps":["trace[941963635] 'agreement among raft nodes before linearized reading' (duration: 502.408705ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:53:03.431766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:53:02.929161Z","time spent":"502.598287ms","remote":"127.0.0.1:56878","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-09T12:53:03.431619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:53:02.975402Z","time spent":"456.214166ms","remote":"127.0.0.1:56698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":803,"request content":"key:\"/registry/events/auth-system/keycloak-0.18ade6b9a9cda55a\" "} {"level":"info","ts":"2026-05-09T12:53:03.431722Z","caller":"traceutil/trace.go:171","msg":"trace[258113159] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2949; }","duration":"656.326084ms","start":"2026-05-09T12:53:02.775391Z","end":"2026-05-09T12:53:03.431717Z","steps":["trace[258113159] 'agreement among raft nodes before linearized reading' (duration: 655.95824ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:53:03.431864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:53:02.775343Z","time spent":"656.508597ms","remote":"127.0.0.1:56802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12236,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-05-09T12:53:03.432137Z","caller":"traceutil/trace.go:171","msg":"trace[249119842] transaction","detail":"{read_only:false; response_revision:2946; number_of_response:1; }","duration":"432.859084ms","start":"2026-05-09T12:53:02.998953Z","end":"2026-05-09T12:53:03.431812Z","steps":["trace[249119842] 'process raft request' (duration: 431.918783ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:53:03.432239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:53:02.998908Z","time spent":"433.265959ms","remote":"127.0.0.1:56878","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T12:55:00.218703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.739924ms","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-05-09T12:55:00.218776Z","caller":"traceutil/trace.go:171","msg":"trace[240828289] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3663; }","duration":"204.854307ms","start":"2026-05-09T12:55:00.013909Z","end":"2026-05-09T12:55:00.218763Z","steps":["trace[240828289] 'range keys from in-memory index tree' (duration: 204.587451ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:55:00.218852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.378324ms","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-09T12:55:00.218965Z","caller":"traceutil/trace.go:171","msg":"trace[1478097124] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3663; }","duration":"204.521148ms","start":"2026-05-09T12:55:00.014418Z","end":"2026-05-09T12:55:00.218939Z","steps":["trace[1478097124] 'range keys from in-memory index tree' (duration: 204.164719ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:55:00.219022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.700661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secrettemplates/monitoring/kube-prometheus-stack-prometheus-oauth2-proxy\" ","response":"range_response_count:1 size:2872"} {"level":"info","ts":"2026-05-09T12:55:00.21916Z","caller":"traceutil/trace.go:171","msg":"trace[743606502] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secrettemplates/monitoring/kube-prometheus-stack-prometheus-oauth2-proxy; range_end:; response_count:1; response_revision:3663; }","duration":"124.852806ms","start":"2026-05-09T12:55:00.094281Z","end":"2026-05-09T12:55:00.219134Z","steps":["trace[743606502] 'range keys from in-memory index tree' (duration: 124.455105ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:55:53.10319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.826969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-29d46fa3-15c7-47a3-8f07-2b620b9438ac\" ","response":"range_response_count:1 size:3773"} {"level":"info","ts":"2026-05-09T12:55:53.103297Z","caller":"traceutil/trace.go:171","msg":"trace[1193272648] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-29d46fa3-15c7-47a3-8f07-2b620b9438ac; range_end:; response_count:1; response_revision:4471; }","duration":"150.998613ms","start":"2026-05-09T12:55:52.952276Z","end":"2026-05-09T12:55:53.103275Z","steps":["trace[1193272648] 'range keys from in-memory index tree' (duration: 150.619214ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:55:53.1041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.070141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2195922"} {"level":"info","ts":"2026-05-09T12:55:53.104213Z","caller":"traceutil/trace.go:171","msg":"trace[675261028] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4471; }","duration":"153.237785ms","start":"2026-05-09T12:55:52.950953Z","end":"2026-05-09T12:55:53.10419Z","steps":["trace[675261028] 'range keys from in-memory index tree' (duration: 152.133599ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:56:00.517556Z","caller":"traceutil/trace.go:171","msg":"trace[1236902358] transaction","detail":"{read_only:false; response_revision:4571; number_of_response:1; }","duration":"140.76256ms","start":"2026-05-09T12:56:00.376764Z","end":"2026-05-09T12:56:00.517527Z","steps":["trace[1236902358] 'process raft request' (duration: 119.164355ms)","trace[1236902358] 'compare' (duration: 21.486183ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:56:00.528348Z","caller":"traceutil/trace.go:171","msg":"trace[76991407] transaction","detail":"{read_only:false; response_revision:4572; number_of_response:1; }","duration":"149.691081ms","start":"2026-05-09T12:56:00.378629Z","end":"2026-05-09T12:56:00.52832Z","steps":["trace[76991407] 'process raft request' (duration: 149.480906ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:56:00.528543Z","caller":"traceutil/trace.go:171","msg":"trace[605700781] transaction","detail":"{read_only:false; response_revision:4573; number_of_response:1; }","duration":"148.562246ms","start":"2026-05-09T12:56:00.379959Z","end":"2026-05-09T12:56:00.528521Z","steps":["trace[605700781] 'process raft request' (duration: 148.2878ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:56:00.966856Z","caller":"traceutil/trace.go:171","msg":"trace[2009617873] transaction","detail":"{read_only:false; response_revision:4589; number_of_response:1; }","duration":"119.433812ms","start":"2026-05-09T12:56:00.847381Z","end":"2026-05-09T12:56:00.966815Z","steps":["trace[2009617873] 'process raft request' (duration: 50.865402ms)","trace[2009617873] 'compare' (duration: 68.218642ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:56:00.966938Z","caller":"traceutil/trace.go:171","msg":"trace[1598562422] transaction","detail":"{read_only:false; response_revision:4590; number_of_response:1; }","duration":"118.283046ms","start":"2026-05-09T12:56:00.848627Z","end":"2026-05-09T12:56:00.96691Z","steps":["trace[1598562422] 'process raft request' (duration: 118.03625ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:56:08.32875Z","caller":"traceutil/trace.go:171","msg":"trace[2134811859] transaction","detail":"{read_only:false; response_revision:4765; number_of_response:1; }","duration":"174.955033ms","start":"2026-05-09T12:56:08.153768Z","end":"2026-05-09T12:56:08.328723Z","steps":["trace[2134811859] 'process raft request' (duration: 174.839941ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:56:08.328829Z","caller":"traceutil/trace.go:171","msg":"trace[145041302] transaction","detail":"{read_only:false; response_revision:4763; number_of_response:1; }","duration":"189.399881ms","start":"2026-05-09T12:56:08.139389Z","end":"2026-05-09T12:56:08.328789Z","steps":["trace[145041302] 'process raft request' (duration: 88.150657ms)","trace[145041302] 'compare' (duration: 99.047665ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:56:08.328942Z","caller":"traceutil/trace.go:171","msg":"trace[391213863] transaction","detail":"{read_only:false; response_revision:4764; number_of_response:1; }","duration":"175.581727ms","start":"2026-05-09T12:56:08.153223Z","end":"2026-05-09T12:56:08.328804Z","steps":["trace[391213863] 'process raft request' (duration: 173.740167ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:56:08.582138Z","caller":"traceutil/trace.go:171","msg":"trace[858110143] linearizableReadLoop","detail":"{readStateIndex:4947; appliedIndex:4946; }","duration":"162.301256ms","start":"2026-05-09T12:56:08.419822Z","end":"2026-05-09T12:56:08.582124Z","steps":["trace[858110143] 'read index received' (duration: 159.267739ms)","trace[858110143] 'applied index is now lower than readState.Index' (duration: 3.032677ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:56:08.582329Z","caller":"traceutil/trace.go:171","msg":"trace[1545493012] transaction","detail":"{read_only:false; response_revision:4766; number_of_response:1; }","duration":"176.067447ms","start":"2026-05-09T12:56:08.406226Z","end":"2026-05-09T12:56:08.582293Z","steps":["trace[1545493012] 'process raft request' (duration: 172.945639ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:56:08.582713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.892338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2bb54f2f-724a-4820-b9d5-34d72bc49ba3\" ","response":"range_response_count:1 size:3762"} {"level":"info","ts":"2026-05-09T12:56:08.583077Z","caller":"traceutil/trace.go:171","msg":"trace[1647602557] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2bb54f2f-724a-4820-b9d5-34d72bc49ba3; range_end:; response_count:1; response_revision:4766; }","duration":"163.284947ms","start":"2026-05-09T12:56:08.41976Z","end":"2026-05-09T12:56:08.583045Z","steps":["trace[1647602557] 'agreement among raft nodes before linearized reading' (duration: 162.450438ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:56:08.58321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.033739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-09T12:56:08.583284Z","caller":"traceutil/trace.go:171","msg":"trace[1887144310] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:4766; }","duration":"131.200852ms","start":"2026-05-09T12:56:08.452065Z","end":"2026-05-09T12:56:08.583266Z","steps":["trace[1887144310] 'agreement among raft nodes before linearized reading' (duration: 130.270341ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:58:03.436345Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2948} {"level":"info","ts":"2026-05-09T12:58:03.560462Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2948,"took":"122.638915ms","hash":1739817079,"current-db-size-bytes":53846016,"current-db-size":"54 MB","current-db-size-in-use-bytes":29319168,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-09T12:58:03.560555Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1739817079,"revision":2948,"compact-revision":-1} {"level":"info","ts":"2026-05-09T13:03:03.442683Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5650} {"level":"info","ts":"2026-05-09T13:03:03.525545Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5650,"took":"81.845909ms","hash":1026426726,"current-db-size-bytes":53846016,"current-db-size":"54 MB","current-db-size-in-use-bytes":18096128,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-09T13:03:03.525722Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1026426726,"revision":5650,"compact-revision":2948}