gistfile1.txt

search-frontend:
2016-12-02 11:40:33 [INFO] ---------------------in look_up_clio_holdings in application_controller.rb---------------------
2016-12-02 11:40:33 [ERROR] ApplicationController#look_up_clio_holdings exception: ORA-00019: maximum number of session licenses exceeded

search-backend:
2016-12-02 11:40:39 [INFO] Started GET "/holdings/status/12042719/6541725/10182963/3616983/407352/2902298/754167/5707018/1287789/8102959/12433083/1210472/7792873/3143270/12814538/728657/1342111/7138412/5624023/1214142/3567137/6750014/4135277/4922483/4922472" for 10.0.2.2 at 2016-12-02 11:40:39 -0500
/home/vagrant/.rvm/gems/ruby-2.3.1@search-backend/gems/activerecord-4.0.0/lib/active_record/associations/has_many_association.rb:75: warning: circular argument reference - reflection
/home/vagrant/.rvm/gems/ruby-2.3.1@search-backend/gems/activerecord-4.0.0/lib/active_record/associations/has_many_association.rb:79: warning: circular argument reference - reflection
/home/vagrant/.rvm/gems/ruby-2.3.1@search-backend/gems/activerecord-4.0.0/lib/active_record/associations/has_many_association.rb:83: warning: circular argument reference - reflection
/home/vagrant/.rvm/gems/ruby-2.3.1@search-backend/gems/activerecord-4.0.0/lib/active_record/associations/has_many_association.rb:102: warning: circular argument reference - reflection
2016-12-02 11:40:39 [INFO] Processing by HoldingsController#status as HTML
2016-12-02 11:40:39 [INFO]   Parameters: {"id"=>"12042719/6541725/10182963/3616983/407352/2902298/754167/5707018/1287789/8102959/12433083/1210472/7792873/3143270/12814538/728657/1342111/7138412/5624023/1214142/3567137/6750014/4135277/4922483/4922472"}
2016-12-02 11:40:39 [INFO] ******** @bibidarray = ["12042719", "6541725", "10182963", "3616983", "407352", "2902298", "754167", "5707018", "1287789", "8102959", "12433083", "1210472", "7792873", "3143270", "12814538", "728657", "1342111", "7138412", "5624023", "1214142", "3567137", "6750014", "4135277", "4922483", "4922472"] with a class of: Array*************
2016-12-02 11:40:39 [INFO] Inside bibidarray method creating the @bibids. Id is: 12042719
2016-12-02 11:40:39 [INFO] Inside bibidarray method creating the @bibids. Id is: 6541725
2016-12-02 11:40:39 [INFO] Inside bibidarray method creating the @bibids. Id is: 10182963
2016-12-02 11:40:39 [INFO] Inside bibidarray method creating the @bibids. Id is: 3616983
2016-12-02 11:40:39 [INFO] Inside bibidarray method creating the @bibids. Id is: 407352
2016-12-02 11:40:39 [INFO] Inside bibidarray method creating the @bibids. Id is: 2902298
2016-12-02 11:40:39 [INFO] Inside bibidarray method creating the @bibids. Id is: 754167
2016-12-02 11:40:39 [INFO] Inside bibidarray method creating the @bibids. Id is: 5707018
2016-12-02 11:40:39 [INFO] Inside bibidarray method creating the @bibids. Id is: 1287789
2016-12-02 11:40:39 [INFO] Inside bibidarray method creating the @bibids. Id is: 8102959
2016-12-02 11:40:39 [INFO] Inside bibidarray method creating the @bibids. Id is: 12433083
2016-12-02 11:40:39 [INFO] Inside bibidarray method creating the @bibids. Id is: 1210472
2016-12-02 11:40:39 [INFO] Inside bibidarray method creating the @bibids. Id is: 7792873
2016-12-02 11:40:39 [INFO] Inside bibidarray method creating the @bibids. Id is: 3143270
2016-12-02 11:40:39 [INFO] Inside bibidarray method creating the @bibids. Id is: 12814538
2016-12-02 11:40:39 [INFO] Inside bibidarray method creating the @bibids. Id is: 728657
2016-12-02 11:40:39 [INFO] Inside bibidarray method creating the @bibids. Id is: 1342111
2016-12-02 11:40:39 [INFO] Inside bibidarray method creating the @bibids. Id is: 7138412
2016-12-02 11:40:39 [INFO] Inside bibidarray method creating the @bibids. Id is: 5624023
2016-12-02 11:40:39 [INFO] Inside bibidarray method creating the @bibids. Id is: 1214142
2016-12-02 11:40:39 [INFO] Inside bibidarray method creating the @bibids. Id is: 3567137
2016-12-02 11:40:39 [INFO] Inside bibidarray method creating the @bibids. Id is: 6750014
2016-12-02 11:40:39 [INFO] Inside bibidarray method creating the @bibids. Id is: 4135277
2016-12-02 11:40:39 [INFO] Inside bibidarray method creating the @bibids. Id is: 4922483
2016-12-02 11:40:39 [INFO] Inside bibidarray method creating the @bibids. Id is: 4922472
2016-12-02 11:40:39 [INFO] ******** in get_oracle_connection() method *************
2016-12-02 11:40:39 [INFO] @@oracle_connection is nil
2016-12-02 11:40:39 [INFO] Creating new Voyager::OracleConnection...
2016-12-02 11:40:39 [INFO] ---------------------connection_details are: {"user"=>"splabel", "password"=>"splabel", "service"=>"(DESCRIPTION=(ADDRESS=(PROTOCOL = TCP)(HOST = clark.library.yale.edu)(PORT = 1521))(CONNECT_DATA =(SERVER = DEDICATED)(SERVICE_NAME=VGER.clark.library.yale.edu)))"}---------------------
2016-12-02 11:40:40 [ERROR] Error calling Voyager::OracleConnection.new(): ORA-00019: maximum number of session licenses exceeded
2016-12-02 11:40:40 [ERROR] Error from search-backend/app/controllers/holdings_controller.rb->status-> for bibids: ["12042719", "6541725", "10182963", "3616983", "407352", "2902298", "754167", "5707018", "1287789", "8102959", "12433083", "1210472", "7792873", "3143270", "12814538", "728657", "1342111", "7138412", "5624023", "1214142", "3567137", "6750014", "4135277", "4922483", "4922472"]: undefined method `retrieve_holdings' for true:TrueClass
2016-12-02 11:40:40 [INFO] Completed 500 Internal Server Error in 373ms (Views: 0.2ms | ActiveRecord: 0.0ms)

search-frontend - 2:
2016-12-02 11:52:45 [INFO] ---------------------in look_up_clio_holdings in application_controller.rb---------------------
2016-12-02 11:52:50 [INFO] ************simple_holdings_check calling from search-frontend/app/controllers/application_controller.rb: Holdings are: {"12042719"=>{:statuses=>{"12227716"=>"none"}}, "7792873"=>{:statuses=>{"835546"=>"none"}}, "728657"=>{:statuses=>{"835538"=>"some_available", "835541"=>"some_available", "835542"=>"available", "835544"=>"some_available", "7494400"=>"available"}}, "12842944"=>{:statuses=>{}}, "2812000"=>{:statuses=>{"3096512"=>"available"}}, "475141"=>{:statuses=>{"545224"=>"available"}}, "2778728"=>{:statuses=>{"3062180"=>"none"}}, "12042726"=>{:statuses=>{"12227723"=>"none"}}, "12106881"=>{:statuses=>{"12291532"=>"none"}}, "12476459"=>{:statuses=>{"12619739"=>"none"}}, "12731087"=>{:statuses=>{"12836642"=>"none"}}, "12042739"=>{:statuses=>{"12227736"=>"none"}}, "12042742"=>{:statuses=>{"12227739"=>"none"}}, "12042738"=>{:statuses=>{"12227735"=>"none"}}, "12202361"=>{:statuses=>{"12378108"=>"none"}}, "12400674"=>{:statuses=>{"12555475"=>"none"}}, "2985223"=>{:statuses=>{"3276167"=>"available"}}, "12788993"=>{:statuses=>{"12891112"=>"none"}}, "4623551"=>{:statuses=>{"5015011"=>"available"}}, "3818404"=>{:statuses=>{"4175247"=>"available"}}, "3349096"=>{:statuses=>{"3672978"=>"some_available"}}, "12042731"=>{:statuses=>{"12227728"=>"none"}}, "475225"=>{:statuses=>{"545327"=>"available"}}, "2808044"=>{:statuses=>{"3092292"=>"none"}}, "12842945"=>{:statuses=>{}}} ********

search-frontend -3:
2016-12-02 12:04:46 [INFO] ---------------------in look_up_clio_holdings in application_controller.rb---------------------
2016-12-02 12:04:47 [ERROR] ApplicationController#look_up_clio_holdings exception: ORA-12520: TNS:listener could not find available handler for requested type of server

search-backend:
http://192.168.33.10:3001/holdings/retrieve/728657
2016-12-02 14:36:51 [INFO] Started GET "/holdings/retrieve/728657" for 192.168.33.1 at 2016-12-02 14:36:51 -0500
2016-12-02 14:36:51 [INFO] Processing by HoldingsController#retrieve as HTML
2016-12-02 14:36:51 [INFO]   Parameters: {"id"=>"728657"}
2016-12-02 14:36:51 [DEBUG]   Holding Load (1.8ms)  SELECT "holdings".* FROM "holdings" WHERE "holdings"."bibid" = 728657 AND (created_at >= '2016-12-02 19:26:51') LIMIT 1
2016-12-02 14:36:51 [INFO] if no cache
2016-12-02 14:36:53 [INFO] ----------------IN RESCUE CLAUSE OF THE VOYAGER CONNECTION----------------
2016-12-02 14:36:53 [ERROR] Error retrieving holdings for bibid 728657: unexpected response: #<HTTP::Message::Headers:0x000000038e2800 @http_version="1.1", @body_size=0, @chunked=false, @request_method="GET", @request_uri=#<URI::HTTP http://clark.library.yale.edu:7014/vxws/GetHoldingsService>, @request_query={:bibId=>728657}, @request_absolute_uri=nil, @status_code=500, @reason_phrase="Internal Server Error", @body_type=nil, @body_charset=nil, @body_date=nil, @body_encoding=#<Encoding:UTF-8>, @is_request=false, @header_item=[["Date", "Fri, 02 Dec 2016 19:36:52 GMT"], ["Server", "Apache"], ["Content-Length", "2803"], ["Vary", "Accept-Encoding,User-Agent"], ["Connection", "close"], ["Content-Type", "text/html;charset=utf-8"]], @dumped=false>
2016-12-02 14:36:53 [DEBUG]   SQL (5.8ms)  DELETE FROM "holdings" WHERE (created_at < '2016-12-02 19:26:51')
2016-12-02 14:36:53 [INFO] Completed 500 Internal Server Error in 1321ms (Views: 0.1ms | ActiveRecord: 14.1ms)

configured to search.library.yale.edu/search-backend:
2016-12-02 15:02:18 [INFO] ******** in get_oracle_connection() method *************
2016-12-02 15:02:19 [INFO] ///simple_holdings_check calling from search-backend/app/controllers/holdings_controller.rb->status: Holdings are: {"12042719"=>{:statuses=>{"12227716"=>"none"}}, "7792873"=>{:statuses=>{"835546"=>"none"}}, "728657"=>{:statuses=>{"835538"=>"some_available", "835541"=>"some_available", "835542"=>"available", "835544"=>"some_available", "7494400"=>"available"}}, "12842944"=>{:statuses=>{}}, "2812000"=>{:statuses=>{"3096512"=>"available"}}, "475141"=>{:statuses=>{"545224"=>"available"}}, "2778728"=>{:statuses=>{"3062180"=>"none"}}, "12042726"=>{:statuses=>{"12227723"=>"none"}}, "12106881"=>{:statuses=>{"12291532"=>"none"}}, "12476459"=>{:statuses=>{"12619739"=>"none"}}, "12731087"=>{:statuses=>{"12836642"=>"none"}}, "12042739"=>{:statuses=>{"12227736"=>"none"}}, "12042742"=>{:statuses=>{"12227739"=>"none"}}, "12042738"=>{:statuses=>{"12227735"=>"none"}}, "12202361"=>{:statuses=>{"12378108"=>"none"}}, "12400674"=>{:statuses=>{"12555475"=>"none"}}, "2985223"=>{:statuses=>{"3276167"=>"available"}}, "12788993"=>{:statuses=>{"12891112"=>"none"}}, "4623551"=>{:statuses=>{"5015011"=>"available"}}, "3818404"=>{:statuses=>{"4175247"=>"available"}}, "3349096"=>{:statuses=>{"3672978"=>"some_available"}}, "12042731"=>{:statuses=>{"12227728"=>"none"}}, "475225"=>{:statuses=>{"545327"=>"available"}}, "2808044"=>{:statuses=>{"3092292"=>"none"}}, "12842945"=>{:statuses=>{}}} //////////////////
2016-12-02 15:02:19 [INFO] Completed 200 OK in 140ms (Views: 3.7ms | ActiveRecord: 0.0ms)

search-frontend search of baseball and law (vm):
2016-12-05 13:22:29 [INFO] Started GET "/catalog?q=baseball+law&search_field=all_fields&commit=Search" for 127.0.0.1 at 2016-12-05 13:22:29 -0500
2016-12-05 13:22:29 [INFO] Processing by CatalogController#index as HTML
2016-12-05 13:22:29 [INFO]   Parameters: {"q"=>"baseball law", "search_field"=>"all_fields", "commit"=>"Search"}
2016-12-05 13:22:29 [DEBUG]   Search Load (1.3ms)  SELECT "searches".* FROM "searches" WHERE "searches"."id" IN (40, 39, 38, 37, 34, 33, 32, 31, 30, 29, 28, 27, 26, 25, 24, 23)  ORDER BY updated_at desc
2016-12-05 13:22:29 [DEBUG]   User Load (1.0ms)  SELECT  "users".* FROM "users" WHERE "users"."id" = ? LIMIT 1  [["id", 4]]
2016-12-05 13:22:29 [DEBUG] ApplicationController#blacklight_search(sent_options={"q"=>"baseball law", "search_field"=>"all_fields", "commit"=>"Search", "controller"=>"catalog", "action"=>"index", "adv"=>{}})
2016-12-05 13:22:29 [DEBUG] Spectrum::Search::Engine#initialize(original_options={"q"=>"baseball law", "search_field"=>"all_fields", "commit"=>"Search", "controller"=>"catalog", "action"=>"index", "adv"=>{}, "source"=>"catalog", "debug_mode"=>false, "current_user"=>#<User id: 4, first_name: nil, last_name: nil, login: nil, created_at: "2016-09-07 20:03:44", updated_at: "2016-10-20 16:04:24", email: "[email protected]">})
2016-12-05 13:22:29 [DEBUG] Spectrum::SearchEngine::Solr#connection()
2016-12-05 13:22:29 [DEBUG] generate_rsolr(catalog) - new RSolr.connect()
2016-12-05 13:22:29 [INFO] [Spectrum][Solr] source: catalog params: {:q=>"baseball law", :search_field=>"all_fields", :commit=>"Search", :controller=>"catalog", :action=>"index", :adv=>{}}
2016-12-05 13:22:29 [DEBUG] Spectrum::Search::Engine#perform_search() with @params={:q=>"baseball law", :search_field=>"all_fields", :commit=>"Search", :controller=>"catalog", :action=>"index", :adv=>{}}
2016-12-05 13:22:29 [DEBUG] Spectrum::SearchEngine::Solr#repository()
2016-12-05 13:22:29 [DEBUG] Spectrum::SolrRepository#connection()
2016-12-05 13:22:29 [DEBUG] @connection=nil
2016-12-05 13:22:29 [DEBUG] Spectrum::SolrRepository#generate_rsolr(catalog)
2016-12-05 13:22:31 [DEBUG] Solr query: get select {"qt"=>"search", "facet.field"=>["format", "pub_date_sort", "author_facet", "location_facet", "language_facet", "subject_topic_facet", "subject_geo_facet", "subject_era_facet", "subject_form_facet", "subject_local_facet", "lc_1letter_facet", "lc_subclass_facet"], "facet.query"=>["acq_dt:[2016-11-28T00:00:00Z TO *]", "acq_dt:[2016-11-05T00:00:00Z TO *]", "acq_dt:[2016-06-05T00:00:00Z TO *]", "acq_dt:[2015-12-05T00:00:00Z TO *]"], "facet.pivot"=>[], "fq"=>[], "hl.fl"=>[], "q"=>"baseball law", "facet"=>true, "f.format.facet.limit"=>6, "f.pub_date_sort.facet.limit"=>4, "f.author_facet.facet.limit"=>6, "f.location_facet.facet.limit"=>6, "f.language_facet.facet.limit"=>6, "f.subject_topic_facet.facet.limit"=>11, "f.subject_geo_facet.facet.limit"=>11, "f.subject_era_facet.facet.limit"=>11, "f.subject_form_facet.facet.limit"=>11, "f.subject_local_facet.facet.limit"=>11, "f.lc_1letter_facet.facet.limit"=>31, "f.lc_subclass_facet.facet.limit"=>501, "rows"=>25, "sort"=>"score desc, pub_date_sort desc, title_sort asc", "stats"=>"true", "stats.field"=>["pub_date_sort"]}
2016-12-05 13:22:31 [DEBUG] Solr fetch (2049.0ms)
2016-12-05 13:22:31 [DEBUG] Spectrum::Search::Engine#perform_search() with @params={:q=>"baseball law", :search_field=>"all_fields", :commit=>"Search", :controller=>"catalog", :action=>"index", :adv=>{}}
2016-12-05 13:22:31 [DEBUG] Spectrum::SearchEngine::Solr#repository()
2016-12-05 13:22:31 [DEBUG] Spectrum::SolrRepository#connection()
2016-12-05 13:22:31 [DEBUG] @connection=#<RSolr::Client:0x00000004d183b0 @uri=#<URI::HTTP http://hydratest.library.yale.edu:8083/solr/clio-hydra/>, @proxy=nil, @connection=#<RSolr::Connection:0x00000004d183d8 @http=#<Net::HTTP hydratest.library.yale.edu:8083 open=false>>, @options={:url=>"http://hydratest.library.yale.edu:8083/solr/clio-hydra"}>
2016-12-05 13:22:33 [DEBUG] Solr query: get select {"qt"=>"search", "facet.field"=>["format", "pub_date_sort", "author_facet", "location_facet", "language_facet", "subject_topic_facet", "subject_geo_facet", "subject_era_facet", "subject_form_facet", "subject_local_facet", "lc_1letter_facet", "lc_subclass_facet"], "facet.query"=>["acq_dt:[2016-11-28T00:00:00Z TO *]", "acq_dt:[2016-11-05T00:00:00Z TO *]", "acq_dt:[2016-06-05T00:00:00Z TO *]", "acq_dt:[2015-12-05T00:00:00Z TO *]"], "facet.pivot"=>[], "fq"=>[], "hl.fl"=>[], "q"=>"baseball law", "facet"=>true, "f.format.facet.limit"=>6, "f.pub_date_sort.facet.limit"=>4, "f.author_facet.facet.limit"=>6, "f.location_facet.facet.limit"=>6, "f.language_facet.facet.limit"=>6, "f.subject_topic_facet.facet.limit"=>11, "f.subject_geo_facet.facet.limit"=>11, "f.subject_era_facet.facet.limit"=>11, "f.subject_form_facet.facet.limit"=>11, "f.subject_local_facet.facet.limit"=>11, "f.lc_1letter_facet.facet.limit"=>31, "f.lc_subclass_facet.facet.limit"=>501, "rows"=>25, "sort"=>"score desc, pub_date_sort desc, title_sort asc", "stats"=>"true", "stats.field"=>["pub_date_sort"]}
2016-12-05 13:22:33 [DEBUG] Solr fetch (1756.6ms)
2016-12-05 13:22:33 [INFO] ---------------------in look_up_clio_holdings in application_controller.rb---------------------
2016-12-05 13:22:33 [INFO] search-frontend->application_controller.rb->bib_available_url: http://search-test.library.yale.edu/quicksearch-morris/bib?q=820871
2016-12-05 13:22:33 [INFO] search-frontend->application_controller.rb->bib_available_url: http://search-test.library.yale.edu/quicksearch-morris/bib?q=1466207
2016-12-05 13:22:33 [INFO] search-frontend->application_controller.rb->bib_available_url: http://search-test.library.yale.edu/quicksearch-morris/bib?q=501938
2016-12-05 13:22:33 [INFO] search-frontend->application_controller.rb->bib_available_url: http://search-test.library.yale.edu/quicksearch-morris/bib?q=1270858
2016-12-05 13:22:33 [INFO] search-frontend->application_controller.rb->bib_available_url: http://search-test.library.yale.edu/quicksearch-morris/bib?q=210749
2016-12-05 13:22:33 [INFO] search-frontend->application_controller.rb->bib_available_url: http://search-test.library.yale.edu/quicksearch-morris/bib?q=1348978
2016-12-05 13:22:33 [INFO] search-frontend->application_controller.rb->bib_available_url: http://search-test.library.yale.edu/quicksearch-morris/bib?q=1076348
2016-12-05 13:22:33 [INFO] search-frontend->application_controller.rb->bib_available_url: http://search-test.library.yale.edu/quicksearch-morris/bib?q=590408
2016-12-05 13:22:33 [INFO] Checkpoint
2016-12-05 13:22:34 [INFO] ************simple_holdings_check calling from search-frontend/app/controllers/application_controller.rb: Holdings are: {0=>{:statuses=>{}}, "4819986"=>{:statuses=>{"5216578"=>"available"}}, "9857844"=>{:statuses=>{"10158073"=>"available"}}, "11539088"=>{:statuses=>{"11674891"=>"none"}}, "5128705"=>{:statuses=>{"5528502"=>"available"}}, "11539977"=>{:statuses=>{"11675776"=>"none"}}, "5125105"=>{:statuses=>{"5524897"=>"available"}}, "12552575"=>{:statuses=>{"12678530"=>"none"}}, "12253441"=>{:statuses=>{"12424230"=>"none"}}, "12427115"=>{:statuses=>{"12577474"=>"none"}}, "11545330"=>{:statuses=>{"11681076"=>"none"}}, "5170964"=>{:statuses=>{"5570782"=>"available"}}, "11543080"=>{:statuses=>{"11678842"=>"none"}}, "5157008"=>{:statuses=>{"5556815"=>"available"}}, "11444810"=>{:statuses=>{"11586041"=>"none"}}, "563033"=>{:statuses=>{"643367"=>"unavailable"}}, "12416223"=>{:statuses=>{"12567747"=>"available"}}, "11569459"=>{:statuses=>{"11705136"=>"none"}}} ********
2016-12-05 13:22:34 [INFO] -----------holdings[cd.fetch('clio_id_display')[0] renders: -----------
2016-12-05 13:22:34 [INFO] -----------holdings[cd.fetch('clio_id_display')[0] renders: -----------
2016-12-05 13:22:34 [INFO] -----------holdings[cd.fetch('clio_id_display')[0] renders: -----------
2016-12-05 13:22:34 [INFO] -----------holdings[cd.fetch('clio_id_display')[0] renders: {:statuses=>{"5216578"=>"available"}}-----------
2016-12-05 13:22:34 [INFO] -----------holdings[cd.fetch('clio_id_display')[0] renders: {:statuses=>{"10158073"=>"available"}}-----------
2016-12-05 13:22:34 [INFO] -----------holdings[cd.fetch('clio_id_display')[0] renders: {:statuses=>{"11674891"=>"none"}}-----------
2016-12-05 13:22:34 [INFO] -----------holdings[cd.fetch('clio_id_display')[0] renders: {:statuses=>{"5528502"=>"available"}}-----------
2016-12-05 13:22:34 [INFO] -----------holdings[cd.fetch('clio_id_display')[0] renders: -----------
2016-12-05 13:22:34 [INFO] -----------holdings[cd.fetch('clio_id_display')[0] renders: {:statuses=>{"11675776"=>"none"}}-----------
2016-12-05 13:22:34 [INFO] -----------holdings[cd.fetch('clio_id_display')[0] renders: -----------
2016-12-05 13:22:34 [INFO] -----------holdings[cd.fetch('clio_id_display')[0] renders: {:statuses=>{"5524897"=>"available"}}-----------
2016-12-05 13:22:34 [INFO] -----------holdings[cd.fetch('clio_id_display')[0] renders: {:statuses=>{"12678530"=>"none"}}-----------
2016-12-05 13:22:34 [INFO] -----------holdings[cd.fetch('clio_id_display')[0] renders: -----------
2016-12-05 13:22:34 [INFO] -----------holdings[cd.fetch('clio_id_display')[0] renders: {:statuses=>{"12424230"=>"none"}}-----------
2016-12-05 13:22:34 [INFO] -----------holdings[cd.fetch('clio_id_display')[0] renders: {:statuses=>{"12577474"=>"none"}}-----------
2016-12-05 13:22:34 [INFO] -----------holdings[cd.fetch('clio_id_display')[0] renders: -----------
2016-12-05 13:22:34 [INFO] -----------holdings[cd.fetch('clio_id_display')[0] renders: {:statuses=>{"11681076"=>"none"}}-----------
2016-12-05 13:22:34 [INFO] -----------holdings[cd.fetch('clio_id_display')[0] renders: {:statuses=>{"5570782"=>"available"}}-----------
2016-12-05 13:22:34 [INFO] -----------holdings[cd.fetch('clio_id_display')[0] renders: -----------
2016-12-05 13:22:34 [INFO] -----------holdings[cd.fetch('clio_id_display')[0] renders: {:statuses=>{"11678842"=>"none"}}-----------
2016-12-05 13:22:34 [INFO] -----------holdings[cd.fetch('clio_id_display')[0] renders: {:statuses=>{"5556815"=>"available"}}-----------
2016-12-05 13:22:34 [INFO] -----------holdings[cd.fetch('clio_id_display')[0] renders: {:statuses=>{"11586041"=>"none"}}-----------
2016-12-05 13:22:34 [INFO] -----------holdings[cd.fetch('clio_id_display')[0] renders: {:statuses=>{"643367"=>"unavailable"}}-----------
2016-12-05 13:22:34 [INFO] -----------holdings[cd.fetch('clio_id_display')[0] renders: {:statuses=>{"12567747"=>"available"}}-----------
2016-12-05 13:22:34 [INFO] -----------holdings[cd.fetch('clio_id_display')[0] renders: {:statuses=>{"11705136"=>"none"}}-----------