Port Locks UP Unity 3.13 TSP6.02b

[astectelecom]

Hello

About twice a week one or more of our unity ports will lock-up during a subscriber login attempt. We are unable to reset the port using the status monitor and must reboot the server to free the port(s) up. Each time a port locks up around 20 avmiu_mc (failure on port in av wav) errors are written to the apln log. (possibly bug cscdx78628, although the fix for that bug is an upgrade to 3.13 which hasn't sorted the problem out).

We have a TAC case open (D230507). On TAC's advice we have enabled the skinny trace and the most recent log is included below (port 1 locked up at 12:27).

thanks very much for your help.

jim

2002-10-31 11:42:54,AvLogMgrSvr_MC,10007,-1,-1,diag file opened

11:42:54:453,AvLogMgrSvr_MC,10012,-1,-1,-1,-1,D:\CommServer\logs\diag_AvCsMgr_20021031_114253.txt,D:\CommServer\logs\diag_AvCsMgr_20021031_114254.txt

11:56:30:062,AvLogMgrSvr_MC,10013,-1,-1,-1,-1

11:56:30:063,AvLogMgrSvr_MC,10013,-1,-1,-1,-1

11:56:30:156,AvLogMgrSvr_MC,10011,-1,-1,-1,-1,D:\CommServer\logs\data_AvCsMgr_20021031_112622.txt,D:\CommServer\logs\data_AvCsMgr_20021031_115630.txt

11:57:40:125,AvLogMgrSvr_MC,10002,-1,-1,-1,-1

12:12:40:125,AvLogMgrSvr_MC,10002,-1,-1,-1,-1

12:26:34:359,AvLogMgrSvr_MC,10013,-1,-1,-1,-1

12:26:34:360,AvLogMgrSvr_MC,10013,-1,-1,-1,-1

12:26:34:453,AvLogMgrSvr_MC,10011,-1,-1,-1,-1,D:\CommServer\logs\data_AvCsMgr_20021031_115630.txt,D:\CommServer\logs\data_AvCsMgr_20021031_122634.txt

12:27:40:125,AvLogMgrSvr_MC,10002,-1,-1,-1,-1

12:27:46:687,AvMiu_MC,690,-1,-1,MiuGeneral,0,1, File: e:\views\Unity3.1.2.41\un_Miu\UnityAvWav\ACM.C(1713) Method: AcmStreamConvert Failure: call to acmStreamPrepareHeader failed with error(200),0x00000A78

12:27:46:688,AvMiu_MC,690,-1,-1,MiuGeneral,0,1, File: e:\views\Unity3.1.2.41\un_Miu\UnityAvWav\ACM.C(1133) Method: AcmConvert Failure: call to AcmStreamConvert failed,0x00000A78

12:27:46:687,AvMiu_MC,690,-1,-1,MiuGeneral,0,1, File: e:\views\Unity3.1.2.41\un_Miu\UnityAvWav\WAV.C(2407) Method: WavWrite Failure: call to mmioWrite failed,0x00000A78

12:27:46:703,AvMiu_MC,690,-1,-1,MiuGeneral,0,1, File: e:\views\Unity3.1.2.41\un_Miu\UnityAvWav\WAV.C(4724) Method: WavWriteFormatRecordAGC Failure: call to WavWrite failed,0x00000A78

12:27:46:704,AvMiu_MC,690,-1,-1,MiuGeneral,0,1, File: e:\views\Unity3.1.2.41\un_Miu\UnityAvWav\WAV.C(6308) Method: WavNotify Failure: call to WavWriteFormatRecordAGC failed,0x00000A78

12:28:16:703,AvMiu_MC,690,-1,-1,MiuGeneral,0,1, File: e:\views\Unity3.1.2.41\un_Miu\UnityAvWav\WAVIN.C(725) Method: WavInClose Failure: call to WaitForSingleObject (hEventDeviceClosed) failed,0x00001128

12:28:16:704,AvMiu_MC,690,-1,-1,MiuGeneral,0,1, File: e:\views\Unity3.1.2.41\un_Miu\UnityAvWav\WAV.C(5522) Method: WavStopRecord Failure: call to WavInClose failed,0x00001128

12:28:16:718,AvMiu_MC,690,-1,-1,MiuGeneral,0,1, File: e:\views\Unity3.1.2.41\un_Miu\UnityAvWav\WAV.C(2264) Method: WavStop Failure: call to WavStopRecord failed,0x00001128

12:28:16:719,AvMiu_MC,683,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),AvWav WavStop failed with 0xFFFFFFFF,0x00001128

12:28:16:718,AvMiu_MC,686,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(), FileName: C:\WINNT\Profiles\ADMINI~1\LOCALS~1\Temp\WAV1.tmp HWAV: 0x0D0C1EDC WavState: WAV_STOPPING,0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),1,[12:26:23:125 - 0x00001004] Drop() - S_OK,0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),2,[12:26:23:671 - 0x0000091C] LINE_APPNEWCALL(0x00010428),0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),3,[12:26:23:671 - 0x0000091C] SetEvent(NewCall),0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),4,[12:26:23:750 - 0x00001128] Answer() entered,0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),5,[12:26:23:750 - 0x00001128] lineAnswer(0x00010428) - 0x00010464,0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),6,[12:26:23:750 - 0x0000091C] LINE_REPLY(0x00010464 | 0x00000000),0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),7,[12:26:23:875 - 0x0000091C] LINECALLSTATE_CONNECTED(0x00010428 | Active),0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),8,[12:26:23:875 - 0x00001128] WaitFor(0x00010464 | CONNECTED) - CONNECTED,0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),9,[12:26:23:875 - 0x00001128] Answer() - S_MIU_CONNECTED,0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),10,[12:26:24:109 - 0x00001128] Play() entered,0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),11,[12:26:24:109 - 0x00001128] WavOpen(0x0BA6CB50) - 0x0D0C1EDC,0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),12,[12:26:24:109 - 0x00001128] WavGetLength(0x0D0C1EDC) - 10430,0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),13,[12:26:24:109 - 0x00001128] WavClose(0x0D0C1EDC) - 0x00000000,0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),14,[12:26:24:109 - 0x00001128] WavOpen(D:\CommServer\localize\Prompts\ENG\AvPHGreet\AvPHGreetENG037.wav) - 0x0D0C1EDC,0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),15,[12:26:24:109 - 0x00001128] WavGetLength(0x0D0C1EDC) - 5851,0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),16,[12:26:24:109 - 0x00001128] WavClose(0x0D0C1EDC) - 0x00000000,0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),17,[12:26:24:109 - 0x00001128] WavOpen(0x0BA6CB50) - 0x0D0C1EDC,0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),18,[12:26:24:109 - 0x00001128] WavSetChunks(0x0D0C1EDC) - 0x00000000,0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),19,[12:26:24:109 - 0x00001128] WavSetPosition(0x0D0C1EDC | 0) - 0,0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),20,[12:26:24:109 - 0x00001128] WavSetVolume(0x0D0C1EDC | 50) - 0x00000000,0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),21,[12:26:24:109 - 0x00001128] WavSetSpeed(0x0D0C1EDC | 100) - 0x00000000,0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),22,[12:26:24:203 - 0x00001128] WavPlay(0x0D0C1EDC) - 0x00000000,0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),23,[12:26:34:609 - 0x00000A78] SetEvent(WavStopped),0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),24,[12:26:34:609 - 0x00001128] WaitFor(StopEvents) - WavStopped,0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),25,[12:26:34:609 - 0x00001128] WavGetLength(0x0D0C1EDC) - 10430,0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),26,[12:26:34:609 - 0x00001128] WavClose(0x0D0C1EDC) - 0x00000000,0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),27,[12:26:34:609 - 0x00001128] Play(Item 1 of 2 | IStream 0x0BA6CB50) - 0 to 10430,0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),28,[12:26:34:609 - 0x00001128] WavOpen(D:\CommServer\localize\Prompts\ENG\AvPHGreet\AvPHGreetENG037.wav) - 0x0D0C1EDC,0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),29,[12:26:34:609 - 0x00001128] WavSetChunks(0x0D0C1EDC) - 0x00000000,0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),30,[12:26:34:609 - 0x00001128] WavSetPosition(0x0D0C1EDC | 0) - 0,0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),31,[12:26:34:609 - 0x00001128] WavSetVolume(0x0D0C1EDC | 50) - 0x00000000,0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),32,[12:26:34:609 - 0x00001128] WavSetSpeed(0x0D0C1EDC | 100) - 0x00000000,0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),33,[12:26:34:609 - 0x00001128] WavPlay(0x0D0C1EDC) - 0x00000000,0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),34,[12:26:40:468 - 0x00000A78] SetEvent(WavStopped),0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),35,[12:26:40:468 - 0x00001128] WaitFor(StopEvents) - WavStopped,0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),36,[12:26:40:468 - 0x00001128] WavGetLength(0x0D0C1EDC) - 5851,0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),37,[12:26:40:468 - 0x00001128] WavClose(0x0D0C1EDC) - 0x00000000,0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),38,[12:26:40:468 - 0x00001128] Play(Item 2 of 2 | WaveFile D:\CommServer\localize\Prompts\ENG\AvPHGreet\AvPHGreetENG037.wav) - 0 to 5851,0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),39,[12:26:40:468 - 0x00001128] Play(2 Items | PlayLength 16281) - S_OK,0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),40,[12:26:40:468 - 0x00001128] GatherDigits(GATHER) entered,0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),41,[12:26:40:468 - 0x00001128] WaitFor(Digit) - Timeout,0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),42,[12:26:40:468 - 0x00001128] GatherDigits(GATHER - <NONE>) - S_MIU_TERM_TIMEOUT,0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),43,[12:26:40:484 - 0x00001128] GatherDigits(FLUSH) entered,0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),44,[12:26:40:484 - 0x00001128] GatherDigits(FLUSH - <>) - S_OK,0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),45,[12:26:40:484 - 0x00001128] Record() entered,0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),46,[12:26:40:484 - 0x00001128] WavOpen(0x2208CC38) - 0x0D0C1EDC,0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),47,[12:26:40:484 - 0x00001128] WavClose(0x0D0C1EDC) - 0x00000000,0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),48,[12:26:40:484 - 0x00001128] WavOpen(C:\WINNT\Profiles\ADMINI~1\LOCALS~1\Temp\WAV1.tmp) - 0x0D0C1EDC,0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),49,[12:26:40:484 - 0x00001128] WavSetChunks(0x0D0C1EDC) - 0x00000000,0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),50,[12:26:40:484 - 0x00001128] WavGetLength(0x0D0C1EDC) - 0,0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),51,[12:26:40:484 - 0x00001128] WavSetPosition(0x0D0C1EDC | 0) - 0,0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),52,[12:26:40:484 - 0x00001128] WavOpen(D:\CommServer\Support\RecordBeep.wav) - 0x0D0B20FC,0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),53,[12:26:40:484 - 0x00001128] WavSetPosition(0x0D0B20FC | 0) - 0,0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),54,[12:26:40:484 - 0x00001128] WavPlay(0x0D0B20FC) - 0x00000000,0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),55,[12:26:40:671 - 0x0000139C] SetEvent(WavStopped),0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),56,[12:26:40:671 - 0x00001128] WaitFor(StopEvents) - WavStopped,0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),57,[12:26:40:671 - 0x00001128] WavRecord(0x0D0C1EDC) - 0x00000000,0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),58,[12:27:46:343 - 0x0000091C] LINECALLSTATE_DISCONNECTED(0x00010428 | Normal),0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),59,[12:27:46:343 - 0x0000091C] StopIO(TERM_DROPPED) entered,0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),60,[12:27:46:343 - 0x0000091C] SetEvent(StopRequested),0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),61,[12:27:46:343 - 0x0000091C] StopIO(TERM_DROPPED) - S_OK,0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),62,[12:27:46:343 - 0x0000091C] LINECALLSTATE_IDLE(0x00010428),0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),63,[12:27:46:343 - 0x0000091C] StopIO(TERM_DROPPED) entered,0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),64,[12:27:46:343 - 0x0000091C] StopIO(TERM_DROPPED) - S_OK,0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),65,[12:27:46:343 - 0x00001128] WaitFor(StopEvents) - StopRequested,0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),66,[12:27:46:437 - 0x00001004] Drop() entered,0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),67,[12:27:46:437 - 0x00001004] Drop Iteration 1 Call State: LINECALLSTATE_IDLE,0x00001128

12:28:16:718,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),68,[12:28:16:703 - 0x00001128] SetEvent(WavStopped),0x00001128

12:28:16:719,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Record(),69,[12:28:16:718 - 0x00001128] WavStop(0x0D0C1EDC) - 0xFFFFFFFF,0x00001128

12:28:16:875,AvMiu_MC,690,-1,-1,MiuGeneral,0,1,e:\views\Unity3.1.2.41\un_Miu\UnityAvWav\WAVIN.C(1064) : Exception caught in Method WavInStop | Data hWavIn 0D0B3A64,0x00000A78

12:28:16:876,AvMiu_MC,690,-1,-1,MiuGeneral,0,1, File: e:\views\Unity3.1.2.41\un_Miu\UnityAvWav\WAVIN.C(688) Method: WavInClose Failure: call to WavInStop failed,0x00000A78

12:28:16:875,AvMiu_MC,690,-1,-1,MiuGeneral,0,1,e:\views\Unity3.1.2.41\un_Miu\UnityAvWav\WAVIN.C(788) : Exception caught in Method WavInClose | Data hWavIn 0D0B3A64,0x00000A78

12:28:16:876,AvMiu_MC,690,-1,-1,MiuGeneral,0,1, File: e:\views\Unity3.1.2.41\un_Miu\UnityAvWav\WAV.C(5522) Method: WavStopRecord Failure: call to WavInClose failed,0x00000A78

12:28:16:875,AvMiu_MC,690,-1,-1,MiuGeneral,0,1, File: e:\views\Unity3.1.2.41\un_Miu\UnityAvWav\WAV.C(6395) Method: WavNotify Failure: call to WavStopRecord failed,0x00000A78

12:28:16:876,AvMiu_MC,690,-1,-1,MiuGeneral,0,1,e:\views\Unity3.1.2.41\un_Miu\UnityAvWav\WAVIN.C(1064) : Exception caught in Method WavInStop | Data hWavIn 0D0B3A64,0x00001128

12:28:16:890,AvMiu_MC,690,-1,-1,MiuGeneral,0,1, File: e:\views\Unity3.1.2.41\un_Miu\UnityAvWav\WAVIN.C(1751) Method: WavInNotify Failure: lpWavIn is NULL,0x00000A24

12:28:16:906,AvMiu_MC,690,-1,-1,MiuGeneral,0,1, File: e:\views\Unity3.1.2.41\un_Miu\UnityAvWav\WAVIN.C(688) Method: WavInClose Failure: call to WavInStop failed,0x00001128

12:28:16:907,AvMiu_MC,690,-1,-1,MiuGeneral,0,1,e:\views\Unity3.1.2.41\un_Miu\UnityAvWav\WAVIN.C(788) : Exception caught in Method WavInClose | Data hWavIn 0D0B3A64,0x00001128

12:28:16:906,AvMiu_MC,690,-1,-1,MiuGeneral,0,1, File: e:\views\Unity3.1.2.41\un_Miu\UnityAvWav\WAV.C(5522) Method: WavStopRecord Failure: call to WavInClose failed,0x00001128

12:28:16:907,AvMiu_MC,690,-1,-1,MiuGeneral,0,1, File: e:\views\Unity3.1.2.41\un_Miu\UnityAvWav\WAV.C(2264) Method: WavStop Failure: call to WavStopRecord failed,0x00001128

12:28:16:906,AvMiu_MC,690,-1,-1,MiuGeneral,0,1, File: e:\views\Unity3.1.2.41\un_Miu\UnityAvWav\WAV.C(1390) Method: WavClose Failure: call to WavStop failed,0x00001128

12:28:16:907,AvMiu_MC,683,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),AvWav WavClose failed with 0xFFFFFFFF,0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),1,[12:26:23:125 - 0x00001004] Drop() - S_OK,0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),2,[12:26:23:671 - 0x0000091C] LINE_APPNEWCALL(0x00010428),0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),3,[12:26:23:671 - 0x0000091C] SetEvent(NewCall),0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),4,[12:26:23:750 - 0x00001128] Answer() entered,0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),5,[12:26:23:750 - 0x00001128] lineAnswer(0x00010428) - 0x00010464,0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),6,[12:26:23:750 - 0x0000091C] LINE_REPLY(0x00010464 | 0x00000000),0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),7,[12:26:23:875 - 0x0000091C] LINECALLSTATE_CONNECTED(0x00010428 | Active),0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),8,[12:26:23:875 - 0x00001128] WaitFor(0x00010464 | CONNECTED) - CONNECTED,0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),9,[12:26:23:875 - 0x00001128] Answer() - S_MIU_CONNECTED,0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),10,[12:26:24:109 - 0x00001128] Play() entered,0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),11,[12:26:24:109 - 0x00001128] WavOpen(0x0BA6CB50) - 0x0D0C1EDC,0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),12,[12:26:24:109 - 0x00001128] WavGetLength(0x0D0C1EDC) - 10430,0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),13,[12:26:24:109 - 0x00001128] WavClose(0x0D0C1EDC) - 0x00000000,0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),14,[12:26:24:109 - 0x00001128] WavOpen(D:\CommServer\localize\Prompts\ENG\AvPHGreet\AvPHGreetENG037.wav) - 0x0D0C1EDC,0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),15,[12:26:24:109 - 0x00001128] WavGetLength(0x0D0C1EDC) - 5851,0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),16,[12:26:24:109 - 0x00001128] WavClose(0x0D0C1EDC) - 0x00000000,0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),17,[12:26:24:109 - 0x00001128] WavOpen(0x0BA6CB50) - 0x0D0C1EDC,0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),18,[12:26:24:109 - 0x00001128] WavSetChunks(0x0D0C1EDC) - 0x00000000,0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),19,[12:26:24:109 - 0x00001128] WavSetPosition(0x0D0C1EDC | 0) - 0,0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),20,[12:26:24:109 - 0x00001128] WavSetVolume(0x0D0C1EDC | 50) - 0x00000000,0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),21,[12:26:24:109 - 0x00001128] WavSetSpeed(0x0D0C1EDC | 100) - 0x00000000,0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),22,[12:26:24:203 - 0x00001128] WavPlay(0x0D0C1EDC) - 0x00000000,0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),23,[12:26:34:609 - 0x00000A78] SetEvent(WavStopped),0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),24,[12:26:34:609 - 0x00001128] WaitFor(StopEvents) - WavStopped,0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),25,[12:26:34:609 - 0x00001128] WavGetLength(0x0D0C1EDC) - 10430,0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),26,[12:26:34:609 - 0x00001128] WavClose(0x0D0C1EDC) - 0x00000000,0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),27,[12:26:34:609 - 0x00001128] Play(Item 1 of 2 | IStream 0x0BA6CB50) - 0 to 10430,0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),28,[12:26:34:609 - 0x00001128] WavOpen(D:\CommServer\localize\Prompts\ENG\AvPHGreet\AvPHGreetENG037.wav) - 0x0D0C1EDC,0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),29,[12:26:34:609 - 0x00001128] WavSetChunks(0x0D0C1EDC) - 0x00000000,0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),30,[12:26:34:609 - 0x00001128] WavSetPosition(0x0D0C1EDC | 0) - 0,0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),31,[12:26:34:609 - 0x00001128] WavSetVolume(0x0D0C1EDC | 50) - 0x00000000,0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),32,[12:26:34:609 - 0x00001128] WavSetSpeed(0x0D0C1EDC | 100) - 0x00000000,0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),33,[12:26:34:609 - 0x00001128] WavPlay(0x0D0C1EDC) - 0x00000000,0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),34,[12:26:40:468 - 0x00000A78] SetEvent(WavStopped),0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),35,[12:26:40:468 - 0x00001128] WaitFor(StopEvents) - WavStopped,0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),36,[12:26:40:468 - 0x00001128] WavGetLength(0x0D0C1EDC) - 5851,0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),37,[12:26:40:468 - 0x00001128] WavClose(0x0D0C1EDC) - 0x00000000,0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),38,[12:26:40:468 - 0x00001128] Play(Item 2 of 2 | WaveFile D:\CommServer\localize\Prompts\ENG\AvPHGreet\AvPHGreetENG037.wav) - 0 to 5851,0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),39,[12:26:40:468 - 0x00001128] Play(2 Items | PlayLength 16281) - S_OK,0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),40,[12:26:40:468 - 0x00001128] GatherDigits(GATHER) entered,0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),41,[12:26:40:468 - 0x00001128] WaitFor(Digit) - Timeout,0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),42,[12:26:40:468 - 0x00001128] GatherDigits(GATHER - <NONE>) - S_MIU_TERM_TIMEOUT,0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),43,[12:26:40:484 - 0x00001128] GatherDigits(FLUSH) entered,0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),44,[12:26:40:484 - 0x00001128] GatherDigits(FLUSH - <>) - S_OK,0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),45,[12:26:40:484 - 0x00001128] Record() entered,0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),46,[12:26:40:484 - 0x00001128] WavOpen(0x2208CC38) - 0x0D0C1EDC,0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),47,[12:26:40:484 - 0x00001128] WavClose(0x0D0C1EDC) - 0x00000000,0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),48,[12:26:40:484 - 0x00001128] WavOpen(C:\WINNT\Profiles\ADMINI~1\LOCALS~1\Temp\WAV1.tmp) - 0x0D0C1EDC,0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),49,[12:26:40:484 - 0x00001128] WavSetChunks(0x0D0C1EDC) - 0x00000000,0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),50,[12:26:40:484 - 0x00001128] WavGetLength(0x0D0C1EDC) - 0,0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),51,[12:26:40:484 - 0x00001128] WavSetPosition(0x0D0C1EDC | 0) - 0,0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),52,[12:26:40:484 - 0x00001128] WavOpen(D:\CommServer\Support\RecordBeep.wav) - 0x0D0B20FC,0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),53,[12:26:40:484 - 0x00001128] WavSetPosition(0x0D0B20FC | 0) - 0,0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),54,[12:26:40:484 - 0x00001128] WavPlay(0x0D0B20FC) - 0x00000000,0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),55,[12:26:40:671 - 0x0000139C] SetEvent(WavStopped),0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),56,[12:26:40:671 - 0x00001128] WaitFor(StopEvents) - WavStopped,0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),57,[12:26:40:671 - 0x00001128] WavRecord(0x0D0C1EDC) - 0x00000000,0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),58,[12:27:46:343 - 0x0000091C] LINECALLSTATE_DISCONNECTED(0x00010428 | Normal),0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),59,[12:27:46:343 - 0x0000091C] StopIO(TERM_DROPPED) entered,0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),60,[12:27:46:343 - 0x0000091C] SetEvent(StopRequested),0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),61,[12:27:46:343 - 0x0000091C] StopIO(TERM_DROPPED) - S_OK,0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),62,[12:27:46:343 - 0x0000091C] LINECALLSTATE_IDLE(0x00010428),0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),63,[12:27:46:343 - 0x0000091C] StopIO(TERM_DROPPED) entered,0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),64,[12:27:46:343 - 0x0000091C] StopIO(TERM_DROPPED) - S_OK,0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),65,[12:27:46:343 - 0x00001128] WaitFor(StopEvents) - StopRequested,0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),66,[12:27:46:437 - 0x00001004] Drop() entered,0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),67,[12:27:46:437 - 0x00001004] Drop Iteration 1 Call State: LINECALLSTATE_IDLE,0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),68,[12:28:16:703 - 0x00001128] SetEvent(WavStopped),0x00001128

12:28:16:906,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),69,[12:28:16:718 - 0x00001128] WavStop(0x0D0C1EDC) - 0xFFFFFFFF,0x00001128

12:28:16:907,AvMiu_MC,688,-1,-1,MiuGeneral,0,1,CAvMiuWave::Close(),70,[12:28:16:906 - 0x00001128] WavClose(0x0D0C1EDC) - 0xFFFFFFFF,0x00001128

2002-10-31 12:42:38,AvLogMgrSvr_MC,10008,-1,-1,diag file closed

[echappell]

I have a simular issue with 3.1.4. TAC wants me to get traces as well as upgrade to 3.1.5. I'll be doing the upgrade this weekend.

[oconnost]

As we.... The ports lockup, and then fail over is initiated. I have yet to get a response from TAC on this issue.

[jakevargas]

We have seen the same issue here often at the mayors office. This started happening after we installed a MS patch for security vul. It happens with the TTS service using the port and not releasing it so it stays there in limbo. We just have to restart the AvTTS service and it frees it up. It's annoying though. We are running 3.1.2 and I'm hoping an upgrade to 3.1.5 will fix it. We're waiting for TAC to say, "Yes. It will"

[rick.bowers]

I've battled this issue for some time & I'm already at 3.1.5. To date, I have found no fix and the cause is uncertain as it happens very intermittently.

[Ginger Dillon]

Hello -

We worked with TAC on this same issue for 3.1(5). The fix was us was upgrading TSP to 7.0(1). The TSP code handles the error more elegantly and should the error reoccur, requires just a stop/start of the TTS service - where it before required a reboot of Unity to correct. Tonight I am upgrading to TSP 7.0(2), the most current version of the wave drivers.

Regards, Ginger

[kechambe]

I was the engineer that worked with Ginger on this case so I will chime in here...

She is correct that TSP 7.0(1) adds new logic that forces the port to unregister and stay unregistered until it is freed up by the TTS engine. There also was a custom dll that we built for Ginger which had improved error handling. With the new dll, exceptions thrown by the TTS process are handled which means the port wouldn't lock in the first place. That code is available in 4.0(2) and will be in 3.1(6) when it is released.

(Ginger, please let me know if you are still seeing exceptions that we aren’t catching.)

My advice for you is to request a hotfix for CSCdz48747 (built off the 3.1(5) branch) from the TAC engineer if they determine that you are seeing the same issue. The symptom is an AvTTS_MC 1016 WavOutClose failed error message in the application log.

Hope that helps,

Keith