Some kind of race in CanLoadSimpleProject - Githubissues

sbt / sbt-remote-control

Create and manage sbt process using unicorns and forks

Other

74 stars 14 forks source link

Some kind of race in CanLoadSimpleProject #216

Open havocp opened 9 years ago

havocp commented 9 years ago

Saved at https://gist.githubusercontent.com/havocp/3b4866ea03e4545a7e2a/raw/gistfile1.txt

Note "registered more than once?" which is from https://github.com/sbt/sbt-remote-control/blob/dde58a811bd6de1b875b5d8682c1c9514b70b1aa/server/src/main/scala/sbt/server/TaskIdRecorder.scala#L55

The logs just before the error

[0m[[0minfo[0m] [0mCoreLogEvent(LogMessage(debug,> server-handle-next-server-request))[0m
[0m[[0minfo[0m] [0mExecutionStarting(6)[0m
[0m[[0minfo[0m] [0mCoreLogEvent(LogMessage(debug,> {file:/home/travis/build/sbt/sbt-remote-control/it-runner/target/integration-test/com-typesafe-sbtrc-it-loading-CanLoadSimpleProject/scratch/test/}test/compile:unmanagedSources))[0m
[0m[[0minfo[0m] [0mCoreLogEvent(LogMessage(debug,Evaluating tasks: compile:unmanagedSources))[0m
[0m[[0minfo[0m] [0mCoreLogEvent(LogMessage(debug,Running task... Cancel: sbt.server.ServerTaskCancellation@256d06ac, check cycles: false))[0m
[0m[[0minfo[0m] [0mCoreLogEvent(LogMessage(debug,cancel strategy start enabled=true lastCommand=Some(LastCommand(CommandExecutionWork(ExecutionId(6),{file:/home/travis/build/sbt/sbt-remote-control/it-runner/target/integration-test/com-typesafe-sbtrc-it-loading-CanLoadSimpleProject/scratch/test/}test/compile:unmanagedSources,Set(LiveClient(sbt-client-test 7db84039-e1c7-41fb-8a97-692a180b1105)),sbt.server.WorkCancellationStatus$$anon$1@18d11966)))))[0m
[0m[[0minfo[0m] [0mCoreLogEvent(LogMessage(debug,cancel strategy finish enabled=false lastCommand=Some(LastCommand(CommandExecutionWork(ExecutionId(6),{file:/home/travis/build/sbt/sbt-remote-control/it-runner/target/integration-test/com-typesafe-sbtrc-it-loading-CanLoadSimpleProject/scratch/test/}test/compile:unmanagedSources,Set(LiveClient(sbt-client-test 7db84039-e1c7-41fb-8a97-692a180b1105)),sbt.server.WorkCancellationStatus$$anon$1@18d11966)))))[0m
[0m[[0minfo[0m] [0mCoreLogEvent(LogTrace(RuntimeException,registered more than once? Task((taskDefinitionKey: ScopedKey(Scope(Select(ProjectRef(file:/home/travis/build/sbt/sbt-remote-control/it-runner/target/integration-test/com-typesafe-sbtrc-it-loading-CanLoadSimpleProject/scratch/test/,test)),Select(ConfigKey(compile)),Global,Global),unmanagedSources)))))[0m
[0m[[0minfo[0m] [0mCoreLogEvent(LogMessage(error,registered more than once? Task((taskDefinitionKey: ScopedKey(Scope(Select(ProjectRef(file:/home/travis/build/sbt/sbt-remote-control/it-runner/target/integration-test/com-typesafe-sbtrc-it-loading-CanLoadSimpleProject/scratch/test/,test)),Select(ConfigKey(compile)),Global,Global),unmanagedSources)))))[0m
[0m[[0minfo[0m] [0mCoreLogEvent(LogMessage(error,Use 'last' for the full log.))[0m
[0m[[0minfo[0m] [0mCoreLogEvent(LogMessage(debug,> server-post-command-error-handler))[0m
[0m[[0minfo[0m] [0mExecutionFailure(6)[0m
[0m[[0minfo[0m] [0mCoreLogEvent(LogMessage(debug,> server-post-command-cleanup))[0m
[0m[[0minfo[0m] [0mCoreLogEvent(LogMessage(debug,> server-handle-next-server-request))[0m
[0m[[0minfo[0m] [0mlog file is /home/travis/build/sbt/sbt-remote-control/it-runner/target/integration-test/com-typesafe-sbtrc-it-loading-CanLoadSimpleProject/scratch/test/.sbtserver/connections/sbt-client-test-7db84039-e1c7-41fb-8a97-692a180b1105.log, you can uncomment some code in SbtClientTest.scala to dump this if you need to[0m
[0m[[0minfo[0m] [0mClosedEvent()[0m
[0m[[0minfo[0m] [0mNot executing runnable because we only run one thing: Runnable(onError(reconnecting=true, Connection closed))[0m
[0m[[31merror[0m] [0mTest failed: java.lang.RuntimeException: Never received watch task key first value[0m
[0m[[0minfo[0m] [0mWaiting for client to close[0m
[0m[[31merror[0m] [0mjava.lang.RuntimeException: Never received watch task key first value[0m
[0m[[0minfo[0m] [0mlog file is /home/travis/build/sbt/sbt-remote-control/it-runner/target/integration-test/com-typesafe-sbtrc-it-loading-CanLoadSimpleProject/scratch/test/.sbtserver/master.log, you can uncomment some code in SbtClientTest.scala to dump this if you need to[0m
[0m[[31merror[0m] [0m   at scala.sys.package$.error(package.scala:27)[0m
[0m[[31merror[0m] [0m   at com.typesafe.sbtrc.it.SbtClientTest$class.waitWithError(SbtClientTest.scala:33)[0m
[0m[[31merror[0m] [0m   at com.typesafe.sbtrc.it.loading.CanLoadSimpleProject.waitWithError(CanLoadSimpleProject.scala:15)[0m
[0m[[31merror[0m] [0m   at com.typesafe.sbtrc.it.loading.CanLoadSimpleProject$$anonfun$1.apply(CanLoadSimpleProject.scala:172)[0m
[0m[[31merror[0m] [0m   at com.typesafe.sbtrc.it.loading.CanLoadSimpleProject$$anonfun$1.apply(CanLoadSimpleProject.scala:40)[0m
[0m[[31merror[0m] [0m   at com.typesafe.sbtrc.it.SbtClientTest$$anonfun$8.apply(SbtClientTest.scala:187)[0m
[0m[[31merror[0m] [0m   at com.typesafe.sbtrc.it.SbtClientTest$$anonfun$8.apply(SbtClientTest.scala:161)[0m
[0m[[31merror[0m] [0m   at sbt.client.impl.SimpleConnector$OpenListener$$anon$2.run(SimpleConnector.scala:152)[0m
[0m[[31merror[0m] [0m   at com.typesafe.sbtrc.it.SbtClientTest$runOneThingExecutor$2$.runWhenReady(SbtClientTest.scala:144)[0m
[0m[[31merror[0m] [0m   at com.typesafe.sbtrc.it.SbtClientTest$class.withSbt(SbtClientTest.scala:216)[0m
[0m[[31merror[0m] [0m   at com.typesafe.sbtrc.it.loading.CanLoadSimpleProject.withSbt(CanLoadSimpleProject.scala:15)[0m
[0m[[31merror[0m] [0m   at com.typesafe.sbtrc.it.loading.CanLoadSimpleProject.delayedEndpoint$com$typesafe$sbtrc$it$loading$CanLoadSimpleProject$1(CanLoadSimpleProject.scala:40)[0m
[0m[[31merror[0m] [0m   at com.typesafe.sbtrc.it.loading.CanLoadSimpleProject$delayedInit$body.apply(CanLoadSimpleProject.scala:15)[0m
[0m[[31merror[0m] [0m   at scala.Function0$class.apply$mcV$sp(Function0.scala:40)[0m
[0m[[31merror[0m] [0m   at scala.runtime.AbstractFunction0.apply$mcV$sp(AbstractFunction0.scala:12)[0m
[0m[[31merror[0m] [0m   at com.typesafe.sbtrc.it.IntegrationTest$$anonfun$run$1.apply(IntegrationTest.scala:32)[0m
[0m[[31merror[0m] [0m   at com.typesafe.sbtrc.it.IntegrationTest$$anonfun$run$1.apply(IntegrationTest.scala:29)[0m
[0m[[31merror[0m] [0m   at com.typesafe.sbtrc.it.package$.withContextClassloader(package.scala:12)[0m
[0m[[31merror[0m] [0m   at com.typesafe.sbtrc.it.IntegrationTest.run(IntegrationTest.scala:29)[0m
[0m[[31merror[0m] [0m   at xsbt.boot.Launch$$anonfun$run$1.apply(Launch.scala:109)[0m
[0m[[31merror[0m] [0m   at xsbt.boot.Launch$.withContextLoader(Launch.scala:128)[0m
[0m[[31merror[0m] [0m   at xsbt.boot.Launch$.run(Launch.scala:109)[0m
[0m[[31merror[0m] [0m   at xsbt.boot.Launch$$anonfun$apply$1.apply(Launch.scala:35)[0m
[0m[[31merror[0m] [0m   at xsbt.boot.Launch$.launch(Launch.scala:117)[0m
[0m[[31merror[0m] [0m   at xsbt.boot.Launch$.apply(Launch.scala:18)[0m
[0m[[31merror[0m] [0m   at xsbt.boot.Boot$.runImpl(Boot.scala:41)[0m
[0m[[31merror[0m] [0m   at xsbt.boot.Boot$.main(Boot.scala:17)[0m
[0m[[31merror[0m] [0m   at xsbt.boot.Boot.main(Boot.scala)[0m
[0m[[31merror[0m] [0m [IT] com.typesafe.sbtrc.it.loading.CanLoadSimpleProject result: FAILURE[0m