{"action":"reopened","issue":{"url":"https://api.github.com/repos/cloudfoundry/noaa/issues/8","labels_url":"https://api.github.com/repos/cloudfoundry/noaa/issues/8/labels{/name}","comments_url":"https://api.github.com/repos/cloudfoundry/noaa/issues/8/comments","events_url":"https://api.github.com/repos/cloudfoundry/noaa/issues/8/events","html_url":"https://github.com/cloudfoundry/noaa/issues/8","id":90393315,"number":8,"title":"Missing events.","user":{"login":"simonjohansson","id":736248,"avatar_url":"https://avatars.githubusercontent.com/u/736248?v=3","gravatar_id":"","url":"https://api.github.com/users/simonjohansson","html_url":"https://github.com/simonjohansson","followers_url":"https://api.github.com/users/simonjohansson/followers","following_url":"https://api.github.com/users/simonjohansson/following{/other_user}","gists_url":"https://api.github.com/users/simonjohansson/gists{/gist_id}","starred_url":"https://api.github.com/users/simonjohansson/starred{/owner}{/repo}","subscriptions_url":"https://api.github.com/users/simonjohansson/subscriptions","organizations_url":"https://api.github.com/users/simonjohansson/orgs","repos_url":"https://api.github.com/users/simonjohansson/repos","events_url":"https://api.github.com/users/simonjohansson/events{/privacy}","received_events_url":"https://api.github.com/users/simonjohansson/received_events","type":"User","site_admin":false},"labels":[],"state":"open","locked":false,"assignee":null,"milestone":null,"comments":11,"created_at":"2015-06-23T13:41:26Z","updated_at":"2015-08-24T11:29:15Z","closed_at":null,"body":"Howdie!\r\n\r\nIm using https://github.com/cloudfoundry-samples/fib-cpu in a newly deployed empty CF 211 VMWare installation. For each request to the app we get two log events\r\n\r\n```\r\n$ curl fib.test.cf.domain.com/10\r\n$ cf logs fib\r\n...\r\n2015-06-23T15:26:40.28+0200 [App/0]      OUT Request /10 took 3.3326e-05 seconds to complete\r\n2015-06-23T15:26:40.29+0200 [RTR/0]      OUT fib.test.cf.domain.com - [23/06/2015:13:26:40 +0000] \"GET /10 HTTP/1.1\" 200 0 2 \"-\" \"curl/7.43.0\" 10.230.31.7:51182 x_forwarded_for:\"10.230.31.7\" vcap_request_id:ce6fb1e7-ff26-497b-6c5c-b11cd47fb70d response_time:0.009590970 app_id:082fea25-f40b-4bff-8c12-7586447cb6c4\r\n```\r\n\r\nUsing the noaa-client I would expect that shooting off 10 requests would yield 20 events but I get between 10-18 for each test I do.\r\n\r\nSetup\r\n```\r\n$ GOPATH=/tmp go get github.com/cloudfoundry/noaa\r\n$ cd /tmp/src/github.com/cloudfoundry/noaa/\r\n$ git --no-pager show --summary \r\ncommit 7f3b03afe00e1bf449cf1651a8623d878e20c70d\r\nAuthor: John Tuley <jtuley@pivotal.io>\r\nDate:   Thu Jun 18 16:50:33 2015 -0600\r\n\r\n    Revert \"Set gogo/protobuf version to be the same as the one in loggregator for travis builds\"\r\n\r\n    This reverts commit 3c78d4555842c8a7396fa4fc3ef18376c08a3e31.\r\n\r\n    [#97345078]\r\n```\r\n\r\nConsuming and comparing events\r\n\r\n```\r\nterm1$ cf logs fib > /tmp/logs-from-cf-logs\r\nterm2$ CF_ACCESS_TOKEN=wryyyy DOPPLER_ADDR=wss://doppler.test.cf.domain.com:443 GOPATH=/tmp go run firehose_sample/main.go > /tmp/noaa-client\r\nterm3$ repeat 10 curl fib.test.cf.domain.com/10 \r\nterm3$ cat /tmp/logs-from-cf-logs | egrep \"App|RTR\" | wc -l\r\n20\r\nterm3$ cat /tmp/noaa-client | egrep \"LogMessage\" | wc -l  \r\n17\r\n$ cat /tmp/noaa-client | egrep \"LogMessage\"        \r\norigin:\"dea_logging_agent\" eventType:LogMessage timestamp:1435066555822822483 logMessage:<message:\"Request /10 took 3.3829e-05 seconds to complete\" message_type:OUT timestamp:1435066555822820553 app_id:\"082fea25-f40b-4bff-8c12-7586447cb6c4\" source_type:\"App\" source_instance:\"0\" >  \r\norigin:\"router__0\" eventType:LogMessage timestamp:1435066555829558583 logMessage:<message:\"fib.test.cf.domain.com - [23/06/2015:13:35:55 +0000] \\\"GET /10 HTTP/1.1\\\" 200 0 2 \\\"-\\\" \\\"curl/7.43.0\\\" 10.230.31.3:51264 x_forwarded_for:\\\"10.230.31.3\\\" vcap_request_id:37c3dd2f-49d4-49e5-4d85-52cf57baac84 response_time:0.007996051 app_id:082fea25-f40b-4bff-8c12-7586447cb6c4\\n\" message_type:OUT timestamp:1435066555829556378 app_id:\"082fea25-f40b-4bff-8c12-7586447cb6c4\" source_type:\"RTR\" source_instance:\"0\" >  \r\norigin:\"dea_logging_agent\" eventType:LogMessage timestamp:1435066555891428615 logMessage:<message:\"Request /10 took 3.2354e-05 seconds to complete\" message_type:OUT timestamp:1435066555891427679 app_id:\"082fea25-f40b-4bff-8c12-7586447cb6c4\" source_type:\"App\" source_instance:\"0\" >  \r\norigin:\"dea_logging_agent\" eventType:LogMessage timestamp:1435066555972095337 logMessage:<message:\"Request /10 took 7.346e-05 seconds to complete\" message_type:OUT timestamp:1435066555972093060 app_id:\"082fea25-f40b-4bff-8c12-7586447cb6c4\" source_type:\"App\" source_instance:\"0\" >  \r\norigin:\"router__0\" eventType:LogMessage timestamp:1435066555974757126 logMessage:<message:\"fib.test.cf.domain.com - [23/06/2015:13:35:55 +0000] \\\"GET /10 HTTP/1.1\\\" 200 0 2 \\\"-\\\" \\\"curl/7.43.0\\\" 10.230.31.1:51266 x_forwarded_for:\\\"10.230.31.1\\\" vcap_request_id:5efaea2d-aee3-4c30-4e6d-91b354d5bf92 response_time:0.008960204 app_id:082fea25-f40b-4bff-8c12-7586447cb6c4\\n\" message_type:OUT timestamp:1435066555974755399 app_id:\"082fea25-f40b-4bff-8c12-7586447cb6c4\" source_type:\"RTR\" source_instance:\"0\" >  \r\norigin:\"dea_logging_agent\" eventType:LogMessage timestamp:1435066556038989559 logMessage:<message:\"Request /10 took 5.659e-05 seconds to complete\" message_type:OUT timestamp:1435066556038988623 app_id:\"082fea25-f40b-4bff-8c12-7586447cb6c4\" source_type:\"App\" source_instance:\"0\" >  \r\norigin:\"dea_logging_agent\" eventType:LogMessage timestamp:1435066556105148981 logMessage:<message:\"Request /10 took 3.25e-05 seconds to complete\" message_type:OUT timestamp:1435066556105136936 app_id:\"082fea25-f40b-4bff-8c12-7586447cb6c4\" source_type:\"App\" source_instance:\"0\" >  \r\norigin:\"router__0\" eventType:LogMessage timestamp:1435066556107187549 logMessage:<message:\"fib.test.cf.domain.com - [23/06/2015:13:35:56 +0000] \\\"GET /10 HTTP/1.1\\\" 200 0 2 \\\"-\\\" \\\"curl/7.43.0\\\" 10.230.31.5:51268 x_forwarded_for:\\\"10.230.31.5\\\" vcap_request_id:06cf7d10-f3d7-47fb-6227-86eea2813bdd response_time:0.005772654 app_id:082fea25-f40b-4bff-8c12-7586447cb6c4\\n\" message_type:OUT timestamp:1435066556107185859 app_id:\"082fea25-f40b-4bff-8c12-7586447cb6c4\" source_type:\"RTR\" source_instance:\"0\" >  \r\norigin:\"dea_logging_agent\" eventType:LogMessage timestamp:1435066556187180248 logMessage:<message:\"Request /10 took 7.2833e-05 seconds to complete\" message_type:OUT timestamp:1435066556187178939 app_id:\"082fea25-f40b-4bff-8c12-7586447cb6c4\" source_type:\"App\" source_instance:\"0\" >  \r\norigin:\"router__0\" eventType:LogMessage timestamp:1435066556190834073 logMessage:<message:\"fib.test.cf.domain.com - [23/06/2015:13:35:56 +0000] \\\"GET /10 HTTP/1.1\\\" 200 0 2 \\\"-\\\" \\\"curl/7.43.0\\\" 10.230.31.4:51269 x_forwarded_for:\\\"10.230.31.4\\\" vcap_request_id:fdf08d66-fe09-4578-7545-921207b5ca2e response_time:0.008445217 app_id:082fea25-f40b-4bff-8c12-7586447cb6c4\\n\" message_type:OUT timestamp:1435066556190832236 app_id:\"082fea25-f40b-4bff-8c12-7586447cb6c4\" source_type:\"RTR\" source_instance:\"0\" >  \r\norigin:\"dea_logging_agent\" eventType:LogMessage timestamp:1435066556273007272 logMessage:<message:\"Request /10 took 3.2422e-05 seconds to complete\" message_type:OUT timestamp:1435066556273005906 app_id:\"082fea25-f40b-4bff-8c12-7586447cb6c4\" source_type:\"App\" source_instance:\"0\" >  \r\norigin:\"router__0\" eventType:LogMessage timestamp:1435066556276260011 logMessage:<message:\"fib.test.cf.domain.com - [23/06/2015:13:35:56 +0000] \\\"GET /10 HTTP/1.1\\\" 200 0 2 \\\"-\\\" \\\"curl/7.43.0\\\" 10.230.31.3:51270 x_forwarded_for:\\\"10.230.31.3\\\" vcap_request_id:86dfedaf-27aa-4333-6542-5f17171afe9b response_time:0.006513990 app_id:082fea25-f40b-4bff-8c12-7586447cb6c4\\n\" message_type:OUT timestamp:1435066556276258104 app_id:\"082fea25-f40b-4bff-8c12-7586447cb6c4\" source_type:\"RTR\" source_instance:\"0\" >  \r\norigin:\"dea_logging_agent\" eventType:LogMessage timestamp:1435066556336575706 logMessage:<message:\"Request /10 took 3.2241e-05 seconds to complete\" message_type:OUT timestamp:1435066556336574740 app_id:\"082fea25-f40b-4bff-8c12-7586447cb6c4\" source_type:\"App\" source_instance:\"0\" >  \r\norigin:\"dea_logging_agent\" eventType:LogMessage timestamp:1435066556441946000 logMessage:<message:\"Request /10 took 7.332e-05 seconds to complete\" message_type:OUT timestamp:1435066556441944975 app_id:\"082fea25-f40b-4bff-8c12-7586447cb6c4\" source_type:\"App\" source_instance:\"0\" >  \r\norigin:\"router__0\" eventType:LogMessage timestamp:1435066556445317709 logMessage:<message:\"fib.test.cf.domain.com - [23/06/2015:13:35:56 +0000] \\\"GET /10 HTTP/1.1\\\" 200 0 2 \\\"-\\\" \\\"curl/7.43.0\\\" 10.230.31.2:51272 x_forwarded_for:\\\"10.230.31.2\\\" vcap_request_id:8ee423bd-88d7-4b02-5605-290e9935d259 response_time:0.008849451 app_id:082fea25-f40b-4bff-8c12-7586447cb6c4\\n\" message_type:OUT timestamp:1435066556445315729 app_id:\"082fea25-f40b-4bff-8c12-7586447cb6c4\" source_type:\"RTR\" source_instance:\"0\" >  \r\norigin:\"dea_logging_agent\" eventType:LogMessage timestamp:1435066556529838323 logMessage:<message:\"Request /10 took 7.2413e-05 seconds to complete\" message_type:OUT timestamp:1435066556529837317 app_id:\"082fea25-f40b-4bff-8c12-7586447cb6c4\" source_type:\"App\" source_instance:\"0\" >  \r\norigin:\"router__0\" eventType:LogMessage timestamp:1435066556533252926 logMessage:<message:\"fib.test.cf.domain.com - [23/06/2015:13:35:56 +0000] \\\"GET /10 HTTP/1.1\\\" 200 0 2 \\\"-\\\" \\\"curl/7.43.0\\\" 10.230.31.6:51273 x_forwarded_for:\\\"10.230.31.6\\\" vcap_request_id:ac3e6844-3b6f-4214-6995-c888113b930d response_time:0.008822410 app_id:082fea25-f40b-4bff-8c12-7586447cb6c4\\n\" message_type:OUT timestamp:1435066556533250929 app_id:\"082fea25-f40b-4bff-8c12-7586447cb6c4\" source_type:\"RTR\" source_instance:\"0\" >\r\n```\r\n\r\nLet me know if you need any other info!"}}