Skip to content

Commit

Permalink
[json layout] use json representation of meta when available (elast…
Browse files Browse the repository at this point in the history
…ic#171310)

## Summary

Use the json representation (`toJSON`) of the log's `meta` when merging
the message and the meta, if possible.
  • Loading branch information
pgayvallet authored Nov 15, 2023
1 parent 2c253bf commit 3d6ac9d
Show file tree
Hide file tree
Showing 3 changed files with 188 additions and 1 deletion.
Original file line number Diff line number Diff line change
Expand Up @@ -365,3 +365,90 @@ test('format() meta can not override tracing properties', () => {
transaction: { id: 'transaction_override' },
});
});

test('format() meta.toJSON() is used if own property', () => {
const layout = new JsonLayout();
expect(
JSON.parse(
layout.format({
message: 'foo',
timestamp,
level: LogLevel.Debug,
context: 'bar',
pid: 3,
meta: {
server: {
address: 'localhost',
},
service: {
version: '1',
},
// @ts-expect-error cannot override @timestamp
toJSON() {
return {
server: {
address: 'localhost',
},
};
},
},
})
)
).toStrictEqual({
ecs: { version: expect.any(String) },
'@timestamp': '2012-02-01T09:30:22.011-05:00',
message: 'foo',
log: {
level: 'DEBUG',
logger: 'bar',
},
process: {
pid: 3,
},
server: {
address: 'localhost',
},
});
});

test('format() meta.toJSON() is used if present on prototype', () => {
class SomeClass {
foo: string = 'bar';
hello: string = 'dolly';

toJSON() {
return {
foo: this.foo,
};
}
}

const someInstance = new SomeClass();

const layout = new JsonLayout();
expect(
JSON.parse(
layout.format({
message: 'foo',
timestamp,
level: LogLevel.Debug,
context: 'bar',
pid: 3,
// @ts-expect-error meta is not of the correct type
meta: someInstance,
})
)
).toStrictEqual({
ecs: { version: expect.any(String) },
'@timestamp': '2012-02-01T09:30:22.011-05:00',
message: 'foo',
log: {
level: 'DEBUG',
logger: 'bar',
},
process: {
pid: 3,
},
foo: 'bar',
});
});
Original file line number Diff line number Diff line change
Expand Up @@ -58,7 +58,13 @@ export class JsonLayout implements Layout {
trace: traceId ? { id: traceId } : undefined,
transaction: transactionId ? { id: transactionId } : undefined,
};
const output = record.meta ? merge({ ...record.meta }, log) : log;

let output = log;
if (record.meta) {
// @ts-expect-error toJSON not defined on `LogMeta`, but some structured meta can have it defined
const serializedMeta = record.meta.toJSON ? record.meta.toJSON() : { ...record.meta };
output = merge(serializedMeta, log);
}

return JSON.stringify(output);
}
Expand Down
Original file line number Diff line number Diff line change
@@ -0,0 +1,94 @@
/*
* Copyright Elasticsearch B.V. and/or licensed to Elasticsearch B.V. under one
* or more contributor license agreements. Licensed under the Elastic License
* 2.0 and the Server Side Public License, v 1; you may not use this file except
* in compliance with, at your election, the Elastic License 2.0 or the Server
* Side Public License, v 1.
*/

import {
createTestServers,
type TestElasticsearchUtils,
type TestKibanaUtils,
} from '@kbn/core-test-helpers-kbn-server';

describe('Error logging', () => {
describe('ES client errors', () => {
let mockConsoleLog: jest.SpyInstance;
let esServer: TestElasticsearchUtils;
let kibanaServer: TestKibanaUtils;

beforeAll(async () => {
mockConsoleLog = jest.spyOn(global.console, 'log');

const { startES, startKibana } = createTestServers({
adjustTimeout: jest.setTimeout,
settings: {
kbn: {
logging: {
appenders: {
'console-json': {
type: 'console',
layout: {
type: 'json',
},
},
},
loggers: [{ name: 'console-json', appenders: ['console-json'], level: 'debug' }],
},
},
},
});

esServer = await startES();
kibanaServer = await startKibana();
});

beforeEach(() => {
mockConsoleLog.mockClear();
});

afterAll(async () => {
mockConsoleLog.mockRestore();
await kibanaServer.stop();
await esServer.stop();
});

it('logs errors following the expected pattern for the json layout', async () => {
const esClient = kibanaServer.coreStart.elasticsearch.client.asInternalUser;
const logger = kibanaServer.root.logger.get('console-json');

try {
await esClient.search({
index: '.kibana',
// @ts-expect-error yes this is invalid
query: { someInvalidQuery: { foo: 'bar' } },
});
expect('should have thrown').toEqual('but it did not');
} catch (e) {
logger.info('logging elasticsearch error', e);

const calls = mockConsoleLog.mock.calls;
const ourCall = calls
.map((call) => call[0])
.find((call) => call.includes('logging elasticsearch error'));

expect(JSON.parse(ourCall)).toEqual({
'@timestamp': expect.any(String),
ecs: {
version: expect.any(String),
},
log: {
level: 'INFO',
logger: 'console-json',
},
message: 'logging elasticsearch error',
name: 'ResponseError',
process: {
pid: expect.any(Number),
},
});
}
});
});
});

0 comments on commit 3d6ac9d

Please sign in to comment.