A problem occurred starting process, IOException, No such file or directory

whitingjr · November 17, 2014, 1:39pm

Hi,

I am seeing an error that doesn’t make sense. Using the exec command to call a java application. A script on my system starts a tool to manage the Faban application.

This is the configuration block for the exec command

exec {
   workingDir = "${ant.properties['faban.harness.dir']}/bin"
   executable ="${ant.properties['fabancli']}"
   errorOutput = new BufferedOutputStream ( new FileOutputStream("${ant.properties['driver.results.harness.runid']}/faban_cli.err"))
     standardOutput = new BufferedOutputStream ( new FileOutputStream("${ant.properties['driver.results.harness.runid']}/faban_cli.out"))
}

The ant properties are built dynamically at runtime. I’ve tried testing with explicit paths without success.

The error message indicates a file or directory is not found.

.............
13:23:22.335 [INFO] [org.gradle.api.internal.project.ant.AntLoggingAdapter] [ant:delete] Deleting: /run/media/whitingjr/theark/work/redhat/java/acme/acmeerprise/acme-git-acmenext/acmeerprise/driver-results/runid.tmp
13:23:22.338 [QUIET] [system.out] [/run/media/whitingjr/theark/work/redhat/java/acme/acmeerprise/acme-git-acmenext/acmeerprise/driver-results/45/harness.runid]
13:23:22.362 [INFO] [org.gradle.process.internal.DefaultExecHandle] Starting process 'command 'fabancli''. Working directory: /run/media/whitingjr/theark/work/redhat/java/acme/acmeerprise/acme-git-acmenext/acmeerprise/faban/harness/faban/bin Command: fabancli
 13:23:22.362 [DEBUG] [org.gradle.process.internal.DefaultExecHandle] Environment for process 'command 'fabancli'' <removed>
13:23:22.363 [DEBUG] [org.gradle.process.internal.DefaultExecHandle] Changing state to: STARTING
13:23:22.381 [DEBUG] [org.gradle.process.internal.DefaultExecHandle] Waiting until process started: command 'fabancli'.
13:23:22.383 [DEBUG] [org.gradle.process.internal.DefaultExecHandle] Changing state to: FAILED
13:23:22.383 [DEBUG] [org.gradle.logging.internal.DefaultLoggingConfigurer] Finished configuring with level: DEBUG, configurers: [org.gradle.logging.internal.OutputEventRenderer@73a03b0, org.gradle.logging.internal.logback.LogbackLoggingConfigurer@71c81b84, org.gradle.logging.internal.JavaUtilLoggingConfigurer@886b178]
13:23:22.384 [DEBUG] [org.gradle.api.internal.tasks.execution.ExecuteAtMostOnceTaskExecuter
                                                                  ]
                                                                             Finished executing task ':faban:faban.cli.run'
13:23:22.384 [LIFECYCLE] [org.gradle.TaskExecutionLogger] :faban:faban.cli.run FAILED
13:23:22.387 [INFO] [org.gradle.process.internal.DefaultExecHandle] Process 'command 'fabancli'' finished with exit value -1 (state: FAILED)
13:23:22.389 [ERROR] [org.gradle.BuildExceptionReporter]
 13:23:22.390 [ERROR] [org.gradle.BuildExceptionReporter] FAILURE: Build failed with an exception.
13:23:22.390 [ERROR] [org.gradle.BuildExceptionReporter]
 13:23:22.390 [ERROR] [org.gradle.BuildExceptionReporter] * What went wrong:
13:23:22.391 [ERROR] [org.gradle.BuildExceptionReporter] Execution failed for task ':faban:faban.cli.run'.
13:23:22.391 [ERROR] [org.gradle.BuildExceptionReporter] > A problem occurred starting process 'command 'fabancli''
13:23:22.393 [ERROR] [org.gradle.BuildExceptionReporter]
 13:23:22.393 [ERROR] [org.gradle.BuildExceptionReporter] * Exception is:
13:23:22.394 [ERROR] [org.gradle.BuildExceptionReporter] org.gradle.api.tasks.TaskExecutionException: Execution failed for task ':faban:faban.cli.run'.
13:23:22.394 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.api.internal.tasks.execution.ExecuteActionsTaskExecuter.executeActions(ExecuteActionsTaskExecuter.java:68)
13:23:22.395 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.api.internal.tasks.execution.ExecuteActionsTaskExecuter.execute(ExecuteActionsTaskExecuter.java:46)
13:23:22.395 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.api.internal.tasks.execution.PostExecutionAnalysisTaskExecuter.execute(PostExecutionAnalysisTaskExecuter.java:34)
13:23:22.395 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.api.internal.changedetection.CacheLockHandlingTaskExecuter$1.run(CacheLockHandlingTaskExecuter.java:34)
13:23:22.396 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.cache.internal.DefaultCacheAccess$3.create(DefaultCacheAccess.java:243)
13:23:22.396 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.cache.internal.DefaultCacheAccess.longRunningOperation(DefaultCacheAccess.java:188)
13:23:22.396 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.cache.internal.DefaultCacheAccess.longRunningOperation(DefaultCacheAccess.java:241)
13:23:22.397 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.cache.internal.DefaultPersistentDirectoryStore.longRunningOperation(DefaultPersistentDirectoryStore.java:137)
13:23:22.397 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.api.internal.changedetection.DefaultTaskArtifactStateCacheAccess.longRunningOperation(DefaultTaskArtifactStateCacheAccess.java:83)
13:23:22.397 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.api.internal.changedetection.CacheLockHandlingTaskExecuter.execute(CacheLockHandlingTaskExecuter.java:32)
13:23:22.398 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.api.internal.tasks.execution.SkipUpToDateTaskExecuter.execute(SkipUpToDateTaskExecuter.java:55)
13:23:22.398 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.api.internal.tasks.execution.ValidatingTaskExecuter.execute(ValidatingTaskExecuter.java:57)
13:23:22.399 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.api.internal.tasks.execution.SkipEmptySourceFilesTaskExecuter.execute(SkipEmptySourceFilesTaskExecuter.java:41)
13:23:22.399 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.api.internal.tasks.execution.SkipTaskWithNoActionsExecuter.execute(SkipTaskWithNoActionsExecuter.java:51)
13:23:22.399 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.api.internal.tasks.execution.SkipOnlyIfTaskExecuter.execute(SkipOnlyIfTaskExecuter.java:52)
13:23:22.400 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.api.internal.tasks.execution.ExecuteAtMostOnceTaskExecuter.execute(ExecuteAtMostOnceTaskExecuter.java:42)
13:23:22.400 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.api.internal.AbstractTask.executeWithoutThrowingTaskFailure(AbstractTask.java:247)
13:23:22.400 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.execution.taskgraph.DefaultTaskPlanExecutor.executeTask(DefaultTaskPlanExecutor.java:52)
13:23:22.401 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.execution.taskgraph.DefaultTaskPlanExecutor.processTask(DefaultTaskPlanExecutor.java:38)
13:23:22.401 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.execution.taskgraph.DefaultTaskPlanExecutor.process(DefaultTaskPlanExecutor.java:30)
13:23:22.401 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.execution.taskgraph.DefaultTaskGraphExecuter.execute(DefaultTaskGraphExecuter.java:83)
13:23:22.402 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.execution.SelectedTaskExecutionAction.execute(SelectedTaskExecutionAction.java:29)
13:23:22.402 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.execution.DefaultBuildExecuter.execute(DefaultBuildExecuter.java:61)
13:23:22.402 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.execution.DefaultBuildExecuter.access$200(DefaultBuildExecuter.java:23)
13:23:22.403 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.execution.DefaultBuildExecuter$2.proceed(DefaultBuildExecuter.java:67)
13:23:22.403 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.api.internal.changedetection.TaskCacheLockHandlingBuildExecuter$1.run(TaskCacheLockHandlingBuildExecuter.java:31)
13:23:22.403 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.cache.internal.DefaultCacheAccess$2.create(DefaultCacheAccess.java:118)
13:23:22.404 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.cache.internal.DefaultCacheAccess.useCache(DefaultCacheAccess.java:133)
13:23:22.404 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.cache.internal.DefaultCacheAccess.useCache(DefaultCacheAccess.java:116)
13:23:22.405 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.cache.internal.DefaultPersistentDirectoryStore.useCache(DefaultPersistentDirectoryStore.java:129)
13:23:22.405 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.api.internal.changedetection.DefaultTaskArtifactStateCacheAccess.useCache(DefaultTaskArtifactStateCacheAccess.java:79)
13:23:22.405 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.api.internal.changedetection.TaskCacheLockHandlingBuildExecuter.execute(TaskCacheLockHandlingBuildExecuter.java:29)
13:23:22.406 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.execution.DefaultBuildExecuter.execute(DefaultBuildExecuter.java:61)
13:23:22.406 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.execution.DefaultBuildExecuter.access$200(DefaultBuildExecuter.java:23)
13:23:22.406 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.execution.DefaultBuildExecuter$2.proceed(DefaultBuildExecuter.java:67)
13:23:22.407 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.execution.DryRunBuildExecutionAction.execute(DryRunBuildExecutionAction.java:32)
13:23:22.407 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.execution.DefaultBuildExecuter.execute(DefaultBuildExecuter.java:61)
13:23:22.407 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.execution.DefaultBuildExecuter.execute(DefaultBuildExecuter.java:54)
13:23:22.408 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.initialization.DefaultGradleLauncher.doBuildStages(DefaultGradleLauncher.java:158)
13:23:22.408 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.initialization.DefaultGradleLauncher.doBuild(DefaultGradleLauncher.java:113)
13:23:22.408 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.initialization.DefaultGradleLauncher.run(DefaultGradleLauncher.java:81)
13:23:22.408 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.launcher.cli.ExecuteBuildAction.run(ExecuteBuildAction.java:38)
13:23:22.409 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.launcher.exec.InProcessGradleLauncherActionExecuter.execute(InProcessGradleLauncherActionExecuter.java:39)
13:23:22.409 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.launcher.exec.InProcessGradleLauncherActionExecuter.execute(InProcessGradleLauncherActionExecuter.java:25)
13:23:22.409 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.launcher.cli.RunBuildAction.run(RunBuildAction.java:50)
13:23:22.409 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.launcher.cli.ActionAdapter.execute(ActionAdapter.java:30)
13:23:22.410 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.launcher.cli.ActionAdapter.execute(ActionAdapter.java:22)
13:23:22.410 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.launcher.cli.CommandLineActionFactory$ParseAndBuildAction.execute(CommandLineActionFactory.java:200)
13:23:22.410 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.launcher.cli.CommandLineActionFactory$ParseAndBuildAction.execute(CommandLineActionFactory.java:173)
13:23:22.410 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.launcher.cli.CommandLineActionFactory$WithLogging.execute(CommandLineActionFactory.java:169)
13:23:22.411 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.launcher.cli.CommandLineActionFactory$WithLogging.execute(CommandLineActionFactory.java:138)
13:23:22.411 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.launcher.cli.ExceptionReportingAction.execute(ExceptionReportingAction.java:33)
13:23:22.411 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.launcher.cli.ExceptionReportingAction.execute(ExceptionReportingAction.java:22)
13:23:22.411 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.launcher.Main.doAction(Main.java:48)
13:23:22.412 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.launcher.bootstrap.EntryPoint.run(EntryPoint.java:45)
13:23:22.412 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.launcher.Main.main(Main.java:39)
13:23:22.412 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.launcher.bootstrap.ProcessBootstrap.runNoExit(ProcessBootstrap.java:50)
13:23:22.412 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.launcher.bootstrap.ProcessBootstrap.run(ProcessBootstrap.java:32)
13:23:22.412 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.launcher.GradleMain.main(GradleMain.java:26)
13:23:22.413 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.wrapper.BootstrapMainStarter.start(BootstrapMainStarter.java:33)
13:23:22.413 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.wrapper.WrapperExecutor.execute(WrapperExecutor.java:130)
13:23:22.413 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.wrapper.GradleWrapperMain.main(GradleWrapperMain.java:47)
13:23:22.413 [ERROR] [org.gradle.BuildExceptionReporter] Caused by: org.gradle.process.internal.ExecException: A problem occurred starting process 'command 'fabancli''
13:23:22.414 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.process.internal.DefaultExecHandle.setEndStateInfo(DefaultExecHandle.java:195)
13:23:22.414 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.process.internal.DefaultExecHandle.failed(DefaultExecHandle.java:325)
13:23:22.414 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.process.internal.ExecHandleRunner.run(ExecHandleRunner.java:90)
13:23:22.414 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.internal.concurrent.DefaultExecutorFactory$StoppableExecutorImpl$1.run(DefaultExecutorFactory.java:66)
13:23:22.415 [ERROR] [org.gradle.BuildExceptionReporter] Caused by: java.io.IOException: Cannot run program "fabancli" (in directory "/run/media/whitingjr/theark/work/redhat/java/acme/acmeerprise/acme-git-acmenext/acmeerprise/faban/harness/faban/bin"): error=2, No such file or directory
13:23:22.415 [ERROR] [org.gradle.BuildExceptionReporter]
at org.gradle.process.internal.ExecHandleRunner.run(ExecHandleRunner.java:71)
13:23:22.415 [ERROR] [org.gradle.BuildExceptionReporter]
... 1 more
13:23:22.415 [ERROR] [org.gradle.BuildExceptionReporter] Caused by: java.io.IOException: error=2, No such file or directory
13:23:22.416 [ERROR] [org.gradle.BuildExceptionReporter]
... 2 more
13:23:22.416 [ERROR] [org.gradle.BuildExceptionReporter]
 13:23:22.416 [LIFECYCLE] [org.gradle.BuildResultLogger]
 13:23:22.416 [LIFECYCLE] [org.gradle.BuildResultLogger] BUILD FAILED
13:23:22.417 [LIFECYCLE] [org.gradle.BuildResultLogger]
 13:23:22.417 [LIFECYCLE] [org.gradle.BuildResultLogger] Total time: 11.286 secs
13:23:22.421 [DEBUG] [org.gradle.cache.internal.DefaultFileLockManager] Releasing lock on no_buildscript class cache for build file '/run/media/whitingjr/theark/work/redhat/java/acme/acmeerprise/acme-git-acmenext/acmeerprise/modules/ws-supplier/ws-supplier.gradle' (/home/whitingjr/.gradle/caches/1.2/scripts/ws_supplier_v5rnvh50q0llilcqlnrgcb80h/ProjectScript/no_buildscript).
......

Yet listing the directory that is missing shows it to exist and contains the file executable ‘fabancli’.

$ ls -l
/run/media/whitingjr/theark/work/redhat/java/acme/acmeerprise/acme-git-acmenext/acmeerprise/faban/harness/faban/bin
total 68
-rwxr-xr-x. 1 whitingjr whitingjr 1739 May
1
2014 agent
-rwxr-xr-x. 1 whitingjr whitingjr 2439 May
1
2014 agent.cmd
-rwxr-xr-x. 1 whitingjr whitingjr
132 May
1
2014 drop.sql
-rwxr-xr-x. 1 whitingjr whitingjr
966 May
1
2014 fabancli
-rwxr-xr-x. 1 whitingjr whitingjr
999 May
1
2014 fabancli.cmd
-rwxr-xr-x. 1 whitingjr whitingjr 1686 May
1
2014 fenxi
-rwxr-xr-x. 1 whitingjr whitingjr 1086 May
1
2014 fenxi.cmd
-rwxr-xr-x. 1 whitingjr whitingjr 1051 May
1
2014 fhb
-rwxr-xr-x. 1 whitingjr whitingjr
906 May
1
2014 fhb.cmd
drwxr-xr-x. 4 whitingjr whitingjr 4096 May
1
2014 Linux
drwxr-xr-x. 2 whitingjr whitingjr 4096 May
1
2014 Mac
-rwxr-xr-x. 1 whitingjr whitingjr
976 May
1
2014 makeagent
-rwxr-xr-x. 1 whitingjr whitingjr 1153 May
1
2014 mcstat
-rwxr-xr-x. 1 whitingjr whitingjr
855 May
1
2014 pushagents
-rwxr-xr-x. 1 whitingjr whitingjr
424 May
1
2014 rootinstall.sh
drwxr-xr-x. 5 whitingjr whitingjr 4096 May
1
2014 SunOS
drwxr-xr-x. 2 whitingjr whitingjr 4096 May
1
2014 Windows
[whitingjr@burtha02-f20 acmeerprise (issue-#26)]$

What’s going on here and how can I debug the situation further ?

Regards, Jeremy

Gradle: 1.8.4 Fedora20 $ java -version java version “1.7.0_71” OpenJDK Runtime Environment (fedora-2.5.3.0.fc20-x86_64 u71-b14) OpenJDK 64-Bit Server VM (build 24.65-b04, mixed mode)

whitingjr · November 17, 2014, 5:28pm

Problem solved. Having a quick read of the groovy docs on Process Management explains the problem. It is shell and built in commands.

Think I will switch back to using the Ant exec task to get this working.

sterling · November 17, 2014, 10:03pm

What’s the value of each of these?

workingDir = “${ant.properties[‘faban.harness.dir’]}/bin”

executable ="${ant.properties[‘fabancli’]}"

Even if the executable you want to run is in the current working directory, you can get the same error (. isn’t on the PATH). Did you try something like this (changes the path to the executable to be absolute)?

workingDir = "${ant.properties['faban.harness.dir']}/bin"
   executable = new File(workingDir, "${ant.properties['fabancli']}")

whitingjr · November 18, 2014, 12:19pm

@Sterling The first property is an absolute directory path to the location of the executable.

The value of the second is the filename of the executable.

Your right though to highlight the environment variable. The script file is not on the PATH. Which is the cause of the error.

whitingjr · November 18, 2014, 6:22pm

Setting the executable property as you suggested has it working. Thank you for your help.