Skip to content

Commit adba95d

Browse files
heiskrCopilot
andauthored
🚢 Add per-step info logging to warm-server for deployment debugging (#60678)
Co-authored-by: Copilot <223556219+Copilot@users.noreply.github.com>
1 parent a3e0414 commit adba95d

File tree

1 file changed

+40
-4
lines changed

1 file changed

+40
-4
lines changed

‎src/frame/lib/warm-server.ts‎

Lines changed: 40 additions & 4 deletions
Original file line numberDiff line numberDiff line change
@@ -31,19 +31,55 @@ let promisedWarmServer: Promise<WarmServerResult> | undefined
3131
async function warmServer(languagesOnly: string[] = []): Promise<WarmServerResult> {
3232
const startTime = Date.now()
3333

34-
logger.debug(
35-
`Priming context information...${languagesOnly && languagesOnly.length ? ` ${languagesOnly.join(',')} only` : ''}`,
36-
)
34+
const langSuffix =
35+
languagesOnly && languagesOnly.length ? ` (${languagesOnly.join(',')})` : ' (all languages)'
3736

37+
logger.info(`warm-server: starting${langSuffix}`)
38+
39+
let stepStart = Date.now()
3840
const unversionedTree = await dog.loadUnversionedTree(languagesOnly)
41+
logger.info('warm-server: loadUnversionedTree complete', {
42+
durationMs: Date.now() - stepStart,
43+
heapUsedMb: Math.round(process.memoryUsage().heapUsed / 1024 / 1024),
44+
})
45+
46+
stepStart = Date.now()
3947
const siteTree = await dog.loadSiteTree(unversionedTree, languagesOnly)
48+
logger.info('warm-server: loadSiteTree complete', {
49+
durationMs: Date.now() - stepStart,
50+
heapUsedMb: Math.round(process.memoryUsage().heapUsed / 1024 / 1024),
51+
})
52+
53+
stepStart = Date.now()
4054
const pageList = await dog.loadPages(unversionedTree, languagesOnly)
55+
logger.info('warm-server: loadPages complete', {
56+
durationMs: Date.now() - stepStart,
57+
pageCount: pageList.length,
58+
heapUsedMb: Math.round(process.memoryUsage().heapUsed / 1024 / 1024),
59+
})
60+
61+
stepStart = Date.now()
4162
const pageMap = await dog.loadPageMap(pageList)
63+
logger.info('warm-server: loadPageMap complete', {
64+
durationMs: Date.now() - stepStart,
65+
permalinkCount: Object.keys(pageMap).length,
66+
heapUsedMb: Math.round(process.memoryUsage().heapUsed / 1024 / 1024),
67+
})
68+
69+
stepStart = Date.now()
4270
const redirects = await dog.loadRedirects(pageList)
71+
logger.info('warm-server: loadRedirects complete', {
72+
durationMs: Date.now() - stepStart,
73+
redirectCount: Object.keys(redirects).length,
74+
heapUsedMb: Math.round(process.memoryUsage().heapUsed / 1024 / 1024),
75+
})
4376

4477
statsd.gauge('memory_heap_used', process.memoryUsage().heapUsed, ['event:warm-server'])
4578

46-
logger.debug(`Context primed in ${Date.now() - startTime} ms`)
79+
logger.info('warm-server: complete', {
80+
totalDurationMs: Date.now() - startTime,
81+
heapUsedMb: Math.round(process.memoryUsage().heapUsed / 1024 / 1024),
82+
})
4783

4884
return {
4985
pages: pageMap,

0 commit comments

Comments
 (0)