console FINE java.util.logging.ConsoleHandler@13ccf8 24-Jul-06 10:50:05 AM frysk.junit.Runner$Results startTest FINE: testDoCloneAckDaemon(frysk.proc.TestProcTasksObserver) ---- startTest ---- Running testDoCloneAckDaemon(frysk.proc.TestProcTasksObserver) ...24-Jul-06 10:50:05 AM frysk.proc.TestLib setUp FINE: testDoCloneAckDaemon(frysk.proc.TestProcTasksObserver) <<<<<<<<<<<<<<<< start setUp 24-Jul-06 10:50:05 AM frysk.event.EventLoop FINE: {Thread[Thread-1,5,main]} new 24-Jul-06 10:50:05 AM frysk.proc.Host FINE: {frysk.proc.LinuxHost@132240,state=running} Host 24-Jul-06 10:50:05 AM frysk.proc.LinuxHost$PollWaitOnSigChld FINE: {frysk.proc.LinuxHost$PollWaitOnSigChld@16b440,sig=Sig_CHLD} PollWaitOnSigChld 24-Jul-06 10:50:05 AM frysk.event.EventLoop FINE: {Thread[Thread-2,5,main]} new 24-Jul-06 10:50:05 AM frysk.proc.Host FINE: {frysk.proc.LinuxHost@132150,state=running} Host 24-Jul-06 10:50:05 AM frysk.proc.LinuxHost$PollWaitOnSigChld FINE: {frysk.proc.LinuxHost$PollWaitOnSigChld@16b160,sig=Sig_CHLD} PollWaitOnSigChld 24-Jul-06 10:50:05 AM frysk.proc.TestLib setUp FINE: testDoCloneAckDaemon(frysk.proc.TestProcTasksObserver) <<<<<<<<<<<<<<<< end setUp 24-Jul-06 10:50:05 AM frysk.proc.TestLib killDuringTearDown FINE: testDoCloneAckDaemon(frysk.proc.TestProcTasksObserver) killDuringTearDown 8,283 24-Jul-06 10:50:05 AM frysk.proc.TestLib assertRunUntilStop FINE: class frysk.proc.TestLib assertRunUntilStop start: startChild (Sig_USR1) 24-Jul-06 10:50:05 AM frysk.event.EventLoop runPolling FINE: {Thread[Thread-2,5,main]} runPolling long 24-Jul-06 10:50:05 AM frysk.event.TimerEvent FINE: {{frysk.event.EventLoop$2$Timeout@13cb40,timeMillis=1153752610929,periodMillis=0},expiredfalse} new long 24-Jul-06 10:50:05 AM frysk.event.EventLoop$2$Timeout FINE: {{frysk.event.EventLoop$2$Timeout@13cb40,timeMillis=1153752610929,periodMillis=0},expiredfalse} timeout 24-Jul-06 10:50:05 AM frysk.proc.LinuxHost$PollWaitOnSigChld execute FINE: {frysk.proc.LinuxHost$PollWaitOnSigChld@16b160,sig=Sig_CHLD} execute 24-Jul-06 10:50:05 AM frysk.sys.Wait log FINE: frysk.sys.Wait pid -1 errno 10 8283.8283: argv[0]=/notnfs/frysk-build/frysk-core/frysk/pkglibexecdir/funit-child 8283.8283: argv[1]=--wait=suspend 8283.8283: argv[2]=10 8283.8283: argv[3]=8280 8283.8283: starting 8283 8283.8283: new thread 8283.8283 8283.8283: notify 8280 with 10 (User defined signal 1) -- new thread 8283.8283 24-Jul-06 10:50:05 AM frysk.proc.TestLib$AckHandler$AckSignal execute FINE: {frysk.proc.TestLib$AckHandler$AckSignal@192f30,sig=Sig_USR1} execute (startChild (Sig_USR1)) 24-Jul-06 10:50:05 AM frysk.event.EventLoop remove FINE: {Thread[Thread-2,5,main]} remove SignalEvent 24-Jul-06 10:50:05 AM frysk.proc.TestLib assertRunUntilStop FINE: class frysk.proc.TestLib assertRunUntilStop stop: startChild (Sig_USR1) 24-Jul-06 10:50:05 AM frysk.event.EventLoop runPending FINE: {Thread[Thread-2,5,main]} runPending 24-Jul-06 10:50:05 AM frysk.proc.HostState$1 handleRefresh FINE: {frysk.proc.LinuxHost@132150,state=running} handleRefresh 24-Jul-06 10:50:05 AM frysk.proc.Host getProc FINE: {frysk.proc.LinuxHost@132150,state=running} getProc ProcId 24-Jul-06 10:50:05 AM frysk.proc.ProcTasksObserver FINE: frysk.proc.ProcTasksObserver@1dc4e0 new 24-Jul-06 10:50:05 AM frysk.event.EventLoop runPending FINE: {Thread[Thread-2,5,main]} runPending 24-Jul-06 10:50:05 AM frysk.proc.Host get FINE: {frysk.proc.LinuxHost@132150,state=running} get TaskId 24-Jul-06 10:50:05 AM frysk.proc.Task requestAddClonedObserver FINE: {frysk.proc.LinuxTask@1ecf60,pid=8283,tid=8283,state=detached} requestAddClonedObserver 24-Jul-06 10:50:05 AM frysk.proc.Proc requestAddObserver FINE: {frysk.proc.LinuxProc@1dec30,pid=8283,state=detached} requestAddObservation 24-Jul-06 10:50:05 AM frysk.proc.Task requestAddTerminatedObserver FINE: {frysk.proc.LinuxTask@1ecf60,pid=8283,tid=8283,state=detached} requestAddTerminatedObserver 24-Jul-06 10:50:05 AM frysk.proc.Proc requestAddObserver FINE: {frysk.proc.LinuxProc@1dec30,pid=8283,state=detached} requestAddObservation 24-Jul-06 10:50:05 AM frysk.proc.ProcState$1 handleAddObservation FINE: {frysk.proc.LinuxProc@1dec30,pid=8283,state=detached} handleAddObserver 24-Jul-06 10:50:05 AM frysk.proc.ProcState$Attaching initialState FINE: {frysk.proc.LinuxProc@1dec30,pid=8283,state=detached} state 24-Jul-06 10:50:05 AM frysk.proc.Host get FINE: {frysk.proc.LinuxHost@132150,state=running} get TaskId 24-Jul-06 10:50:05 AM frysk.proc.TaskState$1 handleAttach FINE: {frysk.proc.LinuxTask@1ecf60,pid=8283,tid=8283,state=detached} handleAttach 24-Jul-06 10:50:05 AM frysk.proc.LinuxTask sendAttach FINE: {frysk.proc.LinuxTask@1ecf60,pid=8283,tid=8283,state=detached} sendAttach 24-Jul-06 10:50:05 AM frysk.proc.ProcState$Attaching$ToMainTask handleAddObservation FINE: {frysk.proc.LinuxProc@1dec30,pid=8283,state=Attaching.ToMainTask} handleAddObservation 24-Jul-06 10:50:05 AM frysk.proc.TestLib assertRunUntilStop FINE: class frysk.proc.TestLib assertRunUntilStop start: addClone (Sig_USR1,Sig_USR2) 24-Jul-06 10:50:05 AM frysk.event.EventLoop runPolling FINE: {Thread[Thread-2,5,main]} runPolling long 24-Jul-06 10:50:05 AM frysk.event.TimerEvent FINE: {{frysk.event.EventLoop$2$Timeout@1edf50,timeMillis=1153752610950,periodMillis=0},expiredfalse} new long 24-Jul-06 10:50:05 AM frysk.event.EventLoop$2$Timeout FINE: {{frysk.event.EventLoop$2$Timeout@1edf50,timeMillis=1153752610950,periodMillis=0},expiredfalse} timeout 24-Jul-06 10:50:05 AM frysk.proc.LinuxHost$PollWaitOnSigChld execute FINE: {frysk.proc.LinuxHost$PollWaitOnSigChld@16b160,sig=Sig_CHLD} execute 24-Jul-06 10:50:05 AM frysk.sys.Wait log FINE: frysk.sys.Wait pid 8283 status 0xa7f 24-Jul-06 10:50:05 AM frysk.sys.Wait log FINE: frysk.sys.Wait pid 0 errno 0 24-Jul-06 10:50:05 AM frysk.proc.LinuxHost$PollWaitOnSigChld$2 getTask FINE: {TaskId,8283} stopped 24-Jul-06 10:50:05 AM frysk.proc.Host get FINE: {frysk.proc.LinuxHost@132150,state=running} get TaskId 24-Jul-06 10:50:05 AM frysk.proc.TaskState$2 handleSignaledEvent FINE: {frysk.proc.LinuxTask@1ecf60,pid=8283,tid=8283,state=attaching} handleSignaledEvent 24-Jul-06 10:50:05 AM frysk.proc.Proc performTaskAttachCompleted FINE: {frysk.proc.LinuxProc@1dec30,pid=8283,state=Attaching.ToMainTask} performTaskAttachCompleted 24-Jul-06 10:50:05 AM frysk.proc.ProcState$Attaching$ToMainTask handleTaskAttachCompleted FINE: {frysk.proc.LinuxProc@1dec30,pid=8283,state=Attaching.ToMainTask} handleTaskAttachCompleted 24-Jul-06 10:50:05 AM frysk.proc.ProcState$Attaching allAttached FINE: {frysk.proc.LinuxProc@1dec30,pid=8283,state=Attaching.ToMainTask} allAttached 24-Jul-06 10:50:05 AM frysk.proc.TaskState$Attached handleAddObserver FINE: {frysk.proc.LinuxTask@1ecf60,pid=8283,tid=8283,state=Attached.WaitForContinueOrUnblock} handleAddObserver 24-Jul-06 10:50:05 AM frysk.proc.TestProcTasksObserver$ProcTasksTester existingTask FINE: ProcTasksTester.existingTask() task: {frysk.proc.LinuxTask@1ecf60,pid=8283,tid=8283,state=Attached.WaitForContinueOrUnblock} 24-Jul-06 10:50:05 AM frysk.proc.TaskState$Attached handleAddObserver FINE: {frysk.proc.LinuxTask@1ecf60,pid=8283,tid=8283,state=Attached.WaitForContinueOrUnblock} handleAddObserver 24-Jul-06 10:50:05 AM frysk.proc.TaskState$Attached$WaitForContinueOrUnblock handleContinue FINE: {frysk.proc.LinuxTask@1ecf60,pid=8283,tid=8283,state=Attached.WaitForContinueOrUnblock} handleContinue 24-Jul-06 10:50:05 AM frysk.proc.LinuxTask sendSetOptions FINE: {frysk.proc.LinuxTask@1ecf60,pid=8283,tid=8283,state=Attached.WaitForContinueOrUnblock} sendSetOptions 24-Jul-06 10:50:05 AM frysk.proc.LinuxTask sendContinue FINE: {frysk.proc.LinuxTask@1ecf60,pid=8283,tid=8283,state=Attached.WaitForContinueOrUnblock} sendContinue 24-Jul-06 10:50:05 AM frysk.proc.Proc$ObservableXXX notify FINE: {frysk.proc.LinuxProc@1dec30,pid=8283,state=Attaching.ToMainTask} notify -- all observers 24-Jul-06 10:50:05 AM frysk.proc.LinuxHost$PollWaitOnSigChld execute FINE: {frysk.proc.LinuxHost$PollWaitOnSigChld@16b160,sig=Sig_CHLD} execute 24-Jul-06 10:50:05 AM frysk.sys.Wait log FINE: frysk.sys.Wait pid 8283 status 0x137f 24-Jul-06 10:50:05 AM frysk.sys.Wait log FINE: frysk.sys.Wait pid 0 errno 0 24-Jul-06 10:50:05 AM frysk.proc.LinuxHost$PollWaitOnSigChld$2 getTask FINE: {TaskId,8283} stopped 24-Jul-06 10:50:05 AM frysk.proc.Host get FINE: {frysk.proc.LinuxHost@132150,state=running} get TaskId 24-Jul-06 10:50:05 AM frysk.proc.TaskState$Running handleStoppedEvent FINE: {frysk.proc.LinuxTask@1ecf60,pid=8283,tid=8283,state=running} handleStoppedEvent 24-Jul-06 10:50:10 AM frysk.event.EventLoop$2$Timeout execute FINE: {{frysk.event.EventLoop$2$Timeout@1edf50,timeMillis=1153752610950,periodMillis=0},expiredfalse} execute 24-Jul-06 10:50:10 AM frysk.proc.TestLib tearDown FINE: testDoCloneAckDaemon(frysk.proc.TestProcTasksObserver) >>>>>>>>>>>>>>>> start tearDown 24-Jul-06 10:50:10 AM frysk.proc.TestLib tearDown FINE: testDoCloneAckDaemon(frysk.proc.TestProcTasksObserver) kill -KILL 8283 24-Jul-06 10:50:10 AM frysk.proc.TestLib tearDown FINE: testDoCloneAckDaemon(frysk.proc.TestProcTasksObserver) kill -CONT 8283 24-Jul-06 10:50:10 AM frysk.proc.TestLib tearDown FINE: testDoCloneAckDaemon(frysk.proc.TestProcTasksObserver) detach -KILL 8283 24-Jul-06 10:50:10 AM frysk.sys.Wait log FINE: frysk.sys.Wait pid -1 errno 10 24-Jul-06 10:50:10 AM frysk.proc.TestLib tearDown FINE: testDoCloneAckDaemon(frysk.proc.TestProcTasksObserver) >>>>>>>>>>>>>>>> end tearDown 24-Jul-06 10:50:10 AM frysk.junit.Runner$Results printProblem FINE: testDoCloneAckDaemon(frysk.proc.TestProcTasksObserver) --- addFailure ---- FAIL: junit.framework.AssertionFailedError: event loop run explictly stopped (addClone (Sig_USR1,Sig_USR2)) FAIL junit.framework.AssertionFailedError: event loop run explictly stopped (addClone (Sig_USR1,Sig_USR2))24-Jul-06 10:50:10 AM frysk.junit.Runner$Results endTest FINE: testDoCloneAckDaemon(frysk.proc.TestProcTasksObserver) ---- endTest ---- Time: 5.033 There was 1 failure: 1) testDoCloneAckDaemon(frysk.proc.TestProcTasksObserver)junit.framework.AssertionFailedError: event loop run explictly stopped (addClone (Sig_USR1,Sig_USR2)) at frysk.proc.TestLib.assertRunUntilStop(TestRunner) at frysk.proc.TestLib.assertRunUntilStop(TestRunner) at frysk.proc.TestLib$AckHandler.assertAwait(TestRunner) at frysk.proc.TestLib$AckHandler.await(TestRunner) at frysk.proc.TestLib$AckProcess.spawn(TestRunner) at frysk.proc.TestLib$AckProcess.addClone(TestRunner) at frysk.proc.TestProcTasksObserver.doClone(TestRunner) at frysk.proc.TestProcTasksObserver.testDoCloneAckDaemon(TestRunner) at frysk.junit.Runner.(TestRunner) at TestRunner.main(TestRunner) FAILURES!!! Tests run: 1, Failures: 1, Errors: 0