Hi folks,

We've just moved to 3.3.1, and I am seeing an odd issue when users try to load 
via spreadsheet. We can select our file, but when we click "import selected" we 
get the generic "something went wrong" 500 page.

I've attached debug logs, but these were logs at warn level

F, [2023-05-09T17:59:29.110284 #23230] FATAL -- :
F, [2023-05-09T17:59:29.110478 #23230] FATAL -- : RuntimeError (Couldn't make 
an ID out of URI: ):
F, [2023-05-09T17:59:29.110534 #23230] FATAL -- :
F, [2023-05-09T17:59:29.110576 #23230] FATAL -- : 
app/controllers/jobs_controller.rb:51:in `create'
app/controllers/application_controller.rb:744:in `set_locale'
E, [2023-05-09T17:59:31.130959 #23230] ERROR -- : Thread-8720: Unhandled 
exception!
E, [2023-05-09T17:59:31.131241 #23230] ERROR -- :
invalid byte sequence in UTF-8

If a user is seeing this, I am easily able to reproduce. With the invalid byte 
sequence message, I assumed it was something in the spreadsheet (attached is 
associated with debug log), BUT the workaround I've found makes me think this 
is something else. The workaround: If I try creating another background job for 
resource in question like generate pdf then I try the load via spreadsheet 
again, the job queues and runs without issue or delay.

Has anyone seen something like this or have any recommendations?

Thanks in advance for any assistance y'all can provide.

Robert

Robert T. Wilson (he/him)
Cloud Systems Administrator
Cornell University Library
rtwil...@cornell.edu
607.254.3483
F, [2023-05-09T17:59:29.110284 #23230] FATAL -- :
F, [2023-05-09T17:59:29.110478 #23230] FATAL -- : RuntimeError (Couldn't make 
an ID out of URI: ):
F, [2023-05-09T17:59:29.110534 #23230] FATAL -- :
F, [2023-05-09T17:59:29.110576 #23230] FATAL -- : 
app/controllers/jobs_controller.rb:51:in `create'
app/controllers/application_controller.rb:744:in `set_locale'
E, [2023-05-09T17:59:31.130959 #23230] ERROR -- : Thread-8720: Unhandled 
exception!
E, [2023-05-09T17:59:31.131241 #23230] ERROR -- :
invalid byte sequence in UTF-8


debug view


I, [2023-05-10T12:21:24.405033 #19786]  INFO -- :   Parameters: {"utf8"=>"✓", 
"authenticity_token"=>"G703YM1Hn_sHkHjj_RDL4ibZNT516QR63jRBxN39JtHbNS-mg4u7vX0uXgiygtkfH8FwN9mX5aaugcvXjykbpQ",
 "job"=>{"job_params"=>{"repo_id"=>"2", 
"ref_id"=>"8371fe00c2668ad7f6b264edaffc0244", "position"=>"3", 
"type"=>"archival_object", "rid"=>"9004", "aoid"=>"972668"}, 
"job_type"=>"bulk_import_job", "jsonmodel_type"=>"bulk_import_job", 
"resource_id"=>"/repositories/2/resources/9004", "format"=>"csv", 
"content_type"=>"xlsx", "filename"=>"bulk_import_template.xlsx", 
"load_type"=>"ao", "only_validate"=>"true"}, 
"files"=>[#<ActionDispatch::Http::UploadedFile:0x267d681c 
@tempfile=#<Tempfile:/cul/app/archivesspace/data/tmp/RackMultipart20230510-19786-1s4sxof.xlsx>,
 @original_filename="bulk_import_template.xlsx", @headers="Content-Disposition: 
form-data; name=\"files[]\"; 
filename=\"bulk_import_template.xlsx\"\r\nContent-Type: 
application/vnd.openxmlformats-officedocument.spreadsheetml.sheet\r\n", 
@content_type="application/vnd.openxmlformats-officedocument.spreadsheetml.sheet">]}
D, [2023-05-10T12:21:24.446396 #19786] DEBUG -- : Thread-3378: POST 
/repositories/2/jobs_with_files [session: #<Session:0x3c2c5220 
@store={:user=>"test", :login_time=>2023-05-10 12:12:34 UTC, :expirable=>true}, 
@system_mtime=2023-05-10 12:21:14 UTC, 
@id="b9d914e17de838676a80b611c1c2bd5c32d96e63d0d146d2255691418c8364e3">]
E, [2023-05-10T12:21:24.451763 #19786] ERROR -- : Thread-3378: Unhandled 
exception!
E, [2023-05-10T12:21:24.451945 #19786] ERROR -- :
invalid byte sequence in UTF-8
org/jruby/ext/strscan/RubyStringScanner.java:261:in `scan'
org/jruby/ext/strscan/RubyStringScanner.java:332:in `scan_until'
uri:classloader:/vendor/rack-2.2.3/rack/multipart/parser.rb:284:in 
`consume_boundary'
uri:classloader:/vendor/rack-2.2.3/rack/multipart/parser.rb:221:in 
`handle_fast_forward'
uri:classloader:/vendor/rack-2.2.3/rack/multipart/parser.rb:207:in `block in 
run_parser'
org/jruby/RubyKernel.java:1442:in `loop'
uri:classloader:/vendor/rack-2.2.3/rack/multipart/parser.rb:204:in `run_parser'
uri:classloader:/vendor/rack-2.2.3/rack/multipart/parser.rb:188:in `on_read'
uri:classloader:/vendor/rack-2.2.3/rack/multipart/parser.rb:73:in `parse'
uri:classloader:/vendor/rack-2.2.3/rack/multipart.rb:54:in `extract_multipart'
uri:classloader:/vendor/rack-2.2.3/rack/request.rb:594:in `parse_multipart'
uri:classloader:/vendor/rack-2.2.3/rack/request.rb:446:in `POST'
uri:classloader:/vendor/rack-2.2.3/rack/request.rb:469:in `params'
uri:classloader:/vendor/rack-2.2.3/rack/request.rb:32:in `params'
/cul/app/archivesspace/gems/gems/sinatra-2.0.5/lib/sinatra/base.rb:79:in 
`params'
/cul/app/archivesspace/gems/gems/sinatra-2.0.5/lib/sinatra/base.rb:1092:in 
`dispatch!'
/cul/app/archivesspace/gems/gems/sinatra-2.0.5/lib/sinatra/base.rb:924:in 
`block in call!'
/cul/app/archivesspace/gems/gems/sinatra-2.0.5/lib/sinatra/base.rb:1076:in 
`block in invoke'
org/jruby/RubyKernel.java:1189:in `catch'
/cul/app/archivesspace/gems/gems/sinatra-2.0.5/lib/sinatra/base.rb:1076:in 
`invoke'
/cul/app/archivesspace/gems/gems/sinatra-2.0.5/lib/sinatra/base.rb:924:in 
`call!'
/cul/app/archivesspace/gems/gems/sinatra-2.0.5/lib/sinatra/base.rb:913:in `call'
cul/app/archivesspace/data/tmp/jetty-0_0_0_0-8089-backend_war-_-any-1621959668380171377/webapp/WEB-INF/app/main.rb:335:in
 `call'
/cul/app/archivesspace/gems/gems/rack-protection-2.0.5/lib/rack/protection/xss_header.rb:18:in
 `call'
/cul/app/archivesspace/gems/gems/rack-protection-2.0.5/lib/rack/protection/path_traversal.rb:16:in
 `call'
/cul/app/archivesspace/gems/gems/rack-protection-2.0.5/lib/rack/protection/json_csrf.rb:26:in
 `call'
/cul/app/archivesspace/gems/gems/rack-protection-2.0.5/lib/rack/protection/base.rb:50:in
 `call'
/cul/app/archivesspace/gems/gems/rack-protection-2.0.5/lib/rack/protection/base.rb:50:in
 `call'
/cul/app/archivesspace/gems/gems/rack-protection-2.0.5/lib/rack/protection/frame_options.rb:31:in
 `call'
uri:classloader:/vendor/rack-2.2.3/rack/null_logger.rb:11:in `call'
uri:classloader:/vendor/rack-2.2.3/rack/head.rb:12:in `call'
/cul/app/archivesspace/gems/gems/sinatra-2.0.5/lib/sinatra/base.rb:194:in `call'
/cul/app/archivesspace/gems/gems/sinatra-2.0.5/lib/sinatra/base.rb:1957:in 
`call'
/cul/app/archivesspace/gems/gems/sinatra-2.0.5/lib/sinatra/base.rb:1502:in 
`block in call'
/cul/app/archivesspace/gems/gems/sinatra-2.0.5/lib/sinatra/base.rb:1729:in 
`synchronize'
/cul/app/archivesspace/gems/gems/sinatra-2.0.5/lib/sinatra/base.rb:1502:in 
`call'
uri:classloader:/vendor/rack-2.2.3/rack/urlmap.rb:74:in `block in call'
org/jruby/RubyArray.java:1821:in `each'
uri:classloader:/vendor/rack-2.2.3/rack/urlmap.rb:58:in `call'
uri:classloader:/rack/handler/servlet.rb:22:in `call'
D, [2023-05-10T12:21:24.452479 #19786] DEBUG -- : Thread-3378: Responded with 
[500, {"Content-Type"=>"application/json", "Content-Length"=>"3335"}, 
["{\"error\":\"invalid byte sequence in UTF-8: 
org/jruby/ext/strscan/RubyStringScanner.java:261:in 
`scan'\\n\\torg/jruby/ext/strscan/RubyStringScanner.java:332:in 
`scan_until'\\n\\turi:classloader:/vendor/rack-2.2.3/rack/multipart/parser.rb:284:in
 
`consume_boundary'\\n\\turi:classloader:/vendor/rack-2.2.3/rack/multipart/parser.rb:221:in
 
`handle_fast_forward'\\n\\turi:classloader:/vendor/rack-2.2.3/rack/multipart/parser.rb:207:in
 `block in ... in 17ms
I, [2023-05-10T12:21:24.455487 #19786]  INFO -- : Completed 500 Internal Server 
Error in 50ms
F, [2023-05-10T12:21:24.458069 #19786] FATAL -- :
F, [2023-05-10T12:21:24.458213 #19786] FATAL -- : RuntimeError (Couldn't make 
an ID out of URI: ):
F, [2023-05-10T12:21:24.458256 #19786] FATAL -- :
F, [2023-05-10T12:21:24.458290 #19786] FATAL -- : 
app/controllers/jobs_controller.rb:51:in `create'

Attachment: 8805 interview cassettes.xlsx
Description: 8805 interview cassettes.xlsx

_______________________________________________
Archivesspace_Users_Group mailing list
Archivesspace_Users_Group@lyralists.lyrasis.org
http://lyralists.lyrasis.org/mailman/listinfo/archivesspace_users_group

Reply via email to