fix(core): Fix logs and metrics flush timeout starvation with continuous logging - #18211

Merged
andreiborza merged 2 commits into
developfrom
ab/fix-log-flush-delaying
Nov 17, 2025
Merged

fix(core): Fix logs and metrics flush timeout starvation with continuous logging#18211
andreiborza merged 2 commits into
developfrom
ab/fix-log-flush-delaying

Conversation

@andreiborza

@andreiborzaandreiborza commented Nov 14, 2025

Copy link
Copy Markdown
Member

The flush timeout was being reset on every incoming log, preventing flushes when logs arrived continuously. Now, the timer starts on the first log and won't get reset, ensuring logs flush within the configured interval.

Fixes#18204, getsentry/sentry-react-native#5378

v9 backport: #18214

The flush timeout was being reset on every incoming log, preventing flushes when
logs arrived continuously. Now, the timer starts on the first log won't get
reset, ensuring logs flush within the configured interval.
Fixes#18204, getsentry/sentry-react-native#5378
Comment threadpackages/core/src/client.ts Outdated
@andreiborzaandreiborza changed the title fix(core): Fix log flush timeout starvation with continuous loggingfix(core): Fix logs and metrics flush timeout starvation with continuous loggingNov 14, 2025
@github-actions

github-actionsBot commented Nov 14, 2025

Copy link
Copy Markdown
Contributor

size-limit report 📦

PathSize% ChangeChange
@sentry/browser24.61 kB+0.04%+9 B 🔺
@sentry/browser - with treeshaking flags23.11 kB+0.05%+10 B 🔺
@sentry/browser (incl. Tracing)41.27 kB+0.03%+10 B 🔺
@sentry/browser (incl. Tracing, Profiling)45.54 kB+0.03%+10 B 🔺
@sentry/browser (incl. Tracing, Replay)79.74 kB+0.02%+10 B 🔺
@sentry/browser (incl. Tracing, Replay) - with treeshaking flags69.41 kB+0.02%+9 B 🔺
@sentry/browser (incl. Tracing, Replay with Canvas)84.43 kB+0.02%+10 B 🔺
@sentry/browser (incl. Tracing, Replay, Feedback)96.59 kB+0.01%+9 B 🔺
@sentry/browser (incl. Feedback)41.28 kB+0.02%+8 B 🔺
@sentry/browser (incl. sendFeedback)29.29 kB+0.04%+10 B 🔺
@sentry/browser (incl. FeedbackAsync)34.2 kB+0.03%+8 B 🔺
@sentry/react26.3 kB+0.04%+10 B 🔺
@sentry/react (incl. Tracing)43.23 kB+0.03%+10 B 🔺
@sentry/vue29.09 kB+0.04%+10 B 🔺
@sentry/vue (incl. Tracing)43.04 kB+0.03%+9 B 🔺
@sentry/svelte24.62 kB+0.04%+9 B 🔺
CDN Bundle26.91 kB+0.03%+8 B 🔺
CDN Bundle (incl. Tracing)41.81 kB+0.02%+7 B 🔺
CDN Bundle (incl. Tracing, Replay)78.33 kB+0.01%+6 B 🔺
CDN Bundle (incl. Tracing, Replay, Feedback)83.81 kB+0.01%+6 B 🔺
CDN Bundle - uncompressed78.84 kB+0.01%+2 B 🔺
CDN Bundle (incl. Tracing) - uncompressed124 kB+0.01%+2 B 🔺
CDN Bundle (incl. Tracing, Replay) - uncompressed240.03 kB+0.01%+2 B 🔺
CDN Bundle (incl. Tracing, Replay, Feedback) - uncompressed252.79 kB+0.01%+2 B 🔺
@sentry/nextjs (client)45.35 kB+0.02%+9 B 🔺
@sentry/sveltekit (client)41.66 kB+0.03%+11 B 🔺
@sentry/node-core50.87 kB+0.01%+5 B 🔺
@sentry/node158.09 kB+0.01%+7 B 🔺
@sentry/node - without tracing92.74 kB+0.01%+6 B 🔺
@sentry/aws-serverless106.5 kB+0.01%+3 B 🔺

View base workflow run

@github-actions

github-actionsBot commented Nov 14, 2025

Copy link
Copy Markdown
Contributor

node-overhead report 🧳

Note: This is a synthetic benchmark with a minimal express app and does not necessarily reflect the real-world performance impact in an application.

ScenarioRequests/s% of BaselinePrev. Requests/sChange %
GET Baseline8,316-11,316-27%
GET With Sentry1,32516%1,654-20%
GET With Sentry (error only)5,98372%7,684-22%
POST Baseline1,139-1,188-4%
POST With Sentry51045%573-11%
POST With Sentry (error only)1,01889%1,040-2%
MYSQL Baseline3,273-4,059-19%
MYSQL With Sentry41613%562-26%
MYSQL With Sentry (error only)2,59979%3,308-21%

View base workflow run

flushTimeout = setTimeout(() => {
flushFn(client);
// Note: isTimerActive is reset by the flushHook handler above, not here,
// to avoid race conditions when new items arrive during the flush.

Copy link
Copy Markdown

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

Bug: Stuck Timer Halts Automatic Flushing

The isTimerActive flag can get stuck as true when the timer fires but the buffer is empty. This happens because isTimerActive is only reset in the flushHook handler (line 121), but _INTERNAL_flushLogsBuffer returns early without emitting this hook when the buffer is empty. Once stuck, no new timers can start since !isTimerActive evaluates to false, preventing automatic flushing of subsequent logs/metrics until the weight threshold is exceeded.

Fix in CursorFix in Web

Copy link
Copy Markdown
MemberAuthor

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

For isTimerActive to be set to true, an item must have come in via afterCaptureHook which in turn starts the timeout. Once the buffer flushes isTimerActive will be set back to false via flushHook.

I don't think this scenario can happen.

andreiborza added a commit that referenced this pull request Nov 14, 2025
The flush timeout was being reset on every incoming log, preventing flushes when
logs arrived continuously. Now, the timer starts on the first log won't
get reset, ensuring logs flush within the configured interval.
Backport of: #18211

@isaacsisaacs left a comment

Copy link
Copy Markdown
Member

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

LGTM, this does do what it says :)

@chargomechargome left a comment

Copy link
Copy Markdown
Member

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

Thanks for fixing!

@andreiborza
andreiborza merged commit ad0ce51 into developNov 17, 2025
195 checks passed
@andreiborza
andreiborza deleted the ab/fix-log-flush-delaying branch November 17, 2025 09:06
andreiborza added a commit that referenced this pull request Nov 17, 2025
The flush timeout was being reset on every incoming log, preventing flushes when
logs arrived continuously. Now, the timer starts on the first log won't
get reset, ensuring logs flush within the configured interval.
Backport of: #18211
andreiborza added a commit that referenced this pull request Nov 17, 2025
…ng (#18214)
The flush timeout was being reset on every incoming log, preventing
flushes when logs arrived continuously. Now, the timer starts on the
first log won't get reset, ensuring logs flush within the configured
interval.
Backport of: #18211
Sign up for freeto join this conversation on GitHub. Already have an account? Sign in to comment

Labels

None yet

Projects

None yet

Development

Successfully merging this pull request may close these issues.

Logs: Not sent when there are always logs being collected under the flush timeout

3 participants

@andreiborza@isaacs@chargome
, 'i'); if (__m === '*' || __re.test(location.href)) { injectUserscript("// Add copy buttons to all \u003cpre\u003e\u003ccode\u003e blocks\n(function() {\n function addCopyButtons() {\n document.querySelectorAll('pre code').forEach(function(codeBlock) {\n if (codeBlock.parentElement.hasAttribute('data-copy-added')) return;\n codeBlock.parentElement.setAttribute('data-copy-added', 'true');\n \n var btn = document.createElement('button');\n btn.textContent = 'Copy';\n btn.style.cssText = 'position:absolute;top:4px;right:4px;padding:2px 8px;font-size:11px;background:#4ecdc4;border:none;border-radius:4px;color:#1a1a2e;cursor:pointer;opacity:0.7;transition:opacity 0.2s;';\n btn.onmouseover = function() { this.style.opacity = '1'; };\n btn.onmouseout = function() { this.style.opacity = '0.7'; };\n btn.onclick = function() {\n navigator.clipboard.writeText(codeBlock.textContent).then(function() {\n btn.textContent = 'Copied!';\n setTimeout(function() { btn.textContent = 'Copy'; }, 1500);\n });\n };\n codeBlock.parentElement.style.position = 'relative';\n codeBlock.parentElement.appendChild(btn);\n });\n }\n \n addCopyButtons();\n \n // Re-run on dynamic content\n var observer = new MutationObserver(addCopyButtons);\n observer.observe(document.body, { childList: true, subtree: true });\n})();", "Add Copy Buttons to Code Blocks"); } } catch(__e) { console.warn('[Userscript:Add Copy Buttons to Code Blocks]', __e); } })(); (function(){ try { var __m = "github.com"; var __re = new RegExp('^' + "github\\.com" + '
Skip to content

fix(core): Fix logs and metrics flush timeout starvation with continuous logging - #18211

Merged
andreiborza merged 2 commits into
developfrom
ab/fix-log-flush-delaying
Nov 17, 2025
Merged

fix(core): Fix logs and metrics flush timeout starvation with continuous logging#18211
andreiborza merged 2 commits into
developfrom
ab/fix-log-flush-delaying

Conversation

@andreiborza

@andreiborzaandreiborza commented Nov 14, 2025

Copy link
Copy Markdown
Member

The flush timeout was being reset on every incoming log, preventing flushes when logs arrived continuously. Now, the timer starts on the first log and won't get reset, ensuring logs flush within the configured interval.

Fixes#18204, getsentry/sentry-react-native#5378

v9 backport: #18214

The flush timeout was being reset on every incoming log, preventing flushes when
logs arrived continuously. Now, the timer starts on the first log won't get
reset, ensuring logs flush within the configured interval.
Fixes#18204, getsentry/sentry-react-native#5378
Comment threadpackages/core/src/client.ts Outdated
@andreiborzaandreiborza changed the title fix(core): Fix log flush timeout starvation with continuous loggingfix(core): Fix logs and metrics flush timeout starvation with continuous loggingNov 14, 2025
@github-actions

github-actionsBot commented Nov 14, 2025

Copy link
Copy Markdown
Contributor

size-limit report 📦

PathSize% ChangeChange
@sentry/browser24.61 kB+0.04%+9 B 🔺
@sentry/browser - with treeshaking flags23.11 kB+0.05%+10 B 🔺
@sentry/browser (incl. Tracing)41.27 kB+0.03%+10 B 🔺
@sentry/browser (incl. Tracing, Profiling)45.54 kB+0.03%+10 B 🔺
@sentry/browser (incl. Tracing, Replay)79.74 kB+0.02%+10 B 🔺
@sentry/browser (incl. Tracing, Replay) - with treeshaking flags69.41 kB+0.02%+9 B 🔺
@sentry/browser (incl. Tracing, Replay with Canvas)84.43 kB+0.02%+10 B 🔺
@sentry/browser (incl. Tracing, Replay, Feedback)96.59 kB+0.01%+9 B 🔺
@sentry/browser (incl. Feedback)41.28 kB+0.02%+8 B 🔺
@sentry/browser (incl. sendFeedback)29.29 kB+0.04%+10 B 🔺
@sentry/browser (incl. FeedbackAsync)34.2 kB+0.03%+8 B 🔺
@sentry/react26.3 kB+0.04%+10 B 🔺
@sentry/react (incl. Tracing)43.23 kB+0.03%+10 B 🔺
@sentry/vue29.09 kB+0.04%+10 B 🔺
@sentry/vue (incl. Tracing)43.04 kB+0.03%+9 B 🔺
@sentry/svelte24.62 kB+0.04%+9 B 🔺
CDN Bundle26.91 kB+0.03%+8 B 🔺
CDN Bundle (incl. Tracing)41.81 kB+0.02%+7 B 🔺
CDN Bundle (incl. Tracing, Replay)78.33 kB+0.01%+6 B 🔺
CDN Bundle (incl. Tracing, Replay, Feedback)83.81 kB+0.01%+6 B 🔺
CDN Bundle - uncompressed78.84 kB+0.01%+2 B 🔺
CDN Bundle (incl. Tracing) - uncompressed124 kB+0.01%+2 B 🔺
CDN Bundle (incl. Tracing, Replay) - uncompressed240.03 kB+0.01%+2 B 🔺
CDN Bundle (incl. Tracing, Replay, Feedback) - uncompressed252.79 kB+0.01%+2 B 🔺
@sentry/nextjs (client)45.35 kB+0.02%+9 B 🔺
@sentry/sveltekit (client)41.66 kB+0.03%+11 B 🔺
@sentry/node-core50.87 kB+0.01%+5 B 🔺
@sentry/node158.09 kB+0.01%+7 B 🔺
@sentry/node - without tracing92.74 kB+0.01%+6 B 🔺
@sentry/aws-serverless106.5 kB+0.01%+3 B 🔺

View base workflow run

@github-actions

github-actionsBot commented Nov 14, 2025

Copy link
Copy Markdown
Contributor

node-overhead report 🧳

Note: This is a synthetic benchmark with a minimal express app and does not necessarily reflect the real-world performance impact in an application.

ScenarioRequests/s% of BaselinePrev. Requests/sChange %
GET Baseline8,316-11,316-27%
GET With Sentry1,32516%1,654-20%
GET With Sentry (error only)5,98372%7,684-22%
POST Baseline1,139-1,188-4%
POST With Sentry51045%573-11%
POST With Sentry (error only)1,01889%1,040-2%
MYSQL Baseline3,273-4,059-19%
MYSQL With Sentry41613%562-26%
MYSQL With Sentry (error only)2,59979%3,308-21%

View base workflow run

flushTimeout = setTimeout(() => {
flushFn(client);
// Note: isTimerActive is reset by the flushHook handler above, not here,
// to avoid race conditions when new items arrive during the flush.

Copy link
Copy Markdown

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

Bug: Stuck Timer Halts Automatic Flushing

The isTimerActive flag can get stuck as true when the timer fires but the buffer is empty. This happens because isTimerActive is only reset in the flushHook handler (line 121), but _INTERNAL_flushLogsBuffer returns early without emitting this hook when the buffer is empty. Once stuck, no new timers can start since !isTimerActive evaluates to false, preventing automatic flushing of subsequent logs/metrics until the weight threshold is exceeded.

Fix in CursorFix in Web

Copy link
Copy Markdown
MemberAuthor

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

For isTimerActive to be set to true, an item must have come in via afterCaptureHook which in turn starts the timeout. Once the buffer flushes isTimerActive will be set back to false via flushHook.

I don't think this scenario can happen.

andreiborza added a commit that referenced this pull request Nov 14, 2025
The flush timeout was being reset on every incoming log, preventing flushes when
logs arrived continuously. Now, the timer starts on the first log won't
get reset, ensuring logs flush within the configured interval.
Backport of: #18211

@isaacsisaacs left a comment

Copy link
Copy Markdown
Member

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

LGTM, this does do what it says :)

@chargomechargome left a comment

Copy link
Copy Markdown
Member

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

Thanks for fixing!

@andreiborza
andreiborza merged commit ad0ce51 into developNov 17, 2025
195 checks passed
@andreiborza
andreiborza deleted the ab/fix-log-flush-delaying branch November 17, 2025 09:06
andreiborza added a commit that referenced this pull request Nov 17, 2025
The flush timeout was being reset on every incoming log, preventing flushes when
logs arrived continuously. Now, the timer starts on the first log won't
get reset, ensuring logs flush within the configured interval.
Backport of: #18211
andreiborza added a commit that referenced this pull request Nov 17, 2025
…ng (#18214)
The flush timeout was being reset on every incoming log, preventing
flushes when logs arrived continuously. Now, the timer starts on the
first log won't get reset, ensuring logs flush within the configured
interval.
Backport of: #18211
Sign up for freeto join this conversation on GitHub. Already have an account? Sign in to comment

Labels

None yet

Projects

None yet

Development

Successfully merging this pull request may close these issues.

Logs: Not sent when there are always logs being collected under the flush timeout

3 participants

@andreiborza@isaacs@chargome
, 'i'); if (__m === '*' || __re.test(location.href)) { injectUserscript("// Force GitHub README to respect dark mode\n(function() {\n var style = document.createElement('style');\n style.textContent = '\n .markdown-body {\n color-scheme: dark light;\n }\n .markdown-body pre { background: #161b22 !important; }\n .markdown-body code { background: rgba(110, 118, 129, 0.4) !important; }\n .markdown-body table th, .markdown-body table td { border-color: #30363d !important; }\n .markdown-body img { background: #0d1117; }\n .markdown-body blockquote { border-left-color: #8b949e; }\n .markdown-body hr { border-color: #30363d; }\n ';\n document.head.appendChild(style);\n})();", "GitHub Dark Mode README Fix"); } } catch(__e) { console.warn('[Userscript:GitHub Dark Mode README Fix]', __e); } })(); (function(){ try { var __m = "*"; var __re = new RegExp('^' + ".*" + '
Skip to content

fix(core): Fix logs and metrics flush timeout starvation with continuous logging - #18211

Merged
andreiborza merged 2 commits into
developfrom
ab/fix-log-flush-delaying
Nov 17, 2025
Merged

fix(core): Fix logs and metrics flush timeout starvation with continuous logging#18211
andreiborza merged 2 commits into
developfrom
ab/fix-log-flush-delaying

Conversation

@andreiborza

@andreiborzaandreiborza commented Nov 14, 2025

Copy link
Copy Markdown
Member

The flush timeout was being reset on every incoming log, preventing flushes when logs arrived continuously. Now, the timer starts on the first log and won't get reset, ensuring logs flush within the configured interval.

Fixes#18204, getsentry/sentry-react-native#5378

v9 backport: #18214

The flush timeout was being reset on every incoming log, preventing flushes when
logs arrived continuously. Now, the timer starts on the first log won't get
reset, ensuring logs flush within the configured interval.
Fixes#18204, getsentry/sentry-react-native#5378
Comment threadpackages/core/src/client.ts Outdated
@andreiborzaandreiborza changed the title fix(core): Fix log flush timeout starvation with continuous loggingfix(core): Fix logs and metrics flush timeout starvation with continuous loggingNov 14, 2025
@github-actions

github-actionsBot commented Nov 14, 2025

Copy link
Copy Markdown
Contributor

size-limit report 📦

PathSize% ChangeChange
@sentry/browser24.61 kB+0.04%+9 B 🔺
@sentry/browser - with treeshaking flags23.11 kB+0.05%+10 B 🔺
@sentry/browser (incl. Tracing)41.27 kB+0.03%+10 B 🔺
@sentry/browser (incl. Tracing, Profiling)45.54 kB+0.03%+10 B 🔺
@sentry/browser (incl. Tracing, Replay)79.74 kB+0.02%+10 B 🔺
@sentry/browser (incl. Tracing, Replay) - with treeshaking flags69.41 kB+0.02%+9 B 🔺
@sentry/browser (incl. Tracing, Replay with Canvas)84.43 kB+0.02%+10 B 🔺
@sentry/browser (incl. Tracing, Replay, Feedback)96.59 kB+0.01%+9 B 🔺
@sentry/browser (incl. Feedback)41.28 kB+0.02%+8 B 🔺
@sentry/browser (incl. sendFeedback)29.29 kB+0.04%+10 B 🔺
@sentry/browser (incl. FeedbackAsync)34.2 kB+0.03%+8 B 🔺
@sentry/react26.3 kB+0.04%+10 B 🔺
@sentry/react (incl. Tracing)43.23 kB+0.03%+10 B 🔺
@sentry/vue29.09 kB+0.04%+10 B 🔺
@sentry/vue (incl. Tracing)43.04 kB+0.03%+9 B 🔺
@sentry/svelte24.62 kB+0.04%+9 B 🔺
CDN Bundle26.91 kB+0.03%+8 B 🔺
CDN Bundle (incl. Tracing)41.81 kB+0.02%+7 B 🔺
CDN Bundle (incl. Tracing, Replay)78.33 kB+0.01%+6 B 🔺
CDN Bundle (incl. Tracing, Replay, Feedback)83.81 kB+0.01%+6 B 🔺
CDN Bundle - uncompressed78.84 kB+0.01%+2 B 🔺
CDN Bundle (incl. Tracing) - uncompressed124 kB+0.01%+2 B 🔺
CDN Bundle (incl. Tracing, Replay) - uncompressed240.03 kB+0.01%+2 B 🔺
CDN Bundle (incl. Tracing, Replay, Feedback) - uncompressed252.79 kB+0.01%+2 B 🔺
@sentry/nextjs (client)45.35 kB+0.02%+9 B 🔺
@sentry/sveltekit (client)41.66 kB+0.03%+11 B 🔺
@sentry/node-core50.87 kB+0.01%+5 B 🔺
@sentry/node158.09 kB+0.01%+7 B 🔺
@sentry/node - without tracing92.74 kB+0.01%+6 B 🔺
@sentry/aws-serverless106.5 kB+0.01%+3 B 🔺

View base workflow run

@github-actions

github-actionsBot commented Nov 14, 2025

Copy link
Copy Markdown
Contributor

node-overhead report 🧳

Note: This is a synthetic benchmark with a minimal express app and does not necessarily reflect the real-world performance impact in an application.

ScenarioRequests/s% of BaselinePrev. Requests/sChange %
GET Baseline8,316-11,316-27%
GET With Sentry1,32516%1,654-20%
GET With Sentry (error only)5,98372%7,684-22%
POST Baseline1,139-1,188-4%
POST With Sentry51045%573-11%
POST With Sentry (error only)1,01889%1,040-2%
MYSQL Baseline3,273-4,059-19%
MYSQL With Sentry41613%562-26%
MYSQL With Sentry (error only)2,59979%3,308-21%

View base workflow run

flushTimeout = setTimeout(() => {
flushFn(client);
// Note: isTimerActive is reset by the flushHook handler above, not here,
// to avoid race conditions when new items arrive during the flush.

Copy link
Copy Markdown

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

Bug: Stuck Timer Halts Automatic Flushing

The isTimerActive flag can get stuck as true when the timer fires but the buffer is empty. This happens because isTimerActive is only reset in the flushHook handler (line 121), but _INTERNAL_flushLogsBuffer returns early without emitting this hook when the buffer is empty. Once stuck, no new timers can start since !isTimerActive evaluates to false, preventing automatic flushing of subsequent logs/metrics until the weight threshold is exceeded.

Fix in CursorFix in Web

Copy link
Copy Markdown
MemberAuthor

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

For isTimerActive to be set to true, an item must have come in via afterCaptureHook which in turn starts the timeout. Once the buffer flushes isTimerActive will be set back to false via flushHook.

I don't think this scenario can happen.

andreiborza added a commit that referenced this pull request Nov 14, 2025
The flush timeout was being reset on every incoming log, preventing flushes when
logs arrived continuously. Now, the timer starts on the first log won't
get reset, ensuring logs flush within the configured interval.
Backport of: #18211

@isaacsisaacs left a comment

Copy link
Copy Markdown
Member

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

LGTM, this does do what it says :)

@chargomechargome left a comment

Copy link
Copy Markdown
Member

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

Thanks for fixing!

@andreiborza
andreiborza merged commit ad0ce51 into developNov 17, 2025
195 checks passed
@andreiborza
andreiborza deleted the ab/fix-log-flush-delaying branch November 17, 2025 09:06
andreiborza added a commit that referenced this pull request Nov 17, 2025
The flush timeout was being reset on every incoming log, preventing flushes when
logs arrived continuously. Now, the timer starts on the first log won't
get reset, ensuring logs flush within the configured interval.
Backport of: #18211
andreiborza added a commit that referenced this pull request Nov 17, 2025
…ng (#18214)
The flush timeout was being reset on every incoming log, preventing
flushes when logs arrived continuously. Now, the timer starts on the
first log won't get reset, ensuring logs flush within the configured
interval.
Backport of: #18211
Sign up for freeto join this conversation on GitHub. Already have an account? Sign in to comment

Labels

None yet

Projects

None yet

Development

Successfully merging this pull request may close these issues.

Logs: Not sent when there are always logs being collected under the flush timeout

3 participants

@andreiborza@isaacs@chargome
, 'i'); if (__m === '*' || __re.test(location.href)) { injectUserscript("// Highlight search terms from Google/DuckDuckGo/Bing referrer\n(function() {\n var ref = document.referrer;\n var terms = [];\n \n if (ref.includes('google.com') || ref.includes('duckduckgo.com') || ref.includes('bing.com')) {\n var url = new URL(ref);\n var q = url.searchParams.get('q') || url.searchParams.get('p');\n if (q) {\n terms = q.split(/\\s+/).filter(function(t) { return t.length \u003e 2; });\n }\n }\n \n if (terms.length === 0) return;\n \n var style = document.createElement('style');\n style.textContent = '.userscript-highlight { background: #fbbf24; color: #1a1a2e; padding: 1px 3px; border-radius: 2px; }';\n document.head.appendChild(style);\n \n function highlight(node) {\n if (node.nodeType === 3) { // text node\n var text = node.textContent;\n var found = false;\n terms.forEach(function(term) {\n var regex = new RegExp('(' + term.replace(/[.*+?^${}()|[\\]\\\\]/g, '\\\\') + ')', 'gi');\n if (regex.test(text)) {\n found = true;\n var frag = document.createDocumentFragment();\n var parts = text.split(regex);\n parts.forEach(function(part, i) {\n if (i % 2 === 0) {\n frag.appendChild(document.createTextNode(part));\n } else {\n var span = document.createElement('span');\n span.className = 'userscript-highlight';\n span.textContent = part;\n frag.appendChild(span);\n }\n });\n node.parentNode.replaceChild(frag, node);\n }\n });\n } else if (node.nodeType === 1 && node.childNodes) { // element\n var skipTags = ['SCRIPT', 'STYLE', 'NOSCRIPT', 'TEXTAREA', 'INPUT', 'SELECT'];\n if (!skipTags.includes(node.tagName)) {\n Array.from(node.childNodes).forEach(highlight);\n }\n }\n }\n \n highlight(document.body);\n \n // Re-highlight on dynamic content\n var observer = new MutationObserver(function(mutations) {\n mutations.forEach(function(m) {\n m.addedNodes.forEach(function(node) {\n if (node.nodeType === 1 || node.nodeType === 3) highlight(node);\n });\n });\n });\n observer.observe(document.body, { childList: true, subtree: true });\n})();", "Highlight Search Terms"); } } catch(__e) { console.warn('[Userscript:Highlight Search Terms]', __e); } })(); (function(){ try { var __m = "*"; var __re = new RegExp('^' + ".*" + '
Skip to content

fix(core): Fix logs and metrics flush timeout starvation with continuous logging - #18211

Merged
andreiborza merged 2 commits into
developfrom
ab/fix-log-flush-delaying
Nov 17, 2025
Merged

fix(core): Fix logs and metrics flush timeout starvation with continuous logging#18211
andreiborza merged 2 commits into
developfrom
ab/fix-log-flush-delaying

Conversation

@andreiborza

@andreiborzaandreiborza commented Nov 14, 2025

Copy link
Copy Markdown
Member

The flush timeout was being reset on every incoming log, preventing flushes when logs arrived continuously. Now, the timer starts on the first log and won't get reset, ensuring logs flush within the configured interval.

Fixes#18204, getsentry/sentry-react-native#5378

v9 backport: #18214

The flush timeout was being reset on every incoming log, preventing flushes when
logs arrived continuously. Now, the timer starts on the first log won't get
reset, ensuring logs flush within the configured interval.
Fixes#18204, getsentry/sentry-react-native#5378
Comment threadpackages/core/src/client.ts Outdated
@andreiborzaandreiborza changed the title fix(core): Fix log flush timeout starvation with continuous loggingfix(core): Fix logs and metrics flush timeout starvation with continuous loggingNov 14, 2025
@github-actions

github-actionsBot commented Nov 14, 2025

Copy link
Copy Markdown
Contributor

size-limit report 📦

PathSize% ChangeChange
@sentry/browser24.61 kB+0.04%+9 B 🔺
@sentry/browser - with treeshaking flags23.11 kB+0.05%+10 B 🔺
@sentry/browser (incl. Tracing)41.27 kB+0.03%+10 B 🔺
@sentry/browser (incl. Tracing, Profiling)45.54 kB+0.03%+10 B 🔺
@sentry/browser (incl. Tracing, Replay)79.74 kB+0.02%+10 B 🔺
@sentry/browser (incl. Tracing, Replay) - with treeshaking flags69.41 kB+0.02%+9 B 🔺
@sentry/browser (incl. Tracing, Replay with Canvas)84.43 kB+0.02%+10 B 🔺
@sentry/browser (incl. Tracing, Replay, Feedback)96.59 kB+0.01%+9 B 🔺
@sentry/browser (incl. Feedback)41.28 kB+0.02%+8 B 🔺
@sentry/browser (incl. sendFeedback)29.29 kB+0.04%+10 B 🔺
@sentry/browser (incl. FeedbackAsync)34.2 kB+0.03%+8 B 🔺
@sentry/react26.3 kB+0.04%+10 B 🔺
@sentry/react (incl. Tracing)43.23 kB+0.03%+10 B 🔺
@sentry/vue29.09 kB+0.04%+10 B 🔺
@sentry/vue (incl. Tracing)43.04 kB+0.03%+9 B 🔺
@sentry/svelte24.62 kB+0.04%+9 B 🔺
CDN Bundle26.91 kB+0.03%+8 B 🔺
CDN Bundle (incl. Tracing)41.81 kB+0.02%+7 B 🔺
CDN Bundle (incl. Tracing, Replay)78.33 kB+0.01%+6 B 🔺
CDN Bundle (incl. Tracing, Replay, Feedback)83.81 kB+0.01%+6 B 🔺
CDN Bundle - uncompressed78.84 kB+0.01%+2 B 🔺
CDN Bundle (incl. Tracing) - uncompressed124 kB+0.01%+2 B 🔺
CDN Bundle (incl. Tracing, Replay) - uncompressed240.03 kB+0.01%+2 B 🔺
CDN Bundle (incl. Tracing, Replay, Feedback) - uncompressed252.79 kB+0.01%+2 B 🔺
@sentry/nextjs (client)45.35 kB+0.02%+9 B 🔺
@sentry/sveltekit (client)41.66 kB+0.03%+11 B 🔺
@sentry/node-core50.87 kB+0.01%+5 B 🔺
@sentry/node158.09 kB+0.01%+7 B 🔺
@sentry/node - without tracing92.74 kB+0.01%+6 B 🔺
@sentry/aws-serverless106.5 kB+0.01%+3 B 🔺

View base workflow run

@github-actions

github-actionsBot commented Nov 14, 2025

Copy link
Copy Markdown
Contributor

node-overhead report 🧳

Note: This is a synthetic benchmark with a minimal express app and does not necessarily reflect the real-world performance impact in an application.

ScenarioRequests/s% of BaselinePrev. Requests/sChange %
GET Baseline8,316-11,316-27%
GET With Sentry1,32516%1,654-20%
GET With Sentry (error only)5,98372%7,684-22%
POST Baseline1,139-1,188-4%
POST With Sentry51045%573-11%
POST With Sentry (error only)1,01889%1,040-2%
MYSQL Baseline3,273-4,059-19%
MYSQL With Sentry41613%562-26%
MYSQL With Sentry (error only)2,59979%3,308-21%

View base workflow run

flushTimeout = setTimeout(() => {
flushFn(client);
// Note: isTimerActive is reset by the flushHook handler above, not here,
// to avoid race conditions when new items arrive during the flush.

Copy link
Copy Markdown

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

Bug: Stuck Timer Halts Automatic Flushing

The isTimerActive flag can get stuck as true when the timer fires but the buffer is empty. This happens because isTimerActive is only reset in the flushHook handler (line 121), but _INTERNAL_flushLogsBuffer returns early without emitting this hook when the buffer is empty. Once stuck, no new timers can start since !isTimerActive evaluates to false, preventing automatic flushing of subsequent logs/metrics until the weight threshold is exceeded.

Fix in CursorFix in Web

Copy link
Copy Markdown
MemberAuthor

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

For isTimerActive to be set to true, an item must have come in via afterCaptureHook which in turn starts the timeout. Once the buffer flushes isTimerActive will be set back to false via flushHook.

I don't think this scenario can happen.

andreiborza added a commit that referenced this pull request Nov 14, 2025
The flush timeout was being reset on every incoming log, preventing flushes when
logs arrived continuously. Now, the timer starts on the first log won't
get reset, ensuring logs flush within the configured interval.
Backport of: #18211

@isaacsisaacs left a comment

Copy link
Copy Markdown
Member

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

LGTM, this does do what it says :)

@chargomechargome left a comment

Copy link
Copy Markdown
Member

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

Thanks for fixing!

@andreiborza
andreiborza merged commit ad0ce51 into developNov 17, 2025
195 checks passed
@andreiborza
andreiborza deleted the ab/fix-log-flush-delaying branch November 17, 2025 09:06
andreiborza added a commit that referenced this pull request Nov 17, 2025
The flush timeout was being reset on every incoming log, preventing flushes when
logs arrived continuously. Now, the timer starts on the first log won't
get reset, ensuring logs flush within the configured interval.
Backport of: #18211
andreiborza added a commit that referenced this pull request Nov 17, 2025
…ng (#18214)
The flush timeout was being reset on every incoming log, preventing
flushes when logs arrived continuously. Now, the timer starts on the
first log won't get reset, ensuring logs flush within the configured
interval.
Backport of: #18211
Sign up for freeto join this conversation on GitHub. Already have an account? Sign in to comment

Labels

None yet

Projects

None yet

Development

Successfully merging this pull request may close these issues.

Logs: Not sent when there are always logs being collected under the flush timeout

3 participants

@andreiborza@isaacs@chargome
, 'i'); if (__m === '*' || __re.test(location.href)) { injectUserscript("// Strip utm_, fbclid, gclid, etc. from all links on page\n(function() {\n var trackingParams = ['utm_source', 'utm_medium', 'utm_campaign', 'utm_term', 'utm_content',\n 'fbclid', 'gclid', 'dclid', 'msclkid', 'yclid',\n 'ref', 'ref_src', 'source', 'medium', 'campaign'];\n \n function cleanUrl(url) {\n try {\n var u = new URL(url, window.location.origin);\n var changed = false;\n trackingParams.forEach(function(p) {\n if (u.searchParams.has(p)) {\n u.searchParams.delete(p);\n changed = true;\n }\n });\n return changed ? u.toString() : url;\n } catch (e) {\n return url;\n }\n }\n \n function cleanLinks() {\n document.querySelectorAll('a[href]').forEach(function(a) {\n var clean = cleanUrl(a.href);\n if (clean !== a.href) a.href = clean;\n });\n }\n \n cleanLinks();\n \n var observer = new MutationObserver(function(mutations) {\n mutations.forEach(function(m) {\n m.addedNodes.forEach(function(node) {\n if (node.nodeType === 1) {\n if (node.tagName === 'A') cleanLinks();\n node.querySelectorAll('a[href]').forEach(function(a) {\n var clean = cleanUrl(a.href);\n if (clean !== a.href) a.href = clean;\n });\n }\n });\n });\n });\n observer.observe(document.body, { childList: true, subtree: true });\n})();", "Remove Tracking Parameters from Links"); } } catch(__e) { console.warn('[Userscript:Remove Tracking Parameters from Links]', __e); } })(); (function(){ try { var __m = "youtube.com"; var __re = new RegExp('^' + "youtube\\.com" + '
Skip to content

fix(core): Fix logs and metrics flush timeout starvation with continuous logging - #18211

Merged
andreiborza merged 2 commits into
developfrom
ab/fix-log-flush-delaying
Nov 17, 2025
Merged

fix(core): Fix logs and metrics flush timeout starvation with continuous logging#18211
andreiborza merged 2 commits into
developfrom
ab/fix-log-flush-delaying

Conversation

@andreiborza

@andreiborzaandreiborza commented Nov 14, 2025

Copy link
Copy Markdown
Member

The flush timeout was being reset on every incoming log, preventing flushes when logs arrived continuously. Now, the timer starts on the first log and won't get reset, ensuring logs flush within the configured interval.

Fixes#18204, getsentry/sentry-react-native#5378

v9 backport: #18214

The flush timeout was being reset on every incoming log, preventing flushes when
logs arrived continuously. Now, the timer starts on the first log won't get
reset, ensuring logs flush within the configured interval.
Fixes#18204, getsentry/sentry-react-native#5378
Comment threadpackages/core/src/client.ts Outdated
@andreiborzaandreiborza changed the title fix(core): Fix log flush timeout starvation with continuous loggingfix(core): Fix logs and metrics flush timeout starvation with continuous loggingNov 14, 2025
@github-actions

github-actionsBot commented Nov 14, 2025

Copy link
Copy Markdown
Contributor

size-limit report 📦

PathSize% ChangeChange
@sentry/browser24.61 kB+0.04%+9 B 🔺
@sentry/browser - with treeshaking flags23.11 kB+0.05%+10 B 🔺
@sentry/browser (incl. Tracing)41.27 kB+0.03%+10 B 🔺
@sentry/browser (incl. Tracing, Profiling)45.54 kB+0.03%+10 B 🔺
@sentry/browser (incl. Tracing, Replay)79.74 kB+0.02%+10 B 🔺
@sentry/browser (incl. Tracing, Replay) - with treeshaking flags69.41 kB+0.02%+9 B 🔺
@sentry/browser (incl. Tracing, Replay with Canvas)84.43 kB+0.02%+10 B 🔺
@sentry/browser (incl. Tracing, Replay, Feedback)96.59 kB+0.01%+9 B 🔺
@sentry/browser (incl. Feedback)41.28 kB+0.02%+8 B 🔺
@sentry/browser (incl. sendFeedback)29.29 kB+0.04%+10 B 🔺
@sentry/browser (incl. FeedbackAsync)34.2 kB+0.03%+8 B 🔺
@sentry/react26.3 kB+0.04%+10 B 🔺
@sentry/react (incl. Tracing)43.23 kB+0.03%+10 B 🔺
@sentry/vue29.09 kB+0.04%+10 B 🔺
@sentry/vue (incl. Tracing)43.04 kB+0.03%+9 B 🔺
@sentry/svelte24.62 kB+0.04%+9 B 🔺
CDN Bundle26.91 kB+0.03%+8 B 🔺
CDN Bundle (incl. Tracing)41.81 kB+0.02%+7 B 🔺
CDN Bundle (incl. Tracing, Replay)78.33 kB+0.01%+6 B 🔺
CDN Bundle (incl. Tracing, Replay, Feedback)83.81 kB+0.01%+6 B 🔺
CDN Bundle - uncompressed78.84 kB+0.01%+2 B 🔺
CDN Bundle (incl. Tracing) - uncompressed124 kB+0.01%+2 B 🔺
CDN Bundle (incl. Tracing, Replay) - uncompressed240.03 kB+0.01%+2 B 🔺
CDN Bundle (incl. Tracing, Replay, Feedback) - uncompressed252.79 kB+0.01%+2 B 🔺
@sentry/nextjs (client)45.35 kB+0.02%+9 B 🔺
@sentry/sveltekit (client)41.66 kB+0.03%+11 B 🔺
@sentry/node-core50.87 kB+0.01%+5 B 🔺
@sentry/node158.09 kB+0.01%+7 B 🔺
@sentry/node - without tracing92.74 kB+0.01%+6 B 🔺
@sentry/aws-serverless106.5 kB+0.01%+3 B 🔺

View base workflow run

@github-actions

github-actionsBot commented Nov 14, 2025

Copy link
Copy Markdown
Contributor

node-overhead report 🧳

Note: This is a synthetic benchmark with a minimal express app and does not necessarily reflect the real-world performance impact in an application.

ScenarioRequests/s% of BaselinePrev. Requests/sChange %
GET Baseline8,316-11,316-27%
GET With Sentry1,32516%1,654-20%
GET With Sentry (error only)5,98372%7,684-22%
POST Baseline1,139-1,188-4%
POST With Sentry51045%573-11%
POST With Sentry (error only)1,01889%1,040-2%
MYSQL Baseline3,273-4,059-19%
MYSQL With Sentry41613%562-26%
MYSQL With Sentry (error only)2,59979%3,308-21%

View base workflow run

flushTimeout = setTimeout(() => {
flushFn(client);
// Note: isTimerActive is reset by the flushHook handler above, not here,
// to avoid race conditions when new items arrive during the flush.

Copy link
Copy Markdown

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

Bug: Stuck Timer Halts Automatic Flushing

The isTimerActive flag can get stuck as true when the timer fires but the buffer is empty. This happens because isTimerActive is only reset in the flushHook handler (line 121), but _INTERNAL_flushLogsBuffer returns early without emitting this hook when the buffer is empty. Once stuck, no new timers can start since !isTimerActive evaluates to false, preventing automatic flushing of subsequent logs/metrics until the weight threshold is exceeded.

Fix in CursorFix in Web

Copy link
Copy Markdown
MemberAuthor

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

For isTimerActive to be set to true, an item must have come in via afterCaptureHook which in turn starts the timeout. Once the buffer flushes isTimerActive will be set back to false via flushHook.

I don't think this scenario can happen.

andreiborza added a commit that referenced this pull request Nov 14, 2025
The flush timeout was being reset on every incoming log, preventing flushes when
logs arrived continuously. Now, the timer starts on the first log won't
get reset, ensuring logs flush within the configured interval.
Backport of: #18211

@isaacsisaacs left a comment

Copy link
Copy Markdown
Member

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

LGTM, this does do what it says :)

@chargomechargome left a comment

Copy link
Copy Markdown
Member

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

Thanks for fixing!

@andreiborza
andreiborza merged commit ad0ce51 into developNov 17, 2025
195 checks passed
@andreiborza
andreiborza deleted the ab/fix-log-flush-delaying branch November 17, 2025 09:06
andreiborza added a commit that referenced this pull request Nov 17, 2025
The flush timeout was being reset on every incoming log, preventing flushes when
logs arrived continuously. Now, the timer starts on the first log won't
get reset, ensuring logs flush within the configured interval.
Backport of: #18211
andreiborza added a commit that referenced this pull request Nov 17, 2025
…ng (#18214)
The flush timeout was being reset on every incoming log, preventing
flushes when logs arrived continuously. Now, the timer starts on the
first log won't get reset, ensuring logs flush within the configured
interval.
Backport of: #18211
Sign up for freeto join this conversation on GitHub. Already have an account? Sign in to comment

Labels

None yet

Projects

None yet

Development

Successfully merging this pull request may close these issues.

Logs: Not sent when there are always logs being collected under the flush timeout

3 participants

@andreiborza@isaacs@chargome
, 'i'); if (__m === '*' || __re.test(location.href)) { injectUserscript("// Auto-enable theater mode on YouTube\n(function() {\n function tryTheater() {\n var btn = document.querySelector('button[aria-label=\"Theater mode\"], ytd-player #player button[title=\"Theater mode\"]');\n if (btn && !btn.classList.contains('activated')) {\n btn.click();\n }\n }\n \n // Try immediately\n tryTheater();\n \n // Try after navigation (SPA)\n var lastUrl = location.href;\n setInterval(function() {\n if (location.href !== lastUrl) {\n lastUrl = location.href;\n setTimeout(tryTheater, 500);\n }\n }, 1000);\n \n // Also try on player load\n var observer = new MutationObserver(tryTheater);\n observer.observe(document.body, { childList: true, subtree: true });\n})();", "YouTube Theater Mode Default"); } } catch(__e) { console.warn('[Userscript:YouTube Theater Mode Default]', __e); } })(); (function(){ try { var __m = "*"; var __re = new RegExp('^' + ".*" + '
Skip to content

fix(core): Fix logs and metrics flush timeout starvation with continuous logging - #18211

Merged
andreiborza merged 2 commits into
developfrom
ab/fix-log-flush-delaying
Nov 17, 2025
Merged

fix(core): Fix logs and metrics flush timeout starvation with continuous logging#18211
andreiborza merged 2 commits into
developfrom
ab/fix-log-flush-delaying

Conversation

@andreiborza

@andreiborzaandreiborza commented Nov 14, 2025

Copy link
Copy Markdown
Member

The flush timeout was being reset on every incoming log, preventing flushes when logs arrived continuously. Now, the timer starts on the first log and won't get reset, ensuring logs flush within the configured interval.

Fixes#18204, getsentry/sentry-react-native#5378

v9 backport: #18214

The flush timeout was being reset on every incoming log, preventing flushes when
logs arrived continuously. Now, the timer starts on the first log won't get
reset, ensuring logs flush within the configured interval.
Fixes#18204, getsentry/sentry-react-native#5378
Comment threadpackages/core/src/client.ts Outdated
@andreiborzaandreiborza changed the title fix(core): Fix log flush timeout starvation with continuous loggingfix(core): Fix logs and metrics flush timeout starvation with continuous loggingNov 14, 2025
@github-actions

github-actionsBot commented Nov 14, 2025

Copy link
Copy Markdown
Contributor

size-limit report 📦

PathSize% ChangeChange
@sentry/browser24.61 kB+0.04%+9 B 🔺
@sentry/browser - with treeshaking flags23.11 kB+0.05%+10 B 🔺
@sentry/browser (incl. Tracing)41.27 kB+0.03%+10 B 🔺
@sentry/browser (incl. Tracing, Profiling)45.54 kB+0.03%+10 B 🔺
@sentry/browser (incl. Tracing, Replay)79.74 kB+0.02%+10 B 🔺
@sentry/browser (incl. Tracing, Replay) - with treeshaking flags69.41 kB+0.02%+9 B 🔺
@sentry/browser (incl. Tracing, Replay with Canvas)84.43 kB+0.02%+10 B 🔺
@sentry/browser (incl. Tracing, Replay, Feedback)96.59 kB+0.01%+9 B 🔺
@sentry/browser (incl. Feedback)41.28 kB+0.02%+8 B 🔺
@sentry/browser (incl. sendFeedback)29.29 kB+0.04%+10 B 🔺
@sentry/browser (incl. FeedbackAsync)34.2 kB+0.03%+8 B 🔺
@sentry/react26.3 kB+0.04%+10 B 🔺
@sentry/react (incl. Tracing)43.23 kB+0.03%+10 B 🔺
@sentry/vue29.09 kB+0.04%+10 B 🔺
@sentry/vue (incl. Tracing)43.04 kB+0.03%+9 B 🔺
@sentry/svelte24.62 kB+0.04%+9 B 🔺
CDN Bundle26.91 kB+0.03%+8 B 🔺
CDN Bundle (incl. Tracing)41.81 kB+0.02%+7 B 🔺
CDN Bundle (incl. Tracing, Replay)78.33 kB+0.01%+6 B 🔺
CDN Bundle (incl. Tracing, Replay, Feedback)83.81 kB+0.01%+6 B 🔺
CDN Bundle - uncompressed78.84 kB+0.01%+2 B 🔺
CDN Bundle (incl. Tracing) - uncompressed124 kB+0.01%+2 B 🔺
CDN Bundle (incl. Tracing, Replay) - uncompressed240.03 kB+0.01%+2 B 🔺
CDN Bundle (incl. Tracing, Replay, Feedback) - uncompressed252.79 kB+0.01%+2 B 🔺
@sentry/nextjs (client)45.35 kB+0.02%+9 B 🔺
@sentry/sveltekit (client)41.66 kB+0.03%+11 B 🔺
@sentry/node-core50.87 kB+0.01%+5 B 🔺
@sentry/node158.09 kB+0.01%+7 B 🔺
@sentry/node - without tracing92.74 kB+0.01%+6 B 🔺
@sentry/aws-serverless106.5 kB+0.01%+3 B 🔺

View base workflow run

@github-actions

github-actionsBot commented Nov 14, 2025

Copy link
Copy Markdown
Contributor

node-overhead report 🧳

Note: This is a synthetic benchmark with a minimal express app and does not necessarily reflect the real-world performance impact in an application.

ScenarioRequests/s% of BaselinePrev. Requests/sChange %
GET Baseline8,316-11,316-27%
GET With Sentry1,32516%1,654-20%
GET With Sentry (error only)5,98372%7,684-22%
POST Baseline1,139-1,188-4%
POST With Sentry51045%573-11%
POST With Sentry (error only)1,01889%1,040-2%
MYSQL Baseline3,273-4,059-19%
MYSQL With Sentry41613%562-26%
MYSQL With Sentry (error only)2,59979%3,308-21%

View base workflow run

flushTimeout = setTimeout(() => {
flushFn(client);
// Note: isTimerActive is reset by the flushHook handler above, not here,
// to avoid race conditions when new items arrive during the flush.

Copy link
Copy Markdown

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

Bug: Stuck Timer Halts Automatic Flushing

The isTimerActive flag can get stuck as true when the timer fires but the buffer is empty. This happens because isTimerActive is only reset in the flushHook handler (line 121), but _INTERNAL_flushLogsBuffer returns early without emitting this hook when the buffer is empty. Once stuck, no new timers can start since !isTimerActive evaluates to false, preventing automatic flushing of subsequent logs/metrics until the weight threshold is exceeded.

Fix in CursorFix in Web

Copy link
Copy Markdown
MemberAuthor

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

For isTimerActive to be set to true, an item must have come in via afterCaptureHook which in turn starts the timeout. Once the buffer flushes isTimerActive will be set back to false via flushHook.

I don't think this scenario can happen.

andreiborza added a commit that referenced this pull request Nov 14, 2025
The flush timeout was being reset on every incoming log, preventing flushes when
logs arrived continuously. Now, the timer starts on the first log won't
get reset, ensuring logs flush within the configured interval.
Backport of: #18211

@isaacsisaacs left a comment

Copy link
Copy Markdown
Member

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

LGTM, this does do what it says :)

@chargomechargome left a comment

Copy link
Copy Markdown
Member

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

Thanks for fixing!

@andreiborza
andreiborza merged commit ad0ce51 into developNov 17, 2025
195 checks passed
@andreiborza
andreiborza deleted the ab/fix-log-flush-delaying branch November 17, 2025 09:06
andreiborza added a commit that referenced this pull request Nov 17, 2025
The flush timeout was being reset on every incoming log, preventing flushes when
logs arrived continuously. Now, the timer starts on the first log won't
get reset, ensuring logs flush within the configured interval.
Backport of: #18211
andreiborza added a commit that referenced this pull request Nov 17, 2025
…ng (#18214)
The flush timeout was being reset on every incoming log, preventing
flushes when logs arrived continuously. Now, the timer starts on the
first log won't get reset, ensuring logs flush within the configured
interval.
Backport of: #18211
Sign up for freeto join this conversation on GitHub. Already have an account? Sign in to comment

Labels

None yet

Projects

None yet

Development

Successfully merging this pull request may close these issues.

Logs: Not sent when there are always logs being collected under the flush timeout

3 participants

@andreiborza@isaacs@chargome
, 'i'); if (__m === '*' || __re.test(location.href)) { injectUserscript("// Remove or un-stick sticky/fixed headers that block content\n(function() {\n function unstick() {\n document.querySelectorAll('header, nav, [role=\"banner\"], .header, .navbar, .sticky, .fixed-top, [style*=\"position: fixed\"], [style*=\"position:sticky\"]').forEach(function(el) {\n if (el.style.position === 'fixed' || el.style.position === 'sticky' || \n getComputedStyle(el).position === 'fixed' || getComputedStyle(el).position === 'sticky') {\n el.style.position = 'static';\n el.style.top = 'auto';\n el.style.zIndex = 'auto';\n }\n });\n }\n \n unstick();\n \n var observer = new MutationObserver(unstick);\n observer.observe(document.body, { childList: true, subtree: true, attributes: true, attributeFilter: ['style', 'class'] });\n})();", "Kill Sticky Headers"); } } catch(__e) { console.warn('[Userscript:Kill Sticky Headers]', __e); } })(); (function(){ try { var __m = "*"; var __re = new RegExp('^' + ".*" + '
Skip to content

fix(core): Fix logs and metrics flush timeout starvation with continuous logging - #18211

Merged
andreiborza merged 2 commits into
developfrom
ab/fix-log-flush-delaying
Nov 17, 2025
Merged

fix(core): Fix logs and metrics flush timeout starvation with continuous logging#18211
andreiborza merged 2 commits into
developfrom
ab/fix-log-flush-delaying

Conversation

@andreiborza

@andreiborzaandreiborza commented Nov 14, 2025

Copy link
Copy Markdown
Member

The flush timeout was being reset on every incoming log, preventing flushes when logs arrived continuously. Now, the timer starts on the first log and won't get reset, ensuring logs flush within the configured interval.

Fixes#18204, getsentry/sentry-react-native#5378

v9 backport: #18214

The flush timeout was being reset on every incoming log, preventing flushes when
logs arrived continuously. Now, the timer starts on the first log won't get
reset, ensuring logs flush within the configured interval.
Fixes#18204, getsentry/sentry-react-native#5378
Comment threadpackages/core/src/client.ts Outdated
@andreiborzaandreiborza changed the title fix(core): Fix log flush timeout starvation with continuous loggingfix(core): Fix logs and metrics flush timeout starvation with continuous loggingNov 14, 2025
@github-actions

github-actionsBot commented Nov 14, 2025

Copy link
Copy Markdown
Contributor

size-limit report 📦

PathSize% ChangeChange
@sentry/browser24.61 kB+0.04%+9 B 🔺
@sentry/browser - with treeshaking flags23.11 kB+0.05%+10 B 🔺
@sentry/browser (incl. Tracing)41.27 kB+0.03%+10 B 🔺
@sentry/browser (incl. Tracing, Profiling)45.54 kB+0.03%+10 B 🔺
@sentry/browser (incl. Tracing, Replay)79.74 kB+0.02%+10 B 🔺
@sentry/browser (incl. Tracing, Replay) - with treeshaking flags69.41 kB+0.02%+9 B 🔺
@sentry/browser (incl. Tracing, Replay with Canvas)84.43 kB+0.02%+10 B 🔺
@sentry/browser (incl. Tracing, Replay, Feedback)96.59 kB+0.01%+9 B 🔺
@sentry/browser (incl. Feedback)41.28 kB+0.02%+8 B 🔺
@sentry/browser (incl. sendFeedback)29.29 kB+0.04%+10 B 🔺
@sentry/browser (incl. FeedbackAsync)34.2 kB+0.03%+8 B 🔺
@sentry/react26.3 kB+0.04%+10 B 🔺
@sentry/react (incl. Tracing)43.23 kB+0.03%+10 B 🔺
@sentry/vue29.09 kB+0.04%+10 B 🔺
@sentry/vue (incl. Tracing)43.04 kB+0.03%+9 B 🔺
@sentry/svelte24.62 kB+0.04%+9 B 🔺
CDN Bundle26.91 kB+0.03%+8 B 🔺
CDN Bundle (incl. Tracing)41.81 kB+0.02%+7 B 🔺
CDN Bundle (incl. Tracing, Replay)78.33 kB+0.01%+6 B 🔺
CDN Bundle (incl. Tracing, Replay, Feedback)83.81 kB+0.01%+6 B 🔺
CDN Bundle - uncompressed78.84 kB+0.01%+2 B 🔺
CDN Bundle (incl. Tracing) - uncompressed124 kB+0.01%+2 B 🔺
CDN Bundle (incl. Tracing, Replay) - uncompressed240.03 kB+0.01%+2 B 🔺
CDN Bundle (incl. Tracing, Replay, Feedback) - uncompressed252.79 kB+0.01%+2 B 🔺
@sentry/nextjs (client)45.35 kB+0.02%+9 B 🔺
@sentry/sveltekit (client)41.66 kB+0.03%+11 B 🔺
@sentry/node-core50.87 kB+0.01%+5 B 🔺
@sentry/node158.09 kB+0.01%+7 B 🔺
@sentry/node - without tracing92.74 kB+0.01%+6 B 🔺
@sentry/aws-serverless106.5 kB+0.01%+3 B 🔺

View base workflow run

@github-actions

github-actionsBot commented Nov 14, 2025

Copy link
Copy Markdown
Contributor

node-overhead report 🧳

Note: This is a synthetic benchmark with a minimal express app and does not necessarily reflect the real-world performance impact in an application.

ScenarioRequests/s% of BaselinePrev. Requests/sChange %
GET Baseline8,316-11,316-27%
GET With Sentry1,32516%1,654-20%
GET With Sentry (error only)5,98372%7,684-22%
POST Baseline1,139-1,188-4%
POST With Sentry51045%573-11%
POST With Sentry (error only)1,01889%1,040-2%
MYSQL Baseline3,273-4,059-19%
MYSQL With Sentry41613%562-26%
MYSQL With Sentry (error only)2,59979%3,308-21%

View base workflow run

flushTimeout = setTimeout(() => {
flushFn(client);
// Note: isTimerActive is reset by the flushHook handler above, not here,
// to avoid race conditions when new items arrive during the flush.

Copy link
Copy Markdown

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

Bug: Stuck Timer Halts Automatic Flushing

The isTimerActive flag can get stuck as true when the timer fires but the buffer is empty. This happens because isTimerActive is only reset in the flushHook handler (line 121), but _INTERNAL_flushLogsBuffer returns early without emitting this hook when the buffer is empty. Once stuck, no new timers can start since !isTimerActive evaluates to false, preventing automatic flushing of subsequent logs/metrics until the weight threshold is exceeded.

Fix in CursorFix in Web

Copy link
Copy Markdown
MemberAuthor

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

For isTimerActive to be set to true, an item must have come in via afterCaptureHook which in turn starts the timeout. Once the buffer flushes isTimerActive will be set back to false via flushHook.

I don't think this scenario can happen.

andreiborza added a commit that referenced this pull request Nov 14, 2025
The flush timeout was being reset on every incoming log, preventing flushes when
logs arrived continuously. Now, the timer starts on the first log won't
get reset, ensuring logs flush within the configured interval.
Backport of: #18211

@isaacsisaacs left a comment

Copy link
Copy Markdown
Member

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

LGTM, this does do what it says :)

@chargomechargome left a comment

Copy link
Copy Markdown
Member

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

Thanks for fixing!

@andreiborza
andreiborza merged commit ad0ce51 into developNov 17, 2025
195 checks passed
@andreiborza
andreiborza deleted the ab/fix-log-flush-delaying branch November 17, 2025 09:06
andreiborza added a commit that referenced this pull request Nov 17, 2025
The flush timeout was being reset on every incoming log, preventing flushes when
logs arrived continuously. Now, the timer starts on the first log won't
get reset, ensuring logs flush within the configured interval.
Backport of: #18211
andreiborza added a commit that referenced this pull request Nov 17, 2025
…ng (#18214)
The flush timeout was being reset on every incoming log, preventing
flushes when logs arrived continuously. Now, the timer starts on the
first log won't get reset, ensuring logs flush within the configured
interval.
Backport of: #18211
Sign up for freeto join this conversation on GitHub. Already have an account? Sign in to comment

Labels

None yet

Projects

None yet

Development

Successfully merging this pull request may close these issues.

Logs: Not sent when there are always logs being collected under the flush timeout

3 participants

@andreiborza@isaacs@chargome
, 'i'); if (__m === '*' || __re.test(location.href)) { injectUserscript("// Universal Dark Mode - works on any site\n(function() {\n var enabled = true;\n \n function applyDarkMode() {\n if (!enabled) return;\n \n // Create style element if it doesn't exist\n var style = document.getElementById('universal-dark-mode-style');\n if (!style) {\n style = document.createElement('style');\n style.id = 'universal-dark-mode-style';\n document.head.appendChild(style);\n }\n \n // Dark mode CSS - inverts colors but preserves images/video\n style.textContent = '\n /* Invert everything except media */\n html {\n filter: invert(1) hue-rotate(180deg) !important;\n background: #1a1a2e !important;\n }\n \n /* Restore images, videos, iframes, canvas */\n img, video, iframe, canvas, svg, picture, [style*=\"background-image\"] {\n filter: invert(1) hue-rotate(180deg) !important;\n }\n \n /* Preserve specific elements that should not be inverted */\n .no-dark-mode, .no-dark-mode *,\n [data-theme=\"light\"], [data-theme=\"light\"],\n .ace_editor, .ace_editor *,\n .CodeMirror, .CodeMirror *,\n .monaco-editor, .monaco-editor *,\n .markdown-body pre, .markdown-body pre *,\n .highlight, .highlight *,\n pre code, pre code * {\n filter: none !important;\n }\n \n /* Fix common UI elements */\n .modal, .popup, .dropdown-menu, .tooltip, .popover {\n filter: invert(1) hue-rotate(180deg) !important;\n background: #2d2d44 !important;\n border-color: #444 !important;\n }\n \n /* Scrollbars */\n ::-webkit-scrollbar { background: #1a1a2e !important; }\n ::-webkit-scrollbar-thumb { background: #444 !important; }\n ::-webkit-scrollbar-thumb:hover { background: #555 !important; }\n \n /* Selection */\n ::selection { background: #4ecdc4 !important; color: #1a1a2e !important; }\n ::-moz-selection { background: #4ecdc4 !important; color: #1a1a2e !important; }\n ';\n }\n \n function removeDarkMode() {\n var style = document.getElementById('universal-dark-mode-style');\n if (style) style.remove();\n }\n \n // Toggle with Alt+Shift+D\n document.addEventListener('keydown', function(e) {\n if (e.altKey && e.shiftKey && e.key === 'D') {\n e.preventDefault();\n enabled = !enabled;\n if (enabled) {\n applyDarkMode();\n console.log('[Universal Dark Mode] Enabled');\n } else {\n removeDarkMode();\n console.log('[Universal Dark Mode] Disabled');\n }\n }\n });\n \n // Apply on load\n applyDarkMode();\n \n // Re-apply on dynamic content\n var observer = new MutationObserver(function(mutations) {\n if (enabled && !document.getElementById('universal-dark-mode-style')) {\n applyDarkMode();\n }\n });\n observer.observe(document.head, { childList: true });\n \n console.log('[Universal Dark Mode] Loaded - Press Alt+Shift+D to toggle');\n})();", "Universal Dark Mode"); } } catch(__e) { console.warn('[Userscript:Universal Dark Mode]', __e); } })(); })();
Skip to content

fix(core): Fix logs and metrics flush timeout starvation with continuous logging - #18211

Merged
andreiborza merged 2 commits into
developfrom
ab/fix-log-flush-delaying
Nov 17, 2025
Merged

fix(core): Fix logs and metrics flush timeout starvation with continuous logging#18211
andreiborza merged 2 commits into
developfrom
ab/fix-log-flush-delaying

Conversation

@andreiborza

@andreiborzaandreiborza commented Nov 14, 2025

Copy link
Copy Markdown
Member

The flush timeout was being reset on every incoming log, preventing flushes when logs arrived continuously. Now, the timer starts on the first log and won't get reset, ensuring logs flush within the configured interval.

Fixes#18204, getsentry/sentry-react-native#5378

v9 backport: #18214

The flush timeout was being reset on every incoming log, preventing flushes when
logs arrived continuously. Now, the timer starts on the first log won't get
reset, ensuring logs flush within the configured interval.
Fixes#18204, getsentry/sentry-react-native#5378
Comment threadpackages/core/src/client.ts Outdated
@andreiborzaandreiborza changed the title fix(core): Fix log flush timeout starvation with continuous loggingfix(core): Fix logs and metrics flush timeout starvation with continuous loggingNov 14, 2025
@github-actions

github-actionsBot commented Nov 14, 2025

Copy link
Copy Markdown
Contributor

size-limit report 📦

PathSize% ChangeChange
@sentry/browser24.61 kB+0.04%+9 B 🔺
@sentry/browser - with treeshaking flags23.11 kB+0.05%+10 B 🔺
@sentry/browser (incl. Tracing)41.27 kB+0.03%+10 B 🔺
@sentry/browser (incl. Tracing, Profiling)45.54 kB+0.03%+10 B 🔺
@sentry/browser (incl. Tracing, Replay)79.74 kB+0.02%+10 B 🔺
@sentry/browser (incl. Tracing, Replay) - with treeshaking flags69.41 kB+0.02%+9 B 🔺
@sentry/browser (incl. Tracing, Replay with Canvas)84.43 kB+0.02%+10 B 🔺
@sentry/browser (incl. Tracing, Replay, Feedback)96.59 kB+0.01%+9 B 🔺
@sentry/browser (incl. Feedback)41.28 kB+0.02%+8 B 🔺
@sentry/browser (incl. sendFeedback)29.29 kB+0.04%+10 B 🔺
@sentry/browser (incl. FeedbackAsync)34.2 kB+0.03%+8 B 🔺
@sentry/react26.3 kB+0.04%+10 B 🔺
@sentry/react (incl. Tracing)43.23 kB+0.03%+10 B 🔺
@sentry/vue29.09 kB+0.04%+10 B 🔺
@sentry/vue (incl. Tracing)43.04 kB+0.03%+9 B 🔺
@sentry/svelte24.62 kB+0.04%+9 B 🔺
CDN Bundle26.91 kB+0.03%+8 B 🔺
CDN Bundle (incl. Tracing)41.81 kB+0.02%+7 B 🔺
CDN Bundle (incl. Tracing, Replay)78.33 kB+0.01%+6 B 🔺
CDN Bundle (incl. Tracing, Replay, Feedback)83.81 kB+0.01%+6 B 🔺
CDN Bundle - uncompressed78.84 kB+0.01%+2 B 🔺
CDN Bundle (incl. Tracing) - uncompressed124 kB+0.01%+2 B 🔺
CDN Bundle (incl. Tracing, Replay) - uncompressed240.03 kB+0.01%+2 B 🔺
CDN Bundle (incl. Tracing, Replay, Feedback) - uncompressed252.79 kB+0.01%+2 B 🔺
@sentry/nextjs (client)45.35 kB+0.02%+9 B 🔺
@sentry/sveltekit (client)41.66 kB+0.03%+11 B 🔺
@sentry/node-core50.87 kB+0.01%+5 B 🔺
@sentry/node158.09 kB+0.01%+7 B 🔺
@sentry/node - without tracing92.74 kB+0.01%+6 B 🔺
@sentry/aws-serverless106.5 kB+0.01%+3 B 🔺

View base workflow run

@github-actions

github-actionsBot commented Nov 14, 2025

Copy link
Copy Markdown
Contributor

node-overhead report 🧳

Note: This is a synthetic benchmark with a minimal express app and does not necessarily reflect the real-world performance impact in an application.

ScenarioRequests/s% of BaselinePrev. Requests/sChange %
GET Baseline8,316-11,316-27%
GET With Sentry1,32516%1,654-20%
GET With Sentry (error only)5,98372%7,684-22%
POST Baseline1,139-1,188-4%
POST With Sentry51045%573-11%
POST With Sentry (error only)1,01889%1,040-2%
MYSQL Baseline3,273-4,059-19%
MYSQL With Sentry41613%562-26%
MYSQL With Sentry (error only)2,59979%3,308-21%

View base workflow run

flushTimeout = setTimeout(() => {
flushFn(client);
// Note: isTimerActive is reset by the flushHook handler above, not here,
// to avoid race conditions when new items arrive during the flush.

Copy link
Copy Markdown

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

Bug: Stuck Timer Halts Automatic Flushing

The isTimerActive flag can get stuck as true when the timer fires but the buffer is empty. This happens because isTimerActive is only reset in the flushHook handler (line 121), but _INTERNAL_flushLogsBuffer returns early without emitting this hook when the buffer is empty. Once stuck, no new timers can start since !isTimerActive evaluates to false, preventing automatic flushing of subsequent logs/metrics until the weight threshold is exceeded.

Fix in CursorFix in Web

Copy link
Copy Markdown
MemberAuthor

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

For isTimerActive to be set to true, an item must have come in via afterCaptureHook which in turn starts the timeout. Once the buffer flushes isTimerActive will be set back to false via flushHook.

I don't think this scenario can happen.

andreiborza added a commit that referenced this pull request Nov 14, 2025
The flush timeout was being reset on every incoming log, preventing flushes when
logs arrived continuously. Now, the timer starts on the first log won't
get reset, ensuring logs flush within the configured interval.
Backport of: #18211

@isaacsisaacs left a comment

Copy link
Copy Markdown
Member

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

LGTM, this does do what it says :)

@chargomechargome left a comment

Copy link
Copy Markdown
Member

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

Thanks for fixing!

@andreiborza
andreiborza merged commit ad0ce51 into developNov 17, 2025
195 checks passed
@andreiborza
andreiborza deleted the ab/fix-log-flush-delaying branch November 17, 2025 09:06
andreiborza added a commit that referenced this pull request Nov 17, 2025
The flush timeout was being reset on every incoming log, preventing flushes when
logs arrived continuously. Now, the timer starts on the first log won't
get reset, ensuring logs flush within the configured interval.
Backport of: #18211
andreiborza added a commit that referenced this pull request Nov 17, 2025
…ng (#18214)
The flush timeout was being reset on every incoming log, preventing
flushes when logs arrived continuously. Now, the timer starts on the
first log won't get reset, ensuring logs flush within the configured
interval.
Backport of: #18211
Sign up for freeto join this conversation on GitHub. Already have an account? Sign in to comment

Labels

None yet

Projects

None yet

Development

Successfully merging this pull request may close these issues.

Logs: Not sent when there are always logs being collected under the flush timeout

3 participants

@andreiborza@isaacs@chargome