intel-cloud / cosbench

a benchmark tool for cloud object storage service
Other
573 stars 242 forks source link

Cosbench Terminates the job after completing all stages. #394

Open ashoksangee opened 4 years ago

ashoksangee commented 4 years ago

Hi

I am facing a weird issue and not very sure what is the problem.

COSBench 0.4.2.c4
Ceph Nautilus accessing via S3

All stages in my test completes successfully however, Workload status is terminated. Not sure what is the problem.

image

Below is my workload file.

ashoksangee commented 4 years ago

Forgot add the system.log output.

Here is the log and I see a Java exception triggered after the final stage.

2019-11-23 09:00:13,913 [INFO] [WorkloadProcessor] - begin to run stage s8-dispose 2019-11-23 09:00:13,913 [INFO] [WorkloadProcessor] - ============================================ 2019-11-23 09:00:13,913 [INFO] [WorkloadProcessor] - START WORK: dispose 2019-11-23 09:00:13,917 [INFO] [AbstractCommandTasklet] - time drift between controller and driver-driver1 is 1 mSec 2019-11-23 09:00:13,000 [INFO] [StageRunner] - successfully booted all tasks in stage s8-dispose 2019-11-23 09:00:13,007 [INFO] [StageRunner] - successfully submitted all tasks in stage s8-dispose 2019-11-23 09:00:13,009 [INFO] [COSBDriverService] - handler=MB989020A50 2019-11-23 09:00:13,010 [INFO] [MissionHandler] - mission MB989020A50 has been authed successfully 2019-11-23 09:00:13,210 [INFO] [StageRunner] - successfully authenticated all tasks in stage s8-dispose 2019-11-23 09:00:13,413 [INFO] [StageRunner] - successfully launched all tasks in stage s8-dispose 2019-11-23 09:00:13,969 [INFO] [MissionHandler] - mission MB989020A50 has been executed successfully 2019-11-23 09:00:18,416 [INFO] [StageRunner] - successfully queried all tasks in stage s8-dispose 2019-11-23 09:00:18,419 [INFO] [MissionHandler] - mission MB989020A50 has been closed successfully 2019-11-23 09:00:18,441 [INFO] [StageRunner] - successfully closed all tasks in stage s8-dispose 2019-11-23 09:00:18,442 [INFO] [StageRunner] - acceptable failure ratio of work s8-dispose-dispose = 0.0 2019-11-23 09:00:18,442 [INFO] [StageRunner] - real failure ratio of work s8-dispose-dispose = N/A 2019-11-23 09:00:18,442 [INFO] [StageRunner] - successfully reach the goal of acceptable failure ratio in stage s8-dispose - work dispose 2019-11-23 09:00:20,914 [INFO] [WorkloadProcessor] - END WORK: dispose, Time elapsed: 0:0::7 2019-11-23 09:00:20,914 [INFO] [WorkloadProcessor] - ============================================ 2019-11-23 09:00:20,914 [INFO] [WorkloadProcessor] - successfully ran stage s8-dispose 2019-11-23 09:00:20,914 [ERROR] [WorkloadProcessor] - unexpected exception java.lang.NullPointerException at com.intel.cosbench.controller.model.WorkloadContext.mergeErrorStatistics(WorkloadContext.java:286) at com.intel.cosbench.controller.service.WorkloadProcessor.processWorkload(WorkloadProcessor.java:168) at com.intel.cosbench.controller.service.WorkloadProcessor.process(WorkloadProcessor.java:130) at com.intel.cosbench.controller.service.ControllerThread.run(ControllerThread.java:14) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) 2019-11-23 09:00:20,915 [INFO] [WorkloadProcessor] - begin to terminate workload w107 2019-11-23 09:00:21,109 [INFO] [SimpleWorkloadArchiver] - workload w107 has been successfully archived 2019-11-23 09:00:21,110 [INFO] [WorkloadProcessor] - successfully terminated workload w107