Logging

[graebm]

Here are results of a GET with elasticurl (filtering out everything but "http" log entries)
./elasticurl -v TRACE example.org 2>&1 | grep '\[http'

INFO

[INFO ] [2019-03-13T21:53:45Z] [123145416802304] [http-connection] - id=0x615000010e80: HTTP/1.1 client connection established.
[INFO ] [2019-03-13T21:53:45Z] [123145416802304] [http-connection] - id=0x615000010e80: Connection shutting down with error code 0 (AWS_ERROR_SUCCESS).

DEBUG

[INFO ] [2019-03-13T21:54:39Z] [123145318748160] [http-connection] - id=0x615000010e80: HTTP/1.1 client connection established.
[DEBUG] [2019-03-13T21:54:39Z] [123145318748160] [http-stream] - id=0x611000013b40: Created client request: GET / HTTP/1.1
[DEBUG] [2019-03-13T21:54:39Z] [123145318748160] [http-stream] - id=0x611000013b40: Client request complete, response status: 200 (OK).
[INFO ] [2019-03-13T21:54:39Z] [123145318748160] [http-connection] - id=0x615000010e80: Connection shutting down with error code 0 (AWS_ERROR_SUCCESS).

TRACE

[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-connection] - static: Socket connected, creating client connection object.
[INFO ] [2019-03-13T21:55:35Z] [123145408667648] [http-connection] - id=0x615000010e80: HTTP/1.1 client connection established.
[DEBUG] [2019-03-13T21:55:35Z] [123145408667648] [http-stream] - id=0x611000034e80: Created client request: GET / HTTP/1.1
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-connection] - id=0x615000010e80: Scheduling outgoing stream task.
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-connection] - id=0x615000010e80: Connection refcount released, 1 remaining.
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-connection] - id=0x615000010e80: Outgoing stream task is running.
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-connection] - id=0x615000010e80: Current outgoing stream is now 0x611000034e80.
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-connection] - id=0x615000010e80: Current incoming stream is now 0x611000034e80.
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-stream] - id=0x611000034e80: Writing to message, outgoing head progress 114/114.
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-stream] - id=0x611000034e80: No body to send.
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-stream] - id=0x611000034e80: Stream is done sending data.
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-connection] - id=0x615000010e80: Current outgoing stream is now 0x0.
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-connection] - id=0x615000010e80: Outgoing stream task is sending message of size 114.
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-connection] - id=0x615000010e80: Outgoing stream task complete.
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-connection] - id=0x615000010e80: Begin processing message of size 322.
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-stream] - id=0x611000034e80: Incoming version: HTTP/1.1
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-stream] - id=0x611000034e80: Incoming response status: 200 (OK).
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-stream] - id=0x611000034e80: Incoming header: Cache-Control: max-age=604800
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-stream] - id=0x611000034e80: Incoming header: Content-Type: text/html; charset=UTF-8
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-stream] - id=0x611000034e80: Incoming header: Date: Wed, 13 Mar 2019 21
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-stream] - id=0x611000034e80: Incoming header: Etag: "1541025663+ident"
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-stream] - id=0x611000034e80: Incoming header: Expires: Wed, 20 Mar 2019 21
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-stream] - id=0x611000034e80: Incoming header: Last-Modified: Fri, 09 Aug 2013 23
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-stream] - id=0x611000034e80: Incoming header: Server: ECS (sec/97A6)
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-stream] - id=0x611000034e80: Incoming header: Vary: Accept-Encoding
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-stream] - id=0x611000034e80: Incoming header: X-Cache: HIT
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-stream] - id=0x611000034e80: Incoming header: Content-Length: 1270
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-connection] - id=0x615000010e80: Done processing message.
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-connection] - id=0x615000010e80: Begin processing message of size 1270.
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-stream] - id=0x611000034e80: Incoming head is done, body is next.
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-stream] - id=0x611000034e80: Incoming body: 1270 bytes received.
[DEBUG] [2019-03-13T21:55:35Z] [123145408667648] [http-stream] - id=0x611000034e80: Client request complete, response status: 200 (OK).
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-stream] - id=0x611000034e80: Stream refcount released, 1 remaining.
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-stream] - id=0x611000034e80: Final stream refcount released.
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-stream] - id=0x611000034e80: Stream destroyed.
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-connection] - id=0x615000010e80: Final connection refcount released, shut down if necessary.
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-connection] - id=0x615000010e80: Channel shutting down with error code 0 (AWS_ERROR_SUCCESS).
[INFO ] [2019-03-13T21:55:35Z] [123145408667648] [http-connection] - id=0x615000010e80: Connection shutting down with error code 0 (AWS_ERROR_SUCCESS).
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-connection] - id=0x615000010e80: Current incoming stream is now 0x0.
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-connection] - id=0x615000010e80: Done processing message.
[TRACE] [2019-03-13T21:55:35Z] [123145408667648] [http-connection] - id=0x615000010e80: Destroying connection.

By submitting this pull request, I confirm that my contribution is made under the terms of the Apache 2.0 license.

[justinboswell]

My only other thought is that I can't decide if some of the log messages are TOO friendly/not concise enough. I'd be interested in others' opinions there.