<div dir="ltr"><div>Hi all,</div><div><br></div><div>I have a little over 600 accession records to import using the CSV template.  On my first attempt I received a non-specific error appearing on the Import Job:Job Status screen within the application so I began splitting these into batches of 100 records each.  My first two batches imported fine, exactly as expected but when I tried the third batch I again received a non-specific error.  </div><div><br></div><div>I opened the archivesspace.out log to see if that might yield any clues but couldn't make heads or tails of it, as far as identify what is failing in the process.  </div><div><br></div><div>I'm a couple versions back, using Version v1.1.2 running against the demo database (my current test environment).</div><div><br></div><div>Here's a snippet of code from the .out log from one attempt:</div><div><br>D, [2015-06-10T15:20:47.877000 #5076] DEBUG -- : Thread-14292: Import running for job 75<br>E, [2015-06-10T15:20:47.924000 #5076] ERROR -- : Thread-14296: Job 75 failed: Permission denied - C:\UserFiles\archivesspace\data\tmp\import_batch_working_file_143397124790920150610-5076-lv1tbj ["org/jruby/RubyFile.java:1106:in `unlink'", "C:/UserFiles/archivesspace/data/tmp/jetty-0.0.0.0-8089-backend.war-_-any-/webapp/WEB-INF/app/converters/converter.rb:22:in `remove_files'", "C:/UserFiles/archivesspace/data/tmp/jetty-0.0.0.0-8089-backend.war-_-any-/webapp/WEB-INF/app/converters/lib/parse_queue.rb:85:in `each_open_file_path'", "C:/UserFiles/archivesspace/data/tmp/jetty-0.0.0.0-8089-backend.war-_-any-/webapp/WEB-INF/app/converters/converter.rb:21:in `remove_files'", "C:/UserFiles/archivesspace/data/tmp/jetty-0.0.0.0-8089-backend.war-_-any-/webapp/WEB-INF/app/lib/batch_import_runner.rb:80:in `run'", "org/jruby/RubyArray.java:1613:in `each'", "org/jruby/RubyEnumerable.java:977:in `each_with_index'", "C:/UserFiles/archivesspace/data/tmp/jetty-0.0.0.0-8089-backend.war-_-any-/webapp/WEB-INF/app/lib/batch_import_runner.rb:63:in `run'", "C:/UserFiles/archivesspace/data/tmp/jetty-0.0.0.0-8089-backend.war-_-any-/webapp/WEB-INF/app/model/db.rb:125:in `open'", "org/jruby/RubyFixnum.java:280:in `times'", "C:/UserFiles/archivesspace/data/tmp/jetty-0.0.0.0-8089-backend.war-_-any-/webapp/WEB-INF/app/model/db.rb:113:in `open'", "C:/UserFiles/archivesspace/data/tmp/jetty-0.0.0.0-8089-backend.war-_-any-/webapp/WEB-INF/app/lib/batch_import_runner.rb:59:in `run'", "C:/UserFiles/archivesspace/data/tmp/jetty-0.0.0.0-8089-backend.war-_-any-/webapp/WEB-INF/app/lib/batch_import_job_queue.rb:96:in `run_pending_import'", "C:/UserFiles/archivesspace/data/tmp/jetty-0.0.0.0-8089-backend.war-_-any-/webapp/WEB-INF/app/lib/batch_import_job_queue.rb:123:in `start_background_thread'"]<br>Started GET "/jobs/75/status" for 0:0:0:0:0:0:0:1 at 2015-06-10 15:20:47 -0600<br>Processing by JobsController#status as JSON<br>  Parameters: {"id"=>"75"}<br>D, [2015-06-10T15:20:48.018000 #5076] DEBUG -- : Thread-13264: GET /repositories/4/jobs/75 [session: #<Session:0x91cfe @store={:user=>"admin", :login_time=>2015-06-10 15:17:42 -0600, :expirable=>true}, @id="35a81ae84f5476b18dca98bab372f309ef68464c588359398c4f25e917d14cdf">]<br>D, [2015-06-10T15:20:48.018000 #5076] DEBUG -- : Thread-13264: Post-processed params: {:id=>75, :repo_id=>4}<br>D, [2015-06-10T15:20:48.081000 #5076] DEBUG -- : Thread-13264: Responded with [200, {"Content-Type"=>"application/json", "Cache-Control"=>"private, must-revalidate, max-age=0", "Content-Length"=>"469"}, ["{\"import_type\":\"accession_csv\",\"lock_version\":2,\"filenames\":[\"realdatatest_301ThruLine400.csv\"],\"time_submitted\":\"2015-06-10 21:20:46 UTC\",\"time_started\":\"2015-06-10 21:20:47 UTC\",\"status\":\"running\",\"created_by\":\"admin\",\"last_modified_by\":\"admin\",\"create_time\":\"2015-06-10T21:20:46Z\",\"system_mtime\":\"2015-06-10T21:20:47Z\",\"user_mtime\":\"2015-06-1... in 94.0ms<br>Completed 200 OK in 125.0ms (Views: 0.0ms)<br>Started GET "/jobs/75" for 0:0:0:0:0:0:0:1 at 2015-06-10 15:20:48 -0600<br>Processing by JobsController#show as HTML<br>  Parameters: {"id"=>"75"}<br>D, [2015-06-10T15:20:48.221000 #5076] DEBUG -- : Thread-6996: GET /repositories/4/jobs/75?resolve%5B%5D=repository [session: #<Session:0x1cfa0ee @store={:user=>"admin", :login_time=>2015-06-10 15:17:42 -0600, :expirable=>true}, @id="35a81ae84f5476b18dca98bab372f309ef68464c588359398c4f25e917d14cdf">]<br>D, [2015-06-10T15:20:48.221000 #5076] DEBUG -- : Thread-6996: Post-processed params: {:id=>75, :resolve=>["repository"], :repo_id=>4}<br>D, [2015-06-10T15:20:48.284000 #5076] DEBUG -- : Thread-6996: Responded with [200, {"Content-Type"=>"application/json", "Cache-Control"=>"private, must-revalidate, max-age=0", "Content-Length"=>"826"}, ["{\"import_type\":\"accession_csv\",\"lock_version\":2,\"filenames\":[\"realdatatest_301ThruLine400.csv\"],\"time_submitted\":\"2015-06-10 21:20:46 UTC\",\"time_started\":\"2015-06-10 21:20:47 UTC\",\"status\":\"running\",\"created_by\":\"admin\",\"last_modified_by\":\"admin\",\"create_time\":\"2015-06-10T21:20:46Z\",\"system_mtime\":\"2015-06-10T21:20:47Z\",\"user_mtime\":\"2015-06-1... in 78.0ms<br>  Rendered shared/_breadcrumb.html.erb (16.0ms)<br>  Rendered jobs/_show_templates.html.erb (0.0ms)<br>  Rendered shared/_sidebar_entry.html.erb (0.0ms)<br>  Rendered shared/_sidebar_entry.html.erb (0.0ms)<br>  Rendered shared/_sidebar_entry.html.erb (0.0ms)<br>  Rendered shared/_sidebar.html.erb (0.0ms)<br>  Rendered jobs/_sidebar.html.erb (0.0ms)<br>  Rendered jobs/_toolbar.html.erb (0.0ms)<br>  Rendered shared/_flash_messages.html.erb (0.0ms)<br>  Rendered shared/_flash_messages.html.erb (0.0ms)<br>  Rendered jobs/show.html.erb within layouts/application (110.0ms)<br>  Rendered shared/_browser_support.html.erb (16.0ms)<br>  Rendered shared/_header_user.html.erb (31.0ms)<br>  Rendered shared/_header_global.html.erb (31.0ms)<br>  Rendered site/_branding.html.erb (0.0ms)<br>  Rendered shared/_advanced_search.html.erb (16.0ms)<br>  Rendered shared/_header_repository.html.erb (94.0ms)<br>  Rendered C:/UserFiles/archivesspace/plugins/aspace_feedback/frontend/views/site/_feedback_form.html.erb (0.0ms)<br>  Rendered C:/UserFiles/archivesspace/plugins/aspace_feedback/frontend/views/site/_footer.html.erb (16.0ms)<br>  Rendered shared/_templates.html.erb (15.0ms)<br>Completed 200 OK in 406.0ms (Views: 312.0ms)<br>Started GET "/jobs/75/log?offset=0" for 0:0:0:0:0:0:0:1 at 2015-06-10 15:20:48 -0600<br>Processing by JobsController#log as */*<br>  Parameters: {"offset"=>"0", "id"=>"75"}<br>Completed 200 OK in 16.0ms<br>D, [2015-06-10T15:20:48.987000 #5076] DEBUG -- : Thread-13264: GET /repositories/4/jobs/75/log?offset=0 [session: #<Session:0xa7438f @store={:user=>"admin", :login_time=>2015-06-10 15:17:42 -0600, :expirable=>true}, @id="35a81ae84f5476b18dca98bab372f309ef68464c588359398c4f25e917d14cdf">]<br>D, [2015-06-10T15:20:48.987000 #5076] DEBUG -- : Thread-13264: Post-processed params: {:id=>75, :repo_id=>4, :offset=>0}<br>D, [2015-06-10T15:20:49.049000 #5076] DEBUG -- : Thread-13264: Responded with [200, {"Content-Type"=>"text/plain", "Cache-Control"=>"private, must-revalidate, max-age=0", "Content-Length"=>"499"}, #<Enumerator: #<JRuby::Generator::Threaded:0x1790ec7 @block=#<Proc:0x410aaa@C:/UserFiles/archivesspace/data/tmp/jetty-0.0.0.0-8089-backend.war-_-any-/webapp/WEB-INF/app/controllers/job.rb:116>, @next_element=nil, @index=0, @queue_finalizer=#<JRuby::Generator::Threaded::QueueFinalizer:0xc80a7c @queue=#<JRuby::Generator::Threaded::ProducerQueue:0x4debc2>>, @queue=#<JRuby::Generator::Threaded::... in 93.0ms<br></div><div><br></div><div><br clear="all"></div><div><div class="gmail_signature"><div dir="ltr"><div>******<div>Nicole Blechynden</div><div dir="ltr"><div>Archivist</div><div>Heart Mountain Wyoming Foundation</div><div>1539 Road 19</div><div>Powell, WY 82435</div><div>307-754-8000 x103</div></div></div></div></div></div>
</div>