2025-08-30 19:04:35 -03:00
|
|
|
const winston = require('winston');
|
|
|
|
|
const path = require('path');
|
2025-11-19 16:01:37 -03:00
|
|
|
require('winston-daily-rotate-file');
|
2025-09-05 20:27:35 -03:00
|
|
|
const fs = require('fs');
|
2025-08-30 19:04:35 -03:00
|
|
|
|
2025-09-05 20:27:35 -03:00
|
|
|
// verifica se a pasta de logs existe, se não, cria
|
|
|
|
|
const logsDir = path.join(__dirname, '../../logs');
|
|
|
|
|
if (!fs.existsSync(logsDir)) {
|
|
|
|
|
fs.mkdirSync(logsDir, { recursive: true });
|
|
|
|
|
}
|
|
|
|
|
|
2026-02-27 17:03:17 -03:00
|
|
|
const isProduction = process.env.NODE_ENV === 'production';
|
|
|
|
|
const logLevel = process.env.LOG_LEVEL || 'info';
|
|
|
|
|
const logToConsole = process.env.LOG_TO_CONSOLE
|
|
|
|
|
? process.env.LOG_TO_CONSOLE === 'true'
|
|
|
|
|
: !isProduction;
|
|
|
|
|
|
2025-09-05 20:27:35 -03:00
|
|
|
// Configuração do logger com winston
|
2025-08-30 19:04:35 -03:00
|
|
|
const logger = winston.createLogger({
|
2026-02-27 17:03:17 -03:00
|
|
|
level: logLevel,
|
2025-11-19 16:01:37 -03:00
|
|
|
format: winston.format.combine(winston.format.timestamp({ format: 'YYYY-MM-DD HH:mm:ss' }), winston.format.errors({ stack: true })),
|
2025-08-30 19:04:35 -03:00
|
|
|
transports: [
|
2025-09-05 20:27:35 -03:00
|
|
|
// Log geral da aplicação
|
2025-11-19 16:01:37 -03:00
|
|
|
new winston.transports.DailyRotateFile({
|
|
|
|
|
filename: path.join(logsDir, 'app-%DATE%.log'),
|
|
|
|
|
datePattern: 'YYYY-MM-DD',
|
|
|
|
|
zippedArchive: true,
|
|
|
|
|
maxSize: '5m',
|
|
|
|
|
maxFiles: '10d',
|
|
|
|
|
format: winston.format.combine(
|
|
|
|
|
winston.format.printf((info) => {
|
|
|
|
|
const { timestamp, level, message, stack, ...meta } = info;
|
2026-07-20 16:59:17 -03:00
|
|
|
let logMessage = `${timestamp} [${level}]: ${message}${stack ? `\n${stack}` : ''}`;
|
2025-11-19 16:01:37 -03:00
|
|
|
if (Object.keys(meta).length) {
|
|
|
|
|
logMessage += ` ${JSON.stringify(meta, null, 2)}`;
|
|
|
|
|
}
|
|
|
|
|
return logMessage;
|
|
|
|
|
})
|
|
|
|
|
),
|
2025-09-05 20:27:35 -03:00
|
|
|
}),
|
|
|
|
|
// Log de erros
|
2025-11-19 16:01:37 -03:00
|
|
|
new winston.transports.DailyRotateFile({
|
|
|
|
|
filename: path.join(logsDir, 'error-%DATE%.log'),
|
2025-09-05 20:27:35 -03:00
|
|
|
level: 'error',
|
2025-11-19 16:01:37 -03:00
|
|
|
datePattern: 'YYYY-MM-DD',
|
|
|
|
|
zippedArchive: true,
|
|
|
|
|
maxSize: '5m',
|
|
|
|
|
maxFiles: '10d',
|
|
|
|
|
format: winston.format.combine(
|
|
|
|
|
winston.format.printf((info) => {
|
|
|
|
|
const { timestamp, level, message, stack, ...meta } = info;
|
2026-07-20 16:59:17 -03:00
|
|
|
let logMessage = `${timestamp} [${level}]: ${message}${stack ? `\n${stack}` : ''}`;
|
2025-11-19 16:01:37 -03:00
|
|
|
if (Object.keys(meta).length) {
|
|
|
|
|
logMessage += ` ${JSON.stringify(meta, null, 2)}`;
|
|
|
|
|
}
|
|
|
|
|
return logMessage;
|
|
|
|
|
})
|
|
|
|
|
),
|
|
|
|
|
})
|
2025-08-30 19:04:35 -03:00
|
|
|
],
|
|
|
|
|
});
|
|
|
|
|
|
2026-02-27 17:03:17 -03:00
|
|
|
// Log no console (controlado por variavel de ambiente)
|
|
|
|
|
if (logToConsole) {
|
2025-08-30 19:04:35 -03:00
|
|
|
logger.add(new winston.transports.Console({
|
2025-09-05 20:27:35 -03:00
|
|
|
format: winston.format.combine(
|
|
|
|
|
winston.format.colorize(),
|
2025-11-19 16:01:37 -03:00
|
|
|
winston.format.printf((info) => {
|
|
|
|
|
const { timestamp, level, message, stack, ...meta } = info;
|
2026-07-20 16:59:17 -03:00
|
|
|
let logMessage = `${timestamp} [${level}]: ${message}${stack ? `\n${stack}` : ''}`;
|
2025-11-19 16:01:37 -03:00
|
|
|
if (Object.keys(meta).length) {
|
|
|
|
|
logMessage += ` ${JSON.stringify(meta, null, 2)}`;
|
|
|
|
|
}
|
|
|
|
|
return logMessage;
|
2025-09-05 20:27:35 -03:00
|
|
|
})
|
|
|
|
|
)
|
2025-08-30 19:04:35 -03:00
|
|
|
}));
|
|
|
|
|
}
|
|
|
|
|
|
2025-09-05 20:27:35 -03:00
|
|
|
// Funções utilitárias
|
|
|
|
|
const logError = (error, context = '') => {
|
|
|
|
|
if (error instanceof Error) {
|
|
|
|
|
logger.error(`${context} - ${error.message}`, { stack: error.stack });
|
|
|
|
|
} else {
|
|
|
|
|
logger.error(`${context} - ${error}`);
|
|
|
|
|
}
|
|
|
|
|
};
|
|
|
|
|
|
|
|
|
|
const logInfo = (message, meta = {}) => {
|
|
|
|
|
logger.info(message, meta);
|
|
|
|
|
};
|
|
|
|
|
|
|
|
|
|
const logWarning = (message, meta = {}) => {
|
|
|
|
|
logger.warn(message, meta);
|
2025-08-30 19:04:35 -03:00
|
|
|
};
|
|
|
|
|
|
PERF: Reduz verbosidade de logs em nivel info no ciclo do cron
Rebaixa para debug uma serie de logs "heartbeat" que disparavam todo ciclo
(a cada 1 minuto) independente de qualquer mudanca real, competindo com os
logs de acao/erro que realmente importam: buscas por watermark, contagem
de tickets pendentes/monitorados, checagens de comentario ja sincronizado,
abertura de conexao GLPI/PostgreSQL, e o resumo de sincronizacao do SN
(que a margem de seguranca de 6h do watermark sempre retorna nao-vazio,
mesmo sem mudanca real de campo).
Corrige tambem um bug real encontrado em teste: no fluxo GLPI -> SN, todo
comentario historico de um ticket era sanitizado e checado contra a API do
SN a cada ciclo antes mesmo de verificar se ja tinha sido sincronizado
(ticket_updates.destiny_id). Em tickets com historico longo isso
significava dezenas de chamadas desnecessarias por minuto. Agora a
checagem local (barata) roda primeiro, e so sanitiza/consulta o SN quando
o comentario realmente ainda nao foi sincronizado.
Corrige tambem o log de configuracao do pool PostgreSQL, que imprimia
"[object Object]" por passar o objeto de config como mensagem em vez de
metadado.
LOG_LEVEL default muda de debug para info em .env.example e
.env.production, unica forma do rebaixamento acima ter efeito pratico.
Co-Authored-By: Claude Sonnet 5 <noreply@anthropic.com>
2026-07-10 16:00:29 -03:00
|
|
|
const logDebug = (message, meta = {}) => {
|
|
|
|
|
logger.debug(message, meta);
|
|
|
|
|
};
|
|
|
|
|
|
|
|
|
|
// Log de sincronização específico. Fica em debug: por causa da margem de seguranca do
|
|
|
|
|
// watermark, esse log dispara toda vez que ha qualquer ticket "quente" no lote, mesmo sem
|
|
|
|
|
// mudanca real de campo - o sinal de mudanca de verdade e logado no chamador.
|
2025-09-05 20:27:35 -03:00
|
|
|
const logSync = (service, count, type) => {
|
PERF: Reduz verbosidade de logs em nivel info no ciclo do cron
Rebaixa para debug uma serie de logs "heartbeat" que disparavam todo ciclo
(a cada 1 minuto) independente de qualquer mudanca real, competindo com os
logs de acao/erro que realmente importam: buscas por watermark, contagem
de tickets pendentes/monitorados, checagens de comentario ja sincronizado,
abertura de conexao GLPI/PostgreSQL, e o resumo de sincronizacao do SN
(que a margem de seguranca de 6h do watermark sempre retorna nao-vazio,
mesmo sem mudanca real de campo).
Corrige tambem um bug real encontrado em teste: no fluxo GLPI -> SN, todo
comentario historico de um ticket era sanitizado e checado contra a API do
SN a cada ciclo antes mesmo de verificar se ja tinha sido sincronizado
(ticket_updates.destiny_id). Em tickets com historico longo isso
significava dezenas de chamadas desnecessarias por minuto. Agora a
checagem local (barata) roda primeiro, e so sanitiza/consulta o SN quando
o comentario realmente ainda nao foi sincronizado.
Corrige tambem o log de configuracao do pool PostgreSQL, que imprimia
"[object Object]" por passar o objeto de config como mensagem em vez de
metadado.
LOG_LEVEL default muda de debug para info em .env.example e
.env.production, unica forma do rebaixamento acima ter efeito pratico.
Co-Authored-By: Claude Sonnet 5 <noreply@anthropic.com>
2026-07-10 16:00:29 -03:00
|
|
|
logger.debug(`SYNC: ${service} - ${count} ${type} sincronizados`, {
|
|
|
|
|
service,
|
|
|
|
|
count,
|
|
|
|
|
type
|
2025-09-05 20:27:35 -03:00
|
|
|
});
|
2025-08-30 19:04:35 -03:00
|
|
|
};
|
|
|
|
|
|
|
|
|
|
module.exports = {
|
2025-09-05 20:27:35 -03:00
|
|
|
logger,
|
2025-08-30 19:04:35 -03:00
|
|
|
logError,
|
|
|
|
|
logInfo,
|
2025-09-05 20:27:35 -03:00
|
|
|
logWarning,
|
PERF: Reduz verbosidade de logs em nivel info no ciclo do cron
Rebaixa para debug uma serie de logs "heartbeat" que disparavam todo ciclo
(a cada 1 minuto) independente de qualquer mudanca real, competindo com os
logs de acao/erro que realmente importam: buscas por watermark, contagem
de tickets pendentes/monitorados, checagens de comentario ja sincronizado,
abertura de conexao GLPI/PostgreSQL, e o resumo de sincronizacao do SN
(que a margem de seguranca de 6h do watermark sempre retorna nao-vazio,
mesmo sem mudanca real de campo).
Corrige tambem um bug real encontrado em teste: no fluxo GLPI -> SN, todo
comentario historico de um ticket era sanitizado e checado contra a API do
SN a cada ciclo antes mesmo de verificar se ja tinha sido sincronizado
(ticket_updates.destiny_id). Em tickets com historico longo isso
significava dezenas de chamadas desnecessarias por minuto. Agora a
checagem local (barata) roda primeiro, e so sanitiza/consulta o SN quando
o comentario realmente ainda nao foi sincronizado.
Corrige tambem o log de configuracao do pool PostgreSQL, que imprimia
"[object Object]" por passar o objeto de config como mensagem em vez de
metadado.
LOG_LEVEL default muda de debug para info em .env.example e
.env.production, unica forma do rebaixamento acima ter efeito pratico.
Co-Authored-By: Claude Sonnet 5 <noreply@anthropic.com>
2026-07-10 16:00:29 -03:00
|
|
|
logDebug,
|
2025-11-19 16:01:37 -03:00
|
|
|
logSync,
|
2026-02-27 17:03:17 -03:00
|
|
|
};
|