I, [2016-07-29T10:24:59.880735 #34433]  INFO -- : Started GET "/page-1" for 127.0.0.1 at 2016-07-29 10:24:59 -0700
I, [2016-07-29T10:24:59.884122 #34433]  INFO -- : Processing by Mascot::SitemapController#show as HTML
I, [2016-07-29T10:24:59.884177 #34433]  INFO -- :   Parameters: {"path"=>"page-1"}
I, [2016-07-29T10:25:01.200590 #34433]  INFO -- :   Rendered inline template within layouts/application (1310.9ms)
I, [2016-07-29T10:25:01.201586 #34433]  INFO -- : Completed 500 Internal Server Error in 1317ms (ActiveRecord: 0.0ms)
F, [2016-07-29T10:25:01.205819 #34433] FATAL -- : 
Interrupt ():
  /Users/bradgessler/.rbenv/versions/2.3.0/lib/ruby/2.3.0/psych/scalar_scanner.rb:58:in `tokenize'
  /Users/bradgessler/.rbenv/versions/2.3.0/lib/ruby/2.3.0/psych/visitors/to_ruby.rb:60:in `deserialize'
  /Users/bradgessler/.rbenv/versions/2.3.0/lib/ruby/2.3.0/psych/visitors/to_ruby.rb:123:in `visit_Psych_Nodes_Scalar'
  /Users/bradgessler/.rbenv/versions/2.3.0/lib/ruby/2.3.0/psych/visitors/visitor.rb:16:in `visit'
  /Users/bradgessler/.rbenv/versions/2.3.0/lib/ruby/2.3.0/psych/visitors/visitor.rb:6:in `accept'
  /Users/bradgessler/.rbenv/versions/2.3.0/lib/ruby/2.3.0/psych/visitors/to_ruby.rb:32:in `accept'
  /Users/bradgessler/.rbenv/versions/2.3.0/lib/ruby/2.3.0/psych/visitors/to_ruby.rb:337:in `block in revive_hash'
  /Users/bradgessler/.rbenv/versions/2.3.0/lib/ruby/2.3.0/psych/visitors/to_ruby.rb:336:in `each'
  /Users/bradgessler/.rbenv/versions/2.3.0/lib/ruby/2.3.0/psych/visitors/to_ruby.rb:336:in `each_slice'
  /Users/bradgessler/.rbenv/versions/2.3.0/lib/ruby/2.3.0/psych/visitors/to_ruby.rb:336:in `revive_hash'
  /Users/bradgessler/.rbenv/versions/2.3.0/lib/ruby/2.3.0/psych/visitors/to_ruby.rb:162:in `visit_Psych_Nodes_Mapping'
  /Users/bradgessler/.rbenv/versions/2.3.0/lib/ruby/2.3.0/psych/visitors/visitor.rb:16:in `visit'
  /Users/bradgessler/.rbenv/versions/2.3.0/lib/ruby/2.3.0/psych/visitors/visitor.rb:6:in `accept'
  /Users/bradgessler/.rbenv/versions/2.3.0/lib/ruby/2.3.0/psych/visitors/to_ruby.rb:32:in `accept'
  /Users/bradgessler/.rbenv/versions/2.3.0/lib/ruby/2.3.0/psych/visitors/to_ruby.rb:311:in `visit_Psych_Nodes_Document'
  /Users/bradgessler/.rbenv/versions/2.3.0/lib/ruby/2.3.0/psych/visitors/visitor.rb:16:in `visit'
  /Users/bradgessler/.rbenv/versions/2.3.0/lib/ruby/2.3.0/psych/visitors/visitor.rb:6:in `accept'
  /Users/bradgessler/.rbenv/versions/2.3.0/lib/ruby/2.3.0/psych/visitors/to_ruby.rb:32:in `accept'
  /Users/bradgessler/.rbenv/versions/2.3.0/lib/ruby/2.3.0/psych/nodes/node.rb:38:in `to_ruby'
  /Users/bradgessler/.rbenv/versions/2.3.0/lib/ruby/2.3.0/psych.rb:253:in `load'
  /Users/bradgessler/Projects/mascot/mascot/lib/mascot/frontmatter.rb:16:in `data'
  /Users/bradgessler/Projects/mascot/mascot/lib/mascot/resource.rb:45:in `data'
  inline template:5:in `block in _inline_template___2569939121292557744_70270984710320'
  /Users/bradgessler/Projects/mascot/mascot/lib/mascot/resources.rb:14:in `each'
  /Users/bradgessler/Projects/mascot/mascot/lib/mascot/resources.rb:14:in `each'
  inline template:4:in `_inline_template___2569939121292557744_70270984710320'
  actionview (4.2.7) lib/action_view/template.rb:145:in `block in render'
  activesupport (4.2.7) lib/active_support/notifications.rb:166:in `instrument'
  actionview (4.2.7) lib/action_view/template.rb:333:in `instrument'
  actionview (4.2.7) lib/action_view/template.rb:143:in `render'
  actionview (4.2.7) lib/action_view/renderer/template_renderer.rb:54:in `block (2 levels) in render_template'
  actionview (4.2.7) lib/action_view/renderer/abstract_renderer.rb:39:in `block in instrument'
  activesupport (4.2.7) lib/active_support/notifications.rb:164:in `block in instrument'
  activesupport (4.2.7) lib/active_support/notifications/instrumenter.rb:20:in `instrument'
  activesupport (4.2.7) lib/active_support/notifications.rb:164:in `instrument'
  actionview (4.2.7) lib/action_view/renderer/abstract_renderer.rb:39:in `instrument'
  actionview (4.2.7) lib/action_view/renderer/template_renderer.rb:53:in `block in render_template'
  actionview (4.2.7) lib/action_view/renderer/template_renderer.rb:61:in `render_with_layout'
  actionview (4.2.7) lib/action_view/renderer/template_renderer.rb:52:in `render_template'
  actionview (4.2.7) lib/action_view/renderer/template_renderer.rb:14:in `render'
  actionview (4.2.7) lib/action_view/renderer/renderer.rb:46:in `render_template'
  actionview (4.2.7) lib/action_view/renderer/renderer.rb:27:in `render'
  actionview (4.2.7) lib/action_view/rendering.rb:100:in `_render_template'
  actionpack (4.2.7) lib/action_controller/metal/streaming.rb:217:in `_render_template'
  actionview (4.2.7) lib/action_view/rendering.rb:83:in `render_to_body'
  actionpack (4.2.7) lib/action_controller/metal/rendering.rb:32:in `render_to_body'
  actionpack (4.2.7) lib/action_controller/metal/renderers.rb:37:in `render_to_body'
  actionpack (4.2.7) lib/abstract_controller/rendering.rb:25:in `render'
  actionpack (4.2.7) lib/action_controller/metal/rendering.rb:16:in `render'
  actionpack (4.2.7) lib/action_controller/metal/instrumentation.rb:44:in `block (2 levels) in render'
  activesupport (4.2.7) lib/active_support/core_ext/benchmark.rb:12:in `block in ms'
  /Users/bradgessler/.rbenv/versions/2.3.0/lib/ruby/2.3.0/benchmark.rb:308:in `realtime'
  activesupport (4.2.7) lib/active_support/core_ext/benchmark.rb:12:in `ms'
  actionpack (4.2.7) lib/action_controller/metal/instrumentation.rb:44:in `block in render'
  actionpack (4.2.7) lib/action_controller/metal/instrumentation.rb:87:in `cleanup_view_runtime'
  activerecord (4.2.7) lib/active_record/railties/controller_runtime.rb:25:in `cleanup_view_runtime'
  actionpack (4.2.7) lib/action_controller/metal/instrumentation.rb:43:in `render'
  /Users/bradgessler/Projects/mascot/mascot-rails/lib/mascot/action_controller_context.rb:22:in `render'
  /Users/bradgessler/Projects/mascot/mascot-rails/app/controllers/mascot/sitemap_controller.rb:6:in `show'
  actionpack (4.2.7) lib/action_controller/metal/implicit_render.rb:4:in `send_action'
  actionpack (4.2.7) lib/abstract_controller/base.rb:198:in `process_action'
  actionpack (4.2.7) lib/action_controller/metal/rendering.rb:10:in `process_action'
  actionpack (4.2.7) lib/abstract_controller/callbacks.rb:20:in `block in process_action'
  activesupport (4.2.7) lib/active_support/callbacks.rb:117:in `call'
  activesupport (4.2.7) lib/active_support/callbacks.rb:555:in `block (2 levels) in compile'
  activesupport (4.2.7) lib/active_support/callbacks.rb:505:in `call'
  activesupport (4.2.7) lib/active_support/callbacks.rb:92:in `__run_callbacks__'
  activesupport (4.2.7) lib/active_support/callbacks.rb:778:in `_run_process_action_callbacks'
  activesupport (4.2.7) lib/active_support/callbacks.rb:81:in `run_callbacks'
  actionpack (4.2.7) lib/abstract_controller/callbacks.rb:19:in `process_action'
  actionpack (4.2.7) lib/action_controller/metal/rescue.rb:29:in `process_action'
  actionpack (4.2.7) lib/action_controller/metal/instrumentation.rb:32:in `block in process_action'
  activesupport (4.2.7) lib/active_support/notifications.rb:164:in `block in instrument'
  activesupport (4.2.7) lib/active_support/notifications/instrumenter.rb:20:in `instrument'
  activesupport (4.2.7) lib/active_support/notifications.rb:164:in `instrument'
  actionpack (4.2.7) lib/action_controller/metal/instrumentation.rb:30:in `process_action'
  actionpack (4.2.7) lib/action_controller/metal/params_wrapper.rb:250:in `process_action'
  activerecord (4.2.7) lib/active_record/railties/controller_runtime.rb:18:in `process_action'
  actionpack (4.2.7) lib/abstract_controller/base.rb:137:in `process'
  actionview (4.2.7) lib/action_view/rendering.rb:30:in `process'
  actionpack (4.2.7) lib/action_controller/metal.rb:196:in `dispatch'
  actionpack (4.2.7) lib/action_controller/metal/rack_delegation.rb:13:in `dispatch'
  actionpack (4.2.7) lib/action_controller/metal.rb:237:in `block in action'
  actionpack (4.2.7) lib/action_dispatch/routing/route_set.rb:74:in `dispatch'
  actionpack (4.2.7) lib/action_dispatch/routing/route_set.rb:43:in `serve'
  actionpack (4.2.7) lib/action_dispatch/routing/mapper.rb:49:in `serve'
  actionpack (4.2.7) lib/action_dispatch/journey/router.rb:43:in `block in serve'
  actionpack (4.2.7) lib/action_dispatch/journey/router.rb:30:in `each'
  actionpack (4.2.7) lib/action_dispatch/journey/router.rb:30:in `serve'
  actionpack (4.2.7) lib/action_dispatch/routing/route_set.rb:817:in `call'
  rack (1.6.4) lib/rack/etag.rb:24:in `call'
  rack (1.6.4) lib/rack/conditionalget.rb:25:in `call'
  rack (1.6.4) lib/rack/head.rb:13:in `call'
  actionpack (4.2.7) lib/action_dispatch/middleware/params_parser.rb:27:in `call'
  actionpack (4.2.7) lib/action_dispatch/middleware/flash.rb:260:in `call'
  rack (1.6.4) lib/rack/session/abstract/id.rb:225:in `context'
  rack (1.6.4) lib/rack/session/abstract/id.rb:220:in `call'
  actionpack (4.2.7) lib/action_dispatch/middleware/cookies.rb:560:in `call'
  activerecord (4.2.7) lib/active_record/query_cache.rb:36:in `call'
  activerecord (4.2.7) lib/active_record/connection_adapters/abstract/connection_pool.rb:653:in `call'
  actionpack (4.2.7) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call'
  activesupport (4.2.7) lib/active_support/callbacks.rb:88:in `__run_callbacks__'
  activesupport (4.2.7) lib/active_support/callbacks.rb:778:in `_run_call_callbacks'
  activesupport (4.2.7) lib/active_support/callbacks.rb:81:in `run_callbacks'
  actionpack (4.2.7) lib/action_dispatch/middleware/callbacks.rb:27:in `call'
  actionpack (4.2.7) lib/action_dispatch/middleware/remote_ip.rb:78:in `call'
  actionpack (4.2.7) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call'
  actionpack (4.2.7) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call'
  railties (4.2.7) lib/rails/rack/logger.rb:38:in `call_app'
  railties (4.2.7) lib/rails/rack/logger.rb:20:in `block in call'
  activesupport (4.2.7) lib/active_support/tagged_logging.rb:68:in `block in tagged'
  activesupport (4.2.7) lib/active_support/tagged_logging.rb:26:in `tagged'
  activesupport (4.2.7) lib/active_support/tagged_logging.rb:68:in `tagged'
  railties (4.2.7) lib/rails/rack/logger.rb:20:in `call'
  actionpack (4.2.7) lib/action_dispatch/middleware/request_id.rb:21:in `call'
  rack (1.6.4) lib/rack/methodoverride.rb:22:in `call'
  rack (1.6.4) lib/rack/runtime.rb:18:in `call'
  activesupport (4.2.7) lib/active_support/cache/strategy/local_cache_middleware.rb:28:in `call'
  actionpack (4.2.7) lib/action_dispatch/middleware/static.rb:120:in `call'
  rack (1.6.4) lib/rack/sendfile.rb:113:in `call'
  railties (4.2.7) lib/rails/engine.rb:518:in `call'
  railties (4.2.7) lib/rails/application.rb:165:in `call'
  rack-test (0.6.3) lib/rack/mock_session.rb:30:in `request'
  rack-test (0.6.3) lib/rack/test.rb:244:in `process_request'
  rack-test (0.6.3) lib/rack/test.rb:58:in `get'
  /Users/bradgessler/Projects/mascot/mascot-rails/lib/mascot/route_constraint.rb:9:in `matches?'
  /benchmarks/rails_rendering_benchmark.rb:62:in `block (4 levels) in <main>'
  /Users/bradgessler/.rbenv/versions/2.3.0/lib/ruby/2.3.0/benchmark.rb:293:in `measure'
  /Users/bradgessler/.rbenv/versions/2.3.0/lib/ruby/2.3.0/benchmark.rb:257:in `block in bmbm'
  /Users/bradgessler/.rbenv/versions/2.3.0/lib/ruby/2.3.0/benchmark.rb:255:in `each'
  /Users/bradgessler/.rbenv/versions/2.3.0/lib/ruby/2.3.0/benchmark.rb:255:in `inject'
  /Users/bradgessler/.rbenv/versions/2.3.0/lib/ruby/2.3.0/benchmark.rb:255:in `bmbm'
  /Users/bradgessler/Projects/mascot/support/benchmark_dsl.rb:27:in `benchmark'
  /benchmarks/rails_rendering_benchmark.rb:54:in `block (2 levels) in <main>'
  /benchmarks/rails_rendering_benchmark.rb:51:in `each'
  /benchmarks/rails_rendering_benchmark.rb:51:in `block in <main>'
  /Users/bradgessler/Projects/mascot/support/benchmark_dsl.rb:18:in `fake_site'
  /benchmarks/rails_rendering_benchmark.rb:15:in `<main>'


I, [2016-07-29T10:25:29.773919 #34518]  INFO -- : Started GET "/page-1" for 127.0.0.1 at 2016-07-29 10:25:29 -0700
I, [2016-07-29T10:25:29.777000 #34518]  INFO -- : Processing by Mascot::SitemapController#show as HTML
I, [2016-07-29T10:25:29.777043 #34518]  INFO -- :   Parameters: {"path"=>"page-1"}
I, [2016-07-29T10:25:30.937426 #34518]  INFO -- :   Rendered inline template within layouts/application (1154.8ms)
I, [2016-07-29T10:25:30.955847 #34518]  INFO -- : Completed 200 OK in 1179ms (Views: 1175.7ms | ActiveRecord: 0.0ms)
I, [2016-07-29T10:25:30.959662 #34518]  INFO -- : Started GET "/baseline/render" for 127.0.0.1 at 2016-07-29 10:25:30 -0700
I, [2016-07-29T10:25:30.971313 #34518]  INFO -- : Processing by BaselineController#show as HTML
I, [2016-07-29T10:25:30.974823 #34518]  INFO -- :   Rendered baseline/show.html.erb within layouts/application (0.2ms)
I, [2016-07-29T10:25:30.975388 #34518]  INFO -- : Completed 200 OK in 4ms (Views: 3.8ms | ActiveRecord: 0.0ms)
I, [2016-07-29T10:25:30.976438 #34518]  INFO -- : Started GET "/page-1" for 127.0.0.1 at 2016-07-29 10:25:30 -0700
I, [2016-07-29T10:25:30.976927 #34518]  INFO -- : Processing by Mascot::SitemapController#show as HTML
I, [2016-07-29T10:25:30.976958 #34518]  INFO -- :   Parameters: {"path"=>"page-1"}
I, [2016-07-29T10:25:31.159115 #34518]  INFO -- :   Rendered inline template within layouts/application (181.7ms)
I, [2016-07-29T10:25:31.160935 #34518]  INFO -- : Completed 200 OK in 184ms (Views: 183.6ms | ActiveRecord: 0.0ms)
I, [2016-07-29T10:25:31.165100 #34518]  INFO -- : Started GET "/page-9999" for 127.0.0.1 at 2016-07-29 10:25:31 -0700
I, [2016-07-29T10:25:31.165728 #34518]  INFO -- : Processing by Mascot::SitemapController#show as HTML
I, [2016-07-29T10:25:31.165760 #34518]  INFO -- :   Parameters: {"path"=>"page-9999"}
I, [2016-07-29T10:25:31.317125 #34518]  INFO -- :   Rendered inline template within layouts/application (150.5ms)
I, [2016-07-29T10:25:31.318568 #34518]  INFO -- : Completed 200 OK in 153ms (Views: 152.2ms | ActiveRecord: 0.0ms)
I, [2016-07-29T10:25:31.498324 #34518]  INFO -- : Started GET "/page-1" for 127.0.0.1 at 2016-07-29 10:25:31 -0700
I, [2016-07-29T10:25:31.498865 #34518]  INFO -- : Processing by Mascot::SitemapController#show as HTML
I, [2016-07-29T10:25:31.498911 #34518]  INFO -- :   Parameters: {"path"=>"page-1"}
I, [2016-07-29T10:25:31.590826 #34518]  INFO -- :   Rendered inline template within layouts/application (91.5ms)
I, [2016-07-29T10:25:31.591551 #34518]  INFO -- : Completed 200 OK in 93ms (Views: 92.3ms | ActiveRecord: 0.0ms)
I, [2016-07-29T10:25:31.667923 #34518]  INFO -- : Started GET "/baseline/render" for 127.0.0.1 at 2016-07-29 10:25:31 -0700
I, [2016-07-29T10:25:31.668451 #34518]  INFO -- : Processing by BaselineController#show as HTML
I, [2016-07-29T10:25:31.668796 #34518]  INFO -- :   Rendered baseline/show.html.erb within layouts/application (0.0ms)
I, [2016-07-29T10:25:31.669190 #34518]  INFO -- : Completed 200 OK in 1ms (Views: 0.6ms | ActiveRecord: 0.0ms)
I, [2016-07-29T10:25:31.728212 #34518]  INFO -- : Started GET "/page-1" for 127.0.0.1 at 2016-07-29 10:25:31 -0700
I, [2016-07-29T10:25:31.728881 #34518]  INFO -- : Processing by Mascot::SitemapController#show as HTML
I, [2016-07-29T10:25:31.728924 #34518]  INFO -- :   Parameters: {"path"=>"page-1"}
I, [2016-07-29T10:25:31.819500 #34518]  INFO -- :   Rendered inline template within layouts/application (90.1ms)
I, [2016-07-29T10:25:31.820232 #34518]  INFO -- : Completed 200 OK in 91ms (Views: 91.0ms | ActiveRecord: 0.0ms)
I, [2016-07-29T10:25:31.896618 #34518]  INFO -- : Started GET "/page-9999" for 127.0.0.1 at 2016-07-29 10:25:31 -0700
I, [2016-07-29T10:25:31.897121 #34518]  INFO -- : Processing by Mascot::SitemapController#show as HTML
I, [2016-07-29T10:25:31.897154 #34518]  INFO -- :   Parameters: {"path"=>"page-9999"}
I, [2016-07-29T10:25:32.006642 #34518]  INFO -- :   Rendered inline template within layouts/application (109.1ms)
I, [2016-07-29T10:25:32.007493 #34518]  INFO -- : Completed 200 OK in 110ms (Views: 110.0ms | ActiveRecord: 0.0ms)
I, [2016-07-29T10:25:34.463208 #34518]  INFO -- : Started GET "/page-1" for 127.0.0.1 at 2016-07-29 10:25:34 -0700
I, [2016-07-29T10:25:34.463694 #34518]  INFO -- : Processing by Mascot::SitemapController#show as HTML
I, [2016-07-29T10:25:34.463724 #34518]  INFO -- :   Parameters: {"path"=>"page-1"}
I, [2016-07-29T10:25:37.023458 #34518]  INFO -- :   Rendered inline template within layouts/application (1266.0ms)
I, [2016-07-29T10:25:37.024161 #34518]  INFO -- : Completed 200 OK in 2560ms (Views: 1266.8ms | ActiveRecord: 0.0ms)
I, [2016-07-29T10:25:37.027457 #34518]  INFO -- : Started GET "/baseline/render" for 127.0.0.1 at 2016-07-29 10:25:37 -0700
I, [2016-07-29T10:25:37.027989 #34518]  INFO -- : Processing by BaselineController#show as HTML
I, [2016-07-29T10:25:37.028386 #34518]  INFO -- :   Rendered baseline/show.html.erb within layouts/application (0.0ms)
I, [2016-07-29T10:25:37.028831 #34518]  INFO -- : Completed 200 OK in 1ms (Views: 0.6ms | ActiveRecord: 0.0ms)
I, [2016-07-29T10:25:37.029794 #34518]  INFO -- : Started GET "/page-1" for 127.0.0.1 at 2016-07-29 10:25:37 -0700
I, [2016-07-29T10:25:37.030237 #34518]  INFO -- : Processing by Mascot::SitemapController#show as HTML
I, [2016-07-29T10:25:37.030267 #34518]  INFO -- :   Parameters: {"path"=>"page-1"}
I, [2016-07-29T10:25:39.529682 #34518]  INFO -- :   Rendered inline template within layouts/application (1216.1ms)
I, [2016-07-29T10:25:39.530450 #34518]  INFO -- : Completed 200 OK in 2500ms (Views: 1217.1ms | ActiveRecord: 0.0ms)
I, [2016-07-29T10:25:39.533413 #34518]  INFO -- : Started GET "/page-9999" for 127.0.0.1 at 2016-07-29 10:25:39 -0700
I, [2016-07-29T10:25:39.533900 #34518]  INFO -- : Processing by Mascot::SitemapController#show as HTML
I, [2016-07-29T10:25:39.533933 #34518]  INFO -- :   Parameters: {"path"=>"page-9999"}
I, [2016-07-29T10:25:41.769897 #34518]  INFO -- :   Rendered inline template within layouts/application (1092.9ms)
I, [2016-07-29T10:25:41.770739 #34518]  INFO -- : Completed 200 OK in 2237ms (Views: 1093.9ms | ActiveRecord: 0.0ms)
I, [2016-07-29T10:25:43.341081 #34518]  INFO -- : Started GET "/page-1" for 127.0.0.1 at 2016-07-29 10:25:43 -0700
I, [2016-07-29T10:25:43.341583 #34518]  INFO -- : Processing by Mascot::SitemapController#show as HTML
I, [2016-07-29T10:25:43.341624 #34518]  INFO -- :   Parameters: {"path"=>"page-1"}
I, [2016-07-29T10:25:45.515442 #34518]  INFO -- :   Rendered inline template within layouts/application (1048.1ms)
I, [2016-07-29T10:25:45.516217 #34518]  INFO -- : Completed 200 OK in 2175ms (Views: 1049.0ms | ActiveRecord: 0.0ms)
I, [2016-07-29T10:25:45.883385 #34518]  INFO -- : Started GET "/baseline/render" for 127.0.0.1 at 2016-07-29 10:25:45 -0700
I, [2016-07-29T10:25:45.884085 #34518]  INFO -- : Processing by BaselineController#show as HTML
I, [2016-07-29T10:25:45.884550 #34518]  INFO -- :   Rendered baseline/show.html.erb within layouts/application (0.0ms)
I, [2016-07-29T10:25:45.885099 #34518]  INFO -- : Completed 200 OK in 1ms (Views: 0.8ms | ActiveRecord: 0.0ms)
I, [2016-07-29T10:25:46.020159 #34518]  INFO -- : Started GET "/page-1" for 127.0.0.1 at 2016-07-29 10:25:46 -0700
I, [2016-07-29T10:25:46.020732 #34518]  INFO -- : Processing by Mascot::SitemapController#show as HTML
I, [2016-07-29T10:25:46.020778 #34518]  INFO -- :   Parameters: {"path"=>"page-1"}
I, [2016-07-29T10:25:48.100345 #34518]  INFO -- :   Rendered inline template within layouts/application (1061.1ms)
I, [2016-07-29T10:25:48.101341 #34518]  INFO -- : Completed 200 OK in 2080ms (Views: 1062.2ms | ActiveRecord: 0.0ms)
I, [2016-07-29T10:25:48.392604 #34518]  INFO -- : Started GET "/page-9999" for 127.0.0.1 at 2016-07-29 10:25:48 -0700
I, [2016-07-29T10:25:48.393106 #34518]  INFO -- : Processing by Mascot::SitemapController#show as HTML
I, [2016-07-29T10:25:48.393139 #34518]  INFO -- :   Parameters: {"path"=>"page-9999"}
I, [2016-07-29T10:25:50.485973 #34518]  INFO -- :   Rendered inline template within layouts/application (1053.1ms)
I, [2016-07-29T10:25:50.486992 #34518]  INFO -- : Completed 200 OK in 2094ms (Views: 1054.3ms | ActiveRecord: 0.0ms)
I, [2016-07-29T10:26:14.067305 #34638]  INFO -- : Started GET "/page-1" for 127.0.0.1 at 2016-07-29 10:26:14 -0700
I, [2016-07-29T10:26:14.070208 #34638]  INFO -- : Processing by Mascot::SitemapController#show as HTML
I, [2016-07-29T10:26:14.070249 #34638]  INFO -- :   Parameters: {"path"=>"page-1"}
I, [2016-07-29T10:26:15.242761 #34638]  INFO -- :   Rendered inline template within layouts/application (1167.1ms)
I, [2016-07-29T10:26:15.262712 #34638]  INFO -- : Completed 200 OK in 1192ms (Views: 1189.7ms | ActiveRecord: 0.0ms)
I, [2016-07-29T10:26:15.266529 #34638]  INFO -- : Started GET "/baseline/render" for 127.0.0.1 at 2016-07-29 10:26:15 -0700
I, [2016-07-29T10:26:15.274236 #34638]  INFO -- : Processing by BaselineController#show as HTML
I, [2016-07-29T10:26:15.277931 #34638]  INFO -- :   Rendered baseline/show.html.erb within layouts/application (0.3ms)
I, [2016-07-29T10:26:15.278684 #34638]  INFO -- : Completed 200 OK in 4ms (Views: 4.2ms | ActiveRecord: 0.0ms)
I, [2016-07-29T10:26:15.280003 #34638]  INFO -- : Started GET "/page-1" for 127.0.0.1 at 2016-07-29 10:26:15 -0700
I, [2016-07-29T10:26:15.280818 #34638]  INFO -- : Processing by Mascot::SitemapController#show as HTML
I, [2016-07-29T10:26:15.280862 #34638]  INFO -- :   Parameters: {"path"=>"page-1"}
I, [2016-07-29T10:26:15.460197 #34638]  INFO -- :   Rendered inline template within layouts/application (178.9ms)
I, [2016-07-29T10:26:15.461752 #34638]  INFO -- : Completed 200 OK in 181ms (Views: 180.6ms | ActiveRecord: 0.0ms)
I, [2016-07-29T10:26:15.466111 #34638]  INFO -- : Started GET "/page-9999" for 127.0.0.1 at 2016-07-29 10:26:15 -0700
I, [2016-07-29T10:26:15.466831 #34638]  INFO -- : Processing by Mascot::SitemapController#show as HTML
I, [2016-07-29T10:26:15.466870 #34638]  INFO -- :   Parameters: {"path"=>"page-9999"}
I, [2016-07-29T10:26:15.617708 #34638]  INFO -- :   Rendered inline template within layouts/application (150.2ms)
I, [2016-07-29T10:26:15.619045 #34638]  INFO -- : Completed 200 OK in 152ms (Views: 151.7ms | ActiveRecord: 0.0ms)
I, [2016-07-29T10:26:15.798730 #34638]  INFO -- : Started GET "/page-1" for 127.0.0.1 at 2016-07-29 10:26:15 -0700
I, [2016-07-29T10:26:15.799271 #34638]  INFO -- : Processing by Mascot::SitemapController#show as HTML
I, [2016-07-29T10:26:15.799304 #34638]  INFO -- :   Parameters: {"path"=>"page-1"}
I, [2016-07-29T10:26:15.893747 #34638]  INFO -- :   Rendered inline template within layouts/application (94.0ms)
I, [2016-07-29T10:26:15.894484 #34638]  INFO -- : Completed 200 OK in 95ms (Views: 94.9ms | ActiveRecord: 0.0ms)
I, [2016-07-29T10:26:15.977366 #34638]  INFO -- : Started GET "/baseline/render" for 127.0.0.1 at 2016-07-29 10:26:15 -0700
I, [2016-07-29T10:26:15.977929 #34638]  INFO -- : Processing by BaselineController#show as HTML
I, [2016-07-29T10:26:15.978319 #34638]  INFO -- :   Rendered baseline/show.html.erb within layouts/application (0.0ms)
I, [2016-07-29T10:26:15.978842 #34638]  INFO -- : Completed 200 OK in 1ms (Views: 0.7ms | ActiveRecord: 0.0ms)
I, [2016-07-29T10:26:16.042888 #34638]  INFO -- : Started GET "/page-1" for 127.0.0.1 at 2016-07-29 10:26:16 -0700
I, [2016-07-29T10:26:16.043414 #34638]  INFO -- : Processing by Mascot::SitemapController#show as HTML
I, [2016-07-29T10:26:16.043456 #34638]  INFO -- :   Parameters: {"path"=>"page-1"}
I, [2016-07-29T10:26:16.137884 #34638]  INFO -- :   Rendered inline template within layouts/application (93.9ms)
I, [2016-07-29T10:26:16.138725 #34638]  INFO -- : Completed 200 OK in 95ms (Views: 94.9ms | ActiveRecord: 0.0ms)
I, [2016-07-29T10:26:16.219332 #34638]  INFO -- : Started GET "/page-9999" for 127.0.0.1 at 2016-07-29 10:26:16 -0700
I, [2016-07-29T10:26:16.219834 #34638]  INFO -- : Processing by Mascot::SitemapController#show as HTML
I, [2016-07-29T10:26:16.219867 #34638]  INFO -- :   Parameters: {"path"=>"page-9999"}
I, [2016-07-29T10:26:16.311211 #34638]  INFO -- :   Rendered inline template within layouts/application (91.0ms)
I, [2016-07-29T10:26:16.312035 #34638]  INFO -- : Completed 200 OK in 92ms (Views: 91.9ms | ActiveRecord: 0.0ms)
I, [2016-07-29T10:26:18.653374 #34638]  INFO -- : Started GET "/page-1" for 127.0.0.1 at 2016-07-29 10:26:18 -0700
I, [2016-07-29T10:26:18.653931 #34638]  INFO -- : Processing by Mascot::SitemapController#show as HTML
I, [2016-07-29T10:26:18.653975 #34638]  INFO -- :   Parameters: {"path"=>"page-1"}
I, [2016-07-29T10:26:21.135888 #34638]  INFO -- :   Rendered inline template within layouts/application (1245.9ms)
I, [2016-07-29T10:26:21.136627 #34638]  INFO -- : Completed 200 OK in 2483ms (Views: 1246.8ms | ActiveRecord: 0.0ms)
I, [2016-07-29T10:26:21.139851 #34638]  INFO -- : Started GET "/baseline/render" for 127.0.0.1 at 2016-07-29 10:26:21 -0700
I, [2016-07-29T10:26:21.140499 #34638]  INFO -- : Processing by BaselineController#show as HTML
I, [2016-07-29T10:26:21.140858 #34638]  INFO -- :   Rendered baseline/show.html.erb within layouts/application (0.0ms)
I, [2016-07-29T10:26:21.141354 #34638]  INFO -- : Completed 200 OK in 1ms (Views: 0.7ms | ActiveRecord: 0.0ms)
I, [2016-07-29T10:26:21.142444 #34638]  INFO -- : Started GET "/page-1" for 127.0.0.1 at 2016-07-29 10:26:21 -0700
I, [2016-07-29T10:26:21.142852 #34638]  INFO -- : Processing by Mascot::SitemapController#show as HTML
I, [2016-07-29T10:26:21.142883 #34638]  INFO -- :   Parameters: {"path"=>"page-1"}
I, [2016-07-29T10:26:23.735667 #34638]  INFO -- :   Rendered inline template within layouts/application (1251.2ms)
I, [2016-07-29T10:26:23.736493 #34638]  INFO -- : Completed 200 OK in 2594ms (Views: 1252.2ms | ActiveRecord: 0.0ms)
I, [2016-07-29T10:26:23.739824 #34638]  INFO -- : Started GET "/page-9999" for 127.0.0.1 at 2016-07-29 10:26:23 -0700
I, [2016-07-29T10:26:23.740303 #34638]  INFO -- : Processing by Mascot::SitemapController#show as HTML
I, [2016-07-29T10:26:23.740344 #34638]  INFO -- :   Parameters: {"path"=>"page-9999"}
I, [2016-07-29T10:26:26.118463 #34638]  INFO -- :   Rendered inline template within layouts/application (1116.4ms)
I, [2016-07-29T10:26:26.119461 #34638]  INFO -- : Completed 200 OK in 2379ms (Views: 1117.5ms | ActiveRecord: 0.0ms)
I, [2016-07-29T10:26:27.776315 #34638]  INFO -- : Started GET "/page-1" for 127.0.0.1 at 2016-07-29 10:26:27 -0700
I, [2016-07-29T10:26:27.776789 #34638]  INFO -- : Processing by Mascot::SitemapController#show as HTML
I, [2016-07-29T10:26:27.776856 #34638]  INFO -- :   Parameters: {"path"=>"page-1"}
I, [2016-07-29T10:26:30.087571 #34638]  INFO -- :   Rendered inline template within layouts/application (1171.3ms)
I, [2016-07-29T10:26:30.088551 #34638]  INFO -- : Completed 200 OK in 2312ms (Views: 1172.3ms | ActiveRecord: 0.0ms)
I, [2016-07-29T10:26:30.475672 #34638]  INFO -- : Started GET "/baseline/render" for 127.0.0.1 at 2016-07-29 10:26:30 -0700
I, [2016-07-29T10:26:30.476234 #34638]  INFO -- : Processing by BaselineController#show as HTML
I, [2016-07-29T10:26:30.476617 #34638]  INFO -- :   Rendered baseline/show.html.erb within layouts/application (0.0ms)
I, [2016-07-29T10:26:30.477049 #34638]  INFO -- : Completed 200 OK in 1ms (Views: 0.6ms | ActiveRecord: 0.0ms)
I, [2016-07-29T10:26:30.605143 #34638]  INFO -- : Started GET "/page-1" for 127.0.0.1 at 2016-07-29 10:26:30 -0700
I, [2016-07-29T10:26:30.605631 #34638]  INFO -- : Processing by Mascot::SitemapController#show as HTML
I, [2016-07-29T10:26:30.605663 #34638]  INFO -- :   Parameters: {"path"=>"page-1"}
I, [2016-07-29T10:26:33.622280 #34638]  INFO -- :   Rendered inline template within layouts/application (1130.8ms)
I, [2016-07-29T10:26:33.623449 #34638]  INFO -- : Completed 200 OK in 3018ms (Views: 1132.1ms | ActiveRecord: 0.0ms)
I, [2016-07-29T10:26:33.924750 #34638]  INFO -- : Started GET "/page-9999" for 127.0.0.1 at 2016-07-29 10:26:33 -0700
I, [2016-07-29T10:26:33.925251 #34638]  INFO -- : Processing by Mascot::SitemapController#show as HTML
I, [2016-07-29T10:26:33.925283 #34638]  INFO -- :   Parameters: {"path"=>"page-9999"}
I, [2016-07-29T10:26:36.319683 #34638]  INFO -- :   Rendered inline template within layouts/application (1172.7ms)
I, [2016-07-29T10:26:36.320476 #34638]  INFO -- : Completed 200 OK in 2395ms (Views: 1173.6ms | ActiveRecord: 0.0ms)