Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Grading and regrading failing - copy to VM failing and timeouts #169

Closed
robsimmons opened this issue Jan 23, 2015 · 18 comments
Closed

Grading and regrading failing - copy to VM failing and timeouts #169

robsimmons opened this issue Jan 23, 2015 · 18 comments

Comments

@robsimmons
Copy link

Why is copy to VM failing with nondeterministic "unexpected token at...."? The error message makes me think it's maybe related to @132? I don't think that looks like anything I could have put in my scripts, though I could be wrong.

Anyway, my lead TA tried a bulk regrade, but apparently that is failing too.

I need to release a number-of-submissions-limited assignment in the next couple of days, so in addition to @121 I'm pretty nervous about the prevalence of these kinds of errors.

==== New TA, 11:30pm ====
(Referring to @ 230 on Piazza)

After I fixed this student's issue, I went to the scoreboard and randomly picked two people who got perfect scores except for the handout category and hit regrade, and their scores also went up to 10.

The error messages usually look like this:

An error occurred while parsing the autoresult returned by the Autograder.

Error message: 795: unexpected token at ': *** [default] Error 2'

Autograder [Thu Jan 22 10:22:36 2015]: Received job 15122-s15_scavhunt_10_aajith@andrew.cmu.edu:315
Autograder [Thu Jan 22 10:22:43 2015]: Error: Copy in to VM failed (status=1)
Autograder [Thu Jan 22 10:22:43 2015]: Here is the output from the autograder:

---
Autodriver: Job exited with status 2
Thu Jan 22 09:22:27 EST 2015
[15-122] Extraction...
=============================================
tar: Skipping to next header
tar: Exiting with failure status due to previous errors
make[1]: *** [extract] Error 2
make: *** [default] Error 2


Score for this problem: 0.0

Graded by: 

I think there may be more students who need regrading. Is there a way to do a bulk regrade?

==== Lead TA, 5am ====

I just did a regrade all. Thanks for noticing this!

==== Lead TA, 6am ====

In response to Grant’s email, I tried to regrade all, and there’s something wrong with the autograder. I get a 500 (internal error) with this error message –

--- !ruby/exception:Net::ReadTimeout {}
@niveditc
Copy link

(Lead TA here)

Here's the stack dump from the 500 I got when I tried to regrade all –

/var/www/.rbenv/versions/2.2.0/lib/ruby/2.2.0/net/protocol.rb:158:in `rescue in rbuf_fill'
/var/www/.rbenv/versions/2.2.0/lib/ruby/2.2.0/net/protocol.rb:152:in `rbuf_fill'
/var/www/.rbenv/versions/2.2.0/lib/ruby/2.2.0/net/protocol.rb:134:in `readuntil'
/var/www/.rbenv/versions/2.2.0/lib/ruby/2.2.0/net/protocol.rb:144:in `readline'
/var/www/.rbenv/versions/2.2.0/lib/ruby/2.2.0/net/http/response.rb:39:in `read_status_line'
/var/www/.rbenv/versions/2.2.0/lib/ruby/2.2.0/net/http/response.rb:28:in `read_new'
/var/www/.rbenv/versions/2.2.0/lib/ruby/2.2.0/net/http.rb:1413:in `block in transport_request'
/var/www/.rbenv/versions/2.2.0/lib/ruby/2.2.0/net/http.rb:1410:in `catch'
/var/www/.rbenv/versions/2.2.0/lib/ruby/2.2.0/net/http.rb:1410:in `transport_request'
/var/www/.rbenv/versions/2.2.0/lib/ruby/2.2.0/net/http.rb:1383:in `request'
/var/www/.rbenv/versions/2.2.0/lib/ruby/2.2.0/net/http.rb:1285:in `request_get'
/var/www/.rbenv/versions/2.2.0/lib/ruby/2.2.0/net/http.rb:480:in `block in get_response'
/var/www/.rbenv/versions/2.2.0/lib/ruby/2.2.0/net/http.rb:853:in `start'
/var/www/.rbenv/versions/2.2.0/lib/ruby/2.2.0/net/http.rb:583:in `start'
/var/www/.rbenv/versions/2.2.0/lib/ruby/2.2.0/net/http.rb:478:in `get_response'
/opt/autolab/build/Autolab/app/controllers/jobs_controller.rb:171:in `getJobs'
/opt/autolab/build/Autolab/app/controllers/jobs_controller.rb:9:in `getCurrentJobs'
/opt/autolab/build/Autolab/app/controllers/jobs_controller.rb:44:in `index'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/actionpack-4.2.0/lib/action_controller/metal/implicit_render.rb:4:in `send_action'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/actionpack-4.2.0/lib/abstract_controller/base.rb:198:in `process_action'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/actionpack-4.2.0/lib/action_controller/metal/rendering.rb:10:in `process_action'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/actionpack-4.2.0/lib/abstract_controller/callbacks.rb:20:in `block in process_action'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/callbacks.rb:117:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/callbacks.rb:117:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/callbacks.rb:234:in `block in halting'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/callbacks.rb:169:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/callbacks.rb:169:in `block in halting'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/callbacks.rb:169:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/callbacks.rb:169:in `block in halting'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/callbacks.rb:151:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/callbacks.rb:151:in `block in halting_and_conditional'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/callbacks.rb:169:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/callbacks.rb:169:in `block in halting'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/callbacks.rb:169:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/callbacks.rb:169:in `block in halting'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/callbacks.rb:169:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/callbacks.rb:169:in `block in halting'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/callbacks.rb:151:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/callbacks.rb:151:in `block in halting_and_conditional'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/callbacks.rb:234:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/callbacks.rb:234:in `block in halting'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/callbacks.rb:169:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/callbacks.rb:169:in `block in halting'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/callbacks.rb:169:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/callbacks.rb:169:in `block in halting'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/callbacks.rb:169:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/callbacks.rb:169:in `block in halting'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/callbacks.rb:92:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/callbacks.rb:92:in `_run_callbacks'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/callbacks.rb:734:in `_run_process_action_callbacks'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/callbacks.rb:81:in `run_callbacks'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/actionpack-4.2.0/lib/abstract_controller/callbacks.rb:19:in `process_action'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/actionpack-4.2.0/lib/action_controller/metal/rescue.rb:29:in `process_action'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/actionpack-4.2.0/lib/action_controller/metal/instrumentation.rb:31:in `block in process_action'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/notifications.rb:164:in `block in instrument'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/notifications/instrumenter.rb:20:in `instrument'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/notifications.rb:164:in `instrument'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/actionpack-4.2.0/lib/action_controller/metal/instrumentation.rb:30:in `process_action'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/actionpack-4.2.0/lib/action_controller/metal/params_wrapper.rb:250:in `process_action'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activerecord-4.2.0/lib/active_record/railties/controller_runtime.rb:18:in `process_action'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/actionpack-4.2.0/lib/abstract_controller/base.rb:137:in `process'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/actionview-4.2.0/lib/action_view/rendering.rb:30:in `process'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/actionpack-4.2.0/lib/action_controller/metal.rb:195:in `dispatch'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/actionpack-4.2.0/lib/action_controller/metal/rack_delegation.rb:13:in `dispatch'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/actionpack-4.2.0/lib/action_controller/metal.rb:236:in `block in action'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/actionpack-4.2.0/lib/action_dispatch/routing/route_set.rb:73:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/actionpack-4.2.0/lib/action_dispatch/routing/route_set.rb:73:in `dispatch'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/actionpack-4.2.0/lib/action_dispatch/routing/route_set.rb:42:in `serve'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/actionpack-4.2.0/lib/action_dispatch/journey/router.rb:43:in `block in serve'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/actionpack-4.2.0/lib/action_dispatch/journey/router.rb:30:in `each'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/actionpack-4.2.0/lib/action_dispatch/journey/router.rb:30:in `serve'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/actionpack-4.2.0/lib/action_dispatch/routing/route_set.rb:802:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/omniauth-1.2.2/lib/omniauth/strategy.rb:186:in `call!'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/omniauth-1.2.2/lib/omniauth/strategy.rb:164:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/omniauth-1.2.2/lib/omniauth/strategy.rb:186:in `call!'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/omniauth-1.2.2/lib/omniauth/strategy.rb:164:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/omniauth-1.2.2/lib/omniauth/strategy.rb:186:in `call!'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/omniauth-1.2.2/lib/omniauth/strategy.rb:164:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/bundler/gems/exception_notification-f9dee5b5f6a1/lib/exception_notification/rack.rb:28:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/rack-ssl-enforcer-0.2.8/lib/rack/ssl-enforcer.rb:52:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/warden-1.2.3/lib/warden/manager.rb:35:in `block in call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/warden-1.2.3/lib/warden/manager.rb:34:in `catch'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/warden-1.2.3/lib/warden/manager.rb:34:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/rack-1.6.0/lib/rack/etag.rb:24:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/rack-1.6.0/lib/rack/conditionalget.rb:25:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/rack-1.6.0/lib/rack/head.rb:13:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/actionpack-4.2.0/lib/action_dispatch/middleware/params_parser.rb:27:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/actionpack-4.2.0/lib/action_dispatch/middleware/flash.rb:260:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/rack-1.6.0/lib/rack/session/abstract/id.rb:225:in `context'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/rack-1.6.0/lib/rack/session/abstract/id.rb:220:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/actionpack-4.2.0/lib/action_dispatch/middleware/cookies.rb:560:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activerecord-4.2.0/lib/active_record/query_cache.rb:36:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activerecord-4.2.0/lib/active_record/connection_adapters/abstract/connection_pool.rb:647:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/actionpack-4.2.0/lib/action_dispatch/middleware/callbacks.rb:29:in `block in call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/callbacks.rb:88:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/callbacks.rb:88:in `_run_callbacks'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/callbacks.rb:734:in `_run_call_callbacks'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/callbacks.rb:81:in `run_callbacks'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/actionpack-4.2.0/lib/action_dispatch/middleware/callbacks.rb:27:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/actionpack-4.2.0/lib/action_dispatch/middleware/remote_ip.rb:78:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/actionpack-4.2.0/lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/actionpack-4.2.0/lib/action_dispatch/middleware/show_exceptions.rb:30:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/railties-4.2.0/lib/rails/rack/logger.rb:38:in `call_app'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/railties-4.2.0/lib/rails/rack/logger.rb:20:in `block in call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/tagged_logging.rb:68:in `block in tagged'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/tagged_logging.rb:26:in `tagged'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/tagged_logging.rb:68:in `tagged'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/railties-4.2.0/lib/rails/rack/logger.rb:20:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/actionpack-4.2.0/lib/action_dispatch/middleware/request_id.rb:21:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/rack-1.6.0/lib/rack/methodoverride.rb:22:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/rack-1.6.0/lib/rack/runtime.rb:18:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/activesupport-4.2.0/lib/active_support/cache/strategy/local_cache_middleware.rb:28:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/rack-1.6.0/lib/rack/sendfile.rb:113:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/railties-4.2.0/lib/rails/engine.rb:518:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/railties-4.2.0/lib/rails/application.rb:164:in `call'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/railties-4.2.0/lib/rails/railtie.rb:194:in `public_send'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/railties-4.2.0/lib/rails/railtie.rb:194:in `method_missing'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/passenger-4.0.57/lib/phusion_passenger/rack/thread_handler_extension.rb:74:in `process_request'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/passenger-4.0.57/lib/phusion_passenger/request_handler/thread_handler.rb:141:in `accept_and_process_next_request'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/passenger-4.0.57/lib/phusion_passenger/request_handler/thread_handler.rb:109:in `main_loop'
/var/www/.rbenv/versions/2.2.0/lib/ruby/gems/2.2.0/gems/passenger-4.0.57/lib/phusion_passenger/request_handler.rb:455:in `block (3 levels) in start_threads'

@robsimmons
Copy link
Author

Wow - the original problem reported is weirder than I expected: the first task on the assignment lists completely different autograder feedback than the remaining four tasks: different job number and and everything. In the case of the student below, who I renamed BOVIK, neither job 442 nor job 407 were listed in the autolab feedback from any other one of their handins, and all the other handins appeard to have consistency of job number between the various tasks, as I would expect.

Regrading individually does seem to make this problem go away, but that's a scary bug!

Autolab feedback for the first task (named "handout"), student BOVIK, handin 5

An error occurred while parsing the autoresult returned by the Autograder.

Error message: 795: unexpected token at ': *** [default] Error 2'

Autograder [Fri Jan 23 10:57:04 2015]: Received job 15122-s15_scavhunt_5_BOVIK@andrew.cmu.edu:442
Autograder [Fri Jan 23 10:57:11 2015]: Error: Copy in to VM failed (status=1)
Autograder [Fri Jan 23 10:57:11 2015]: Here is the output from the autograder:
---
Autodriver: Job exited with status 2
Fri Jan 23 09:56:26 EST 2015
[15-122] Extraction...
=============================================
tar: Skipping to next header
tar: Exiting with failure status due to previous errors
make[1]: *** [extract] Error 2
make: *** [default] Error 2

Score for this problem: 0.0

Graded by: 

Autolab feedback for other tasks, student BOVIK, handin 5

Autograder [Thu Jan 22 10:33:18 2015]: Received job 15122-s15_scavhunt_5_BOVIK@andrew.cmu.edu:407
Autograder [Thu Jan 22 10:33:25 2015]: Success: Autodriver returned normally
Autograder [Thu Jan 22 10:33:25 2015]: Here is the output from the autograder:
---
Autodriver: Job exited with status 0
Thu Jan 22 09:32:58 EST 2015
[15-122] Extraction...
=============================================
scavhunt.c0
puzzle.c0

Thu Jan 22 09:32:59 EST 2015
[15-122] Compilation...
=============================================
Thu Jan 22 09:32:59 EST 2015
[15-122] Grading...
=============================================
TESTING...
==================================================
Task 1: obtaining the handout code
--------------------------------------------------
Test testgreet, expect successful execution
Test passed!
==================================================
Task 2: using the C0 Tutorial
--------------------------------------------------
Test tutorial, expect successful execution
Test passed!
==================================================
Task 3: viewing an image on AFS
--------------------------------------------------
Test salute -d 0, expect successful execution
Test salute -d 1, expect successful execution
Test salute -d 2, expect successful execution
Test passed!
--------------------------------------------------
Test salute -d -1, expect assertion failure
Test salute -d 4, expect assertion failure
Test passed!
==================================================
Task 4: using Piazza
--------------------------------------------------
Test salute -d 3, expect successful execution
Test passed!
==================================================
Task 5: viewing Autolab feedback
--------------------------------------------------
Test feedback, expect successful execution
Test passed!
==================================================
Task 5: string puzzles
--------------------------------------------------
Test puzzletest common_prefix_given, expect successful execution
Test passed!
--------------------------------------------------
Test puzzletest common_prefix_exhaustive, expect successful execution
Test passed!
--------------------------------------------------
Test puzzletest non_repeating_character ab, expect successful execution
Test puzzletest non_repeating_character abb, expect successful execution
Test puzzletest non_repeating_character aab, expect successful execution
Test puzzletest non_repeating_character acb, expect successful execution
Test puzzletest non_repeating_character abbb, expect successful execution
Test puzzletest non_repeating_character acbb, expect successful execution
Test puzzletest non_repeating_character aabb, expect successful execution
Test puzzletest non_repeating_character aacb, expect successful execution
Test puzzletest non_repeating_character aaab, expect successful execution
Test puzzletest non_repeating_character abbbb, expect successful execution
Test puzzletest non_repeating_character acbbb, expect successful execution
Test puzzletest non_repeating_character aabbb, expect successful execution
Test puzzletest non_repeating_character aacbb, expect successful execution
Test puzzletest non_repeating_character aaacb, expect successful execution
Test puzzletest non_repeating_character aaaab, expect successful execution
Test passed!
--------------------------------------------------
Test puzzletest same_start_end, expect successful execution
Test passed!
==================================================

*** FINISHED!
*** TOTAL SCORE:  10
{"scores": {"piazza": 1, "puzzle": 5, "handout": 1, "afsimg": 1, "tutorial": 1, "feedback": 1}}

Score for this problem: 1.0

Graded by: 

@robsimmons
Copy link
Author

Could the broken handins I made while poking at @126 have broken the "regrade all" script? I've now deleted those two broken handins.

@niveditc
Copy link

Not sure if it's related, but the timestamp on the latest feedback seems to be a time in the future (unless I'm reading it wrong). From Rob's comment above –

Autograder [Fri Jan 23 10:57:04 2015]: Received job 15122-s15_scavhunt_5_BOVIK@andrew.cmu.edu:442
Autograder [Fri Jan 23 10:57:11 2015]: Error: Copy in to VM failed (status=1)
Autograder [Fri Jan 23 10:57:11 2015]: Here is the output from the autograder:
---
Autodriver: Job exited with status 2
Fri Jan 23 09:56:26 EST 2015

Doesn't that timestamp indicate 9 a.m. and 10 a.m. today morning (which hasn't happened yet)?

@robsimmons
Copy link
Author

Never mind about my comment 71189933 above - the broken handins are not at fault, without them "regrade all" still fails.

Sorry for conflating two separate bugs (the mysterious zeroes + inconsistent autolab feedback within a submission and the bulk regrade failure) on one issue, I didn't fully understand these were separate things this morning.

@robsimmons
Copy link
Author

Wait... I thought I saw the regrade all fail but now I'm not sure. It appears to have succeeded with this error message...

Warning: Could not regrade 1 submission(s):
/opt/autolab/build/Autolab/courses/15122-s15/scavhunt/handin/robsimmons@gmail.com_remote_handin/scav.c: not found or not readable.

@robsimmons
Copy link
Author

Okay, it looks like I did manage to regrade all, so the command-line-handed-in submissions may have been causing Nivedita's failure.

However, I'm still seeing the same failure to grade the first assignments: everything except for the first task works But when I regrade by hand the right score shows up. I don't know if it's a heisenbug - I don't know if the people that have 9/10 now are the same people that had 9/10 before - or what.

@robsimmons
Copy link
Author

Oh: @niveditc reports that there is now a different group of people with failures, so this appears to be some sort of nondeterminstic bug, great.

@dlbucci
Copy link
Member

dlbucci commented Jan 23, 2015

This sounds like a bug that we spent 6 hours on Monday squashing, and that we were very certain had been fixed. @mihirpandya and @yrkumar should probably get involved in this.

@dlbucci
Copy link
Member

dlbucci commented Jan 23, 2015

So I did regrade all and diffed the exported grades, and sure enough, 17 students had different grades from on regrade all to the next.

@robsimmons
Copy link
Author

Were the changes in multiple directions? (0 -> 1 and 1 -> 0)?

@dlbucci
Copy link
Member

dlbucci commented Jan 23, 2015

Looked to be that way.

@dlbucci
Copy link
Member

dlbucci commented Jan 23, 2015

But it is a little bit strange that only the first problem ever changes. Is it possible that there's some non-determinism in your autograder?

@robsimmons
Copy link
Author

Look at the example autograder feedback above: if you click on the other problems, you seem that my autograder did give people a point for the "handout" task. But if you click on the handout task it reports a completely different job for which autograder never even got to the point of running my python code.

@mihirpandya
Copy link
Member

@niveditc the timestamp issue of the autodriver has to do with autolab/Tango#13

Looks like the bug we fixed on Monday is resurfacing. Might be a race... Digging deeper.

@mihirpandya
Copy link
Member

Looks like a bunch of consecutive submissions or regrades is causing scp to fail erratically. As a result, the files necessary for a job to run are not copied over to the grading VMs, which is why the feedback file says copyIn failed. Still not sure if this is an Autolab issue or an scp issue. A temporary fix would be to retry scp-ing until the file is copied over.

Gonna investigate more and if nothing works out by tonight, I'll just make the temporary fix and investigate further later.

@robsimmons
Copy link
Author

What's the status here? Can I regrade all my initial homework submissions and have confidence that all the grades will be recorded?

@icanb
Copy link
Member

icanb commented Feb 3, 2015

This is an issue with Tango. So moving it over there.

@icanb icanb closed this as completed Feb 3, 2015
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

No branches or pull requests

5 participants