On Tue, 2010-05-11 at 23:29 +0530, sudhir kumar wrote:
> On Tue, May 11, 2010 at 9:04 PM, poornima nayak
> <[email protected]> wrote:
> > Hi All
> >
> > When I execute my tests in KVM Autotest. I get this failure randomly.
> > Not sure what is this error 'Test subprocess failed rc=9'.
>
> Does this test connecthon run any other legacy or full testsuite?
> The same messgae should be there inside the .DEBUG file too. Please
> send the lines before and after this error.
> This looks to be an abnormal exit from the kvm subprocess which might
> be executing any autotest test inside the guest.
>
Pasted debug info of failure along with information of the test that has
passed before this failure.
05/11 11:40:19 INFO |kvm_subpro:0880| 14:40:18 INFO | START
connecthon.itera-100-test-1 connecthon.itera-100-test-1
timestamp=1273603218 localtime=May 11 14:40:18
05/11 11:40:19 INFO |kvm_subpro:0880| 14:40:19 INFO | Test started.
Number of iterations: 1
05/11 11:40:19 INFO |kvm_subpro:0880| 14:40:19 INFO | Executing
iteration 1 of 1
05/11 11:40:19 INFO |kvm_subpro:0880| 14:40:19 INFO | Dropping caches
between iterations
05/11 11:40:20 INFO |kvm_subpro:0880| 14:40:19 INFO | tarball is
cthon04.tgz
05/11 11:40:20 INFO |kvm_subpro:0880| 14:40:19 INFO | connecthon
tarball /root/project_llm52/client/tests/connecthon/cthon04.tgz
05/11 11:42:54 INFO |kvm_subpro:0880| 14:42:54 INFO | Test finished
after 1 iterations.
05/11 11:42:55 INFO |kvm_subpro:0880| 14:42:54 INFO | GOOD
connecthon.itera-100-test-1 connecthon.itera-100-test-1
timestamp=1273603374 localtime=May 11 14:42:54 completed
successfully
05/11 11:42:55 INFO |kvm_subpro:0880| 14:42:55 INFO | END GOOD
connecthon.itera-100-test-1 connecthon.itera-100-test-1
timestamp=1273603375 localtime=May 11 14:42:55
05/11 11:42:56 INFO |kvm_subpro:0880| 14:42:55 INFO | START
connecthon.itera-1000-test-2 connecthon.itera-1000-test-2
timestamp=1273603375 localtime=May 11 14:42:55
05/11 11:42:57 INFO |kvm_subpro:0880| 14:42:56 INFO | Test started.
Number of iterations: 1
05/11 11:42:57 INFO |kvm_subpro:0880| 14:42:56 INFO | Executing
iteration 1 of 1
05/11 11:42:57 INFO |kvm_subpro:0880| 14:42:56 INFO | Dropping caches
between iterations
05/11 11:42:57 INFO |kvm_subpro:0880| 14:42:56 INFO | tarball is
cthon04.tgz
05/11 11:42:57 INFO |kvm_subpro:0880| 14:42:56 INFO | connecthon
tarball /root/project_llm52/client/tests/connecthon/cthon04.tgz
05/11 12:14:03 INFO |kvm_subpro:0880| 15:14:02 INFO | ERROR
connecthon.itera-1000-test-2 connecthon.itera-1000-test-2
timestamp=1273605241 localtime=May 11 15:14:01 Test subprocess
failed rc=9
05/11 12:14:07 INFO |kvm_subpro:0880| 15:14:06 INFO | END ERROR
connecthon.itera-1000-test-2 connecthon.itera-1000-test-2
timestamp=1273605245 localtime=May 11 15:14:05
05/11 12:14:22 INFO |kvm_subpro:0880| 15:14:21 INFO | START
connecthon.itera-10-test-3 connecthon.itera-10-test-3
timestamp=1273605256 localtime=May 11 15:14:16
05/11 12:15:17 INFO |kvm_subpro:0880| 15:15:15 INFO | Test started.
Number of iterations: 1
05/11 12:15:17 INFO |kvm_subpro:0880| 15:15:16 INFO | Executing
iteration 1 of 1
05/11 12:15:17 INFO |kvm_subpro:0880| 15:15:16 INFO | Dropping caches
between iterations
I get this failure multiple times for different test conditions
For one of the test condition I do get this information in debug file
15:32:09 INFO | ERROR connecthon.itera-100-test-7
connecthon.itera-100-test-7 timestamp=1273606324 localtime=May 11
15:32:04 Test subprocess failed rc=9
15:32:32 INFO | END ERROR connecthon.itera-100-test-7
connecthon.itera-100-test-7 timestamp=1273606345 localtime=May 11
15:32:25
15:32:36 ERROR| JOB ERROR: Unhandled CmdError: Command <sync> failed,
rc=-9, Command returned non-zero exit status
* Command:
sync
Exit status: -9
Duration: 0
Traceback (most recent call last):
File "/root/project_llm52/client/bin/job.py", line 969, in step_engine
execfile(self.control, global_control_vars, global_control_vars)
File "/root/project_llm52/client/control", line 25, in <module>
job.run_test('connecthon',tarball=None,testdir=dir,args=test,iteration=j,tag=("itera-%s-test-%s"
%(j,loop_cntr)))
File "/root/project_llm52/client/bin/job.py", line 48, in wrapped
utils.drop_caches()
File "/root/project_llm52/client/bin/base_utils.py", line 710, in
drop_caches
utils.system("sync")
File "/root/project_llm52/client/common_lib/utils.py", line 670, in
system
stdout_tee=TEE_TO_LOGS, stderr_tee=TEE_TO_LOGS).exit_status
File "/root/project_llm52/client/common_lib/utils.py", line 433, in
run
"Command returned non-zero exit status")
CmdError: Command <sync> failed, rc=-9, Command returned non-zero exit
status
* Command:
sync
Exit status: -9
Duration: 0
> >
> > FAIL kvm.raw.Fedora.12.64.virtio.autotest.connecthon
> > kvm.raw.Fedora.12.64.virtio.autotest.connecthon timestamp=1273606409
> > localtime=May 11 12:33:29 Test 'connecthon.itera-1000-test-2' ended
> > with ERROR (reason: 'Test subprocess failed rc=9')
> >
> > I dont get any other information when this test failes and it is very
> > random. Not aware if this is bug in KVM Autotest or the testcase failed
> > due to issue in kvm guest OS.
> >
> > If i get some pointers to understand this issue would be a great help.
> >
> > Regards
> > Poornima
> >
> > _______________________________________________
> > Autotest mailing list
> > [email protected]
> > http://test.kernel.org/cgi-bin/mailman/listinfo/autotest
> >
>
>
>
_______________________________________________
Autotest mailing list
[email protected]
http://test.kernel.org/cgi-bin/mailman/listinfo/autotest
