How to read diag.dat to findout MWI problem?

[max1017]

I have a problem is my IP Phone's VoiceMail LAMP turn on each morning, I searched in forum I should download diag.dat file from 3300 to diagnosis my problem. But I really no idea how to use those information.

Problem extension is 9866

02/28 15:51:39 INFO 2403-03 VT_ON:0
02/28 15:51:39 INFO 6001-03 Msg V4d6b52a9.0d7 (02/28 15:46)) for 9899 deleted
03/01 02:00:08 INFO 7077-00 fileio_open:pen([/vmail/d/vm/msg/msg0.vox],2,0)=-1,ctxt=[x_compress]
03/01 02:00:08 ERROR 5308-00 x_compress(0,msg0.vox,15)=-1
03/01 02:00:38 INFO 7077-00 fileio_open:pen([/vmail/d/vm/msg/msg9866.vox],2,0)=-1,ctxt=[x_compress]
03/01 02:00:38 ERROR 5308-00 x_compress(9866,msg9866.vox,15)=-1
03/01 02:02:18 INFO 7077-00 fileio_open:pen([/vmail/d/vm/msg/msg2548.vox],2,0)=-1,ctxt=[x_compress]
03/01 02:02:18 ERROR 5308-00 x_compress(2548,msg2548.vox,15)=-1
03/01 02:02:28 INFO 7077-00 fileio_open:pen([/vmail/d/vm/msg/msg3335.vox],2,0)=-1,ctxt=[x_compress]
03/01 02:02:28 ERROR 5308-00 x_compress(3335,msg3335.vox,15)=-1
03/01 02:02:48 INFO 7077-00 fileio_open:pen([/vmail/d/vm/msg/msg9814.vox],2,0)=-1,ctxt=[x_compress]
03/01 02:02:48 ERROR 5308-00 x_compress(9814,msg9814.vox,15)=-1
03/01 03:00:09 INFO 4904-00 Abort scheduled for 03:00
03/01 03:00:09 WARNING 7526-33 0x12166cd0 CvvmServer:oCallback(0x0, 4, 3, 0x0) NULL session
03/01 03:00:09 WARNING 7526-33 0x12166cd0 CvvmServer:oCallback(0x0, 4, 0, 0x0) NULL session
03/01 03:00:10 ERROR 7087-36 fileio_close::fd=654 not on unbuffered open list,ctxt=[edt_Run]
03/01 03:00:10 TRACE 0000-36 fileio_close::close(654)=25532816,ctxt=[edt_Run]
03/01 03:00:10 INFO 4320-01 stopch() issued
03/01 03:00:10 INFO 4320-02 stopch() issued
03/01 03:00:10 INFO 4320-03 stopch() issued
03/01 03:00:10 INFO 4320-04 stopch() issued
03/01 03:00:10 INFO 4320-05 stopch() issued
03/01 03:00:10 INFO 4320-06 stopch() issued
03/01 03:00:10 INFO 4320-07 stopch() issued
03/01 03:00:10 INFO 4320-08 stopch() issued
03/01 03:00:10 INFO 4320-09 stopch() issued
03/01 03:00:10 INFO 4320-10 stopch() issued
03/01 03:00:10 INFO 4320-11 stopch() issued
03/01 03:00:10 INFO 4320-12 stopch() issued
03/01 03:00:10 INFO 4320-13 stopch() issued
03/01 03:00:10 INFO 4320-14 stopch() issued
03/01 03:00:10 INFO 4320-15 stopch() issued
03/01 03:00:10 INFO 4320-16 stopch() issued
03/01 03:00:10 INFO 4321-01 T_STOP received
03/01 03:00:10 INFO 4321-02 T_STOP received
03/01 03:00:10 INFO 4321-03 T_STOP received
03/01 03:00:10 INFO 4321-04 T_STOP received
03/01 03:00:10 INFO 4321-05 T_STOP received
03/01 03:00:10 INFO 4321-06 T_STOP received
03/01 03:00:10 INFO 4321-07 T_STOP received
03/01 03:00:10 INFO 4321-08 T_STOP received
03/01 03:00:10 INFO 4321-09 T_STOP received
03/01 03:00:10 INFO 4321-10 T_STOP received
03/01 03:00:10 INFO 4321-11 T_STOP received
03/01 03:00:10 INFO 4321-12 T_STOP received
03/01 03:00:10 INFO 4321-13 T_STOP received
03/01 03:00:10 INFO 4321-14 T_STOP received
03/01 03:00:10 INFO 4321-15 T_STOP received
03/01 03:00:10 INFO 4321-16 T_STOP received
03/01 03:00:10 INFO 4316-00 vtxd40: Voice Mail is gracefully shutting down
03/01 03:00:10 INFO 7050-00 event_queue_delete()::Callback function unregisterd
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[0],ptr=[0xfc69388]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[1],ptr=[0xfc68560]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[2],ptr=[0xfc67738]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[3],ptr=[0xfc66910]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[4],ptr=[0xfc65ae8]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[5],ptr=[0xfc64cc0]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[6],ptr=[0xfc63e98]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[7],ptr=[0xfc63070]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[8],ptr=[0xfc62248]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[9],ptr=[0xfc61420]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[10],ptr=[0xfc605f8]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[11],ptr=[0xfc5f7d0]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[12],ptr=[0xfc5e9a8]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[13],ptr=[0xfc5db80]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[14],ptr=[0xfc5cd58]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[15],ptr=[0xfc5bf30]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[16],ptr=[0xfc5b108]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[17],ptr=[0xfc5a2e0]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[18],ptr=[0xfc594b8]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[19],ptr=[0xfc58690]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[20],ptr=[0xfc57868]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[21],ptr=[0xfc56a40]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[22],ptr=[0xfc55c18]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[23],ptr=[0xfc54df0]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[24],ptr=[0xfc53fc8]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[25],ptr=[0xfc531a0]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[26],ptr=[0xfc52378]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[27],ptr=[0xfc51550]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[28],ptr=[0xfc50728]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[29],ptr=[0x1d725b80]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[30],ptr=[0x10ca33c8]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[31],ptr=[0x10ca25a0]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[32],ptr=[0x10ca1778]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[33],ptr=[0x10ca0950]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[34],ptr=[0x10c9fb28]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[35],ptr=[0x10c9ed00]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[36],ptr=[0x10c9ded8]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[37],ptr=[0x10c9d0b0]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[38],ptr=[0x10b27778]
03/01 03:00:10 INFO 7055-00 vtg_malloc_cleanup,i=[39],ptr=[0x10ccd0d8]
03/01 03:00:10 INFO 7701-00 Exiting vm.exe(1)

03/01 03:00:10 WARNING 7526-33 0x12166cd0 CvvmServer:oCallback(0x0, 4, 1, 0x0) NULL session
03/01 03:00:10 INFO 7046-00 event_queue_create()::Callback function set:0x18555d0
03/01 03:00:10 INFO 8401-01 Number of channels: voxdrv=16, vbpc=30, rac=0
03/01 03:00:11 INFO 4328-00 vtxd40: 16 ports available, 16 installed
03/01 03:00:11 INFO 4916-00 0x10ca0a20=vtg_malloc(14280)
03/01 03:00:11 INFO 4916-00 0x10c9fbf8=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10c9edd0=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10c9dfa8=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10c9d180=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0xfc6d1a8=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x1d725b80=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10cc85f0=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10cc77c8=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10cc69a0=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10cc5b78=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10cc4d50=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10cc3f28=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10cc3100=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10cc22d8=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10cc14b0=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10cc0688=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10cbf860=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10cbea38=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10cbdc10=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10cbcde8=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10cbbfc0=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10cbb198=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10cba370=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10cb9548=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10cb8720=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10cb78f8=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10cb6ad0=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10cb5ca8=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10cb4e80=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10cb4058=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10cb3230=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10cb2408=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10cb15e0=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10cb07b8=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10caf990=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10caeb68=vtg_malloc(3616)
03/01 03:00:11 INFO 4916-00 0x10cadd40=vtg_malloc(3616)
03/01 03:00:11 INFO 4900-00 Application initialized
03/01 03:00:12 INFO 3205-00 lang=5 prompt handles:vtp6,vtn=632,vte=291
03/01 03:00:12 INFO 3205-00 lang=12 prompt handles:vtp633,vtn=635,vte=634
03/01 03:00:13 INFO 4916-00 0x10b27778=vtg_malloc(51068)
03/01 03:00:13 INFO 4916-00 0x10ccd0d8=vtg_malloc(5250)
03/01 03:00:14 INFO 7077-00 fileio_open:pen([/vmail/d/vm/msg/msg0.vox],2,0)=-1,ctxt=[vtmsgcheck]
03/01 03:00:14 DEBUG 5300-00 vtmsgcheck=-2[msg0.vox,0]
03/01 03:00:14 DEBUG 5300-00 vtmsgcheck=0[msg9811.vox,0]
03/01 03:00:14 DEBUG 5300-00 msg=1[12,22,17,8,00000001]
03/01 03:00:14 DEBUG 5300-00 msg=2[12,22,17,14,00000001]
03/01 03:00:14 DEBUG 5300-00 vtmsgcheck=0[msg3334.vox,2]
03/01 03:00:14 INFO 7077-00 fileio_open:pen([/vmail/d/vm/msg/msg9866.vox],2,0)=-1,ctxt=[vtmsgcheck]
03/01 03:00:14 DEBUG 5300-00 vtmsgcheck=-2[msg9866.vox,0]
03/01 03:00:14 DEBUG 5300-00 vtmsgcheck=0[msg9899.vox,0]
03/01 03:00:14 DEBUG 5300-00 vtmsgcheck=0[msg9868.vox,0]
03/01 03:00:14 DEBUG 5300-00 vtmsgcheck=0[msg9855.vox,0]
03/01 03:00:14 DEBUG 5300-00 msg=1[12,27,10,32,00000001]
03/01 03:00:14 DEBUG 5300-00 msg=2[12,27,10,34,00000001]
03/01 03:00:14 DEBUG 5300-00 msg=3[12,31,18,0,00000001]
03/01 03:00:14 DEBUG 5300-00 vtmsgcheck=0[msg9862.vox,3]
03/01 03:00:14 DEBUG 5300-00 msg=1[2,17,14,21,00000001]
03/01 03:00:14 DEBUG 5300-00 vtmsgcheck=0[msg9800.vox,1]
03/01 03:00:14 DEBUG 5300-00 vtmsgcheck=0[msg9888.vox,0]
03/01 03:00:14 DEBUG 5300-00 vtmsgcheck=0[msg9898.vox,0]
03/01 03:00:14 DEBUG 5300-00 msg=1[12,27,10,34,00000001]
03/01 03:00:14 DEBUG 5300-00 vtmsgcheck=0[msg9863.vox,1]
03/01 03:00:14 DEBUG 5300-00 msg=1[2,22,19,40,00000001]
03/01 03:00:14 DEBUG 5300-00 vtmsgcheck=0[msg9812.vox,1]
03/01 03:00:14 INFO 7077-00 fileio_open:pen([/vmail/d/vm/msg/msg2548.vox],2,0)=-1,ctxt=[vtmsgcheck]
03/01 03:00:14 DEBUG 5300-00 vtmsgcheck=-2[msg2548.vox,0]
03/01 03:00:14 INFO 7077-00 fileio_open:pen([/vmail/d/vm/msg/msg3335.vox],2,0)=-1,ctxt=[vtmsgcheck]
03/01 03:00:14 DEBUG 5300-00 vtmsgcheck=-2[msg3335.vox,0]
03/01 03:00:14 DEBUG 5300-00 vtmsgcheck=0[msg9838.vox,0]
03/01 03:00:14 INFO 7077-00 fileio_open:pen([/vmail/d/vm/msg/msg9814.vox],2,0)=-1,ctxt=[vtmsgcheck]
03/01 03:00:14 DEBUG 5300-00 vtmsgcheck=-2[msg9814.vox,0]
03/01 03:00:14 INFO 7077-00 fileio_open:pen([/vmail/d/vm/msg/msg9999.vox],2,0)=-1,ctxt=[vtmsgcheck]
03/01 03:00:14 DEBUG 5300-00 vtmsgcheck=-2[msg9999.vox,0]
03/01 03:00:14 WARNING 1611-00 vtPageQFileInit: di=1
03/01 03:00:14 INFO 2403-01 VT_ON:0
03/01 03:00:14 WARNING 7526-33 0x12166cd0 CvvmServer:oCallback(0x0, 4, 2, 0x0) NULL session
03/01 03:00:14 INFO 2403-02 VT_ON:0
03/01 03:00:14 INFO 2403-03 VT_ON:0
03/01 03:00:14 INFO 2403-04 VT_ON:0
03/01 03:00:14 INFO 2403-05 VT_ON:0
03/01 03:00:14 INFO 2403-06 VT_ON:0
03/01 03:00:14 INFO 2403-07 VT_ON:0
03/01 03:00:14 INFO 7077-00 fileio_open:pen([/vmail/d/vm/msg/msg0.vox],2,0)=-1,ctxt=[x_compress]
03/01 03:00:14 ERROR 5308-00 x_compress(0,msg0.vox,15)=-1
03/01 03:00:14 INFO 2403-08 VT_ON:0
03/01 03:00:14 INFO 2403-09 VT_ON:0
03/01 03:00:14 INFO 2403-10 VT_ON:0
03/01 03:00:14 INFO 2403-11 VT_ON:0
03/01 03:00:14 INFO 2403-12 VT_ON:0
03/01 03:00:14 INFO 2403-13 VT_ON:0
03/01 03:00:15 INFO 2403-14 VT_ON:0
03/01 03:00:15 INFO 2403-15 VT_ON:0
03/01 03:00:15 INFO 2403-16 VT_ON:0
03/01 03:00:15 INFO 2403-15 VT_ON:0
03/01 03:00:18 INFO 8483-14 mwi: vb_dial[*909862]
03/01 03:00:22 INFO 8483-15 mwi: vb_dial[*909800]
03/01 03:00:26 INFO 8483-15 mwi: vb_dial[*909863]
03/01 03:00:30 INFO 8483-15 mwi: vb_dial[*909812]
03/01 03:00:45 INFO 7077-00 fileio_open:pen([/vmail/d/vm/msg/msg9866.vox],2,0)=-1,ctxt=[x_compress]
03/01 03:00:45 ERROR 5308-00 x_compress(9866,msg9866.vox,15)=-1
03/01 03:02:25 INFO 7077-00 fileio_open:pen([/vmail/d/vm/msg/msg2548.vox],2,0)=-1,ctxt=[x_compress]
03/01 03:02:25 ERROR 5308-00 x_compress(2548,msg2548.vox,15)=-1
03/01 03:02:35 INFO 7077-00 fileio_open:pen([/vmail/d/vm/msg/msg3335.vox],2,0)=-1,ctxt=[x_compress]
03/01 03:02:35 ERROR 5308-00 x_compress(3335,msg3335.vox,15)=-1
03/01 03:02:55 INFO 7077-00 fileio_open:pen([/vmail/d/vm/msg/msg9814.vox],2,0)=-1,ctxt=[x_compress]
03/01 03:02:55 ERROR 5308-00 x_compress(9814,msg9814.vox,15)=-1
03/01 05:05:07 INFO 7077-00 fileio_open:pen([/vmail/d/vm/msg/msg9999.vox],2,0)=-1,ctxt=[x_compress]
03/01 05:05:07 ERROR 5308-00 x_compress(9999,msg9999.vox,15)=-1
03/01 08:46:53 INFO 9050-03 mi_process_switch_packet: MiNet message with CLC value [1] is received
03/01 08:46:54 INFO 2403-04 VT_OFF:0
03/01 08:46:58 INFO 7013-04 Logged in to mailbox 9866
03/01 08:46:58 INFO 7077-04 fileio_open:pen([/vmail/d/vm/msg/msg9866.vox],2,0)=-1,ctxt=[vtmsgcheck]
03/01 08:46:58 DEBUG 5300-04 vtmsgcheck=-2[msg9866.vox,0]
03/01 08:46:58 INFO 5932-04 say_mbox_stats: f_handle=-1, totmsgs=0, nm=0, om=0, tt=-1, em = 0, ret=-2
03/01 08:46:58 INFO 1203-04 vta_s12: fh=-1, tm=0, mrc=0
03/01 08:46:59 INFO 8483-15 mwi: vb_dial[#909866]
03/01 08:47:03 INFO 2403-04 VT_ON:0
03/01 09:46:10 INFO 9050-00 mi_process_switch_packet: MiNet message with CLC

 

[max1017]

each morning the lamp is on but no message, i have to login to Voicemail then trun off the lamp.

03/01 08:46:59 INFO 8483-15 mwi: vb_dial[#909866]

What can i do for next step? Thank you.

 

[Supernova99]

Have you checked the SUPERSET Callback Message Cancel Timer
in the system options form
This should be set to blank i.e. no value

Share what you know - Learn what you don't

 

[kwbMitel]

I believe the message waiting is being reset at 3:00am by the voicemail.

I've heard of this before but I do not know the resolution.

I would suggest that you delete the voicemail and recreate it.

@supernova - the issue is the lamp is on. Cancel Message timer would turn it off.

**********************************************
What's most important is that you realise ... There is no spoon.

 

[Supernova99]

There is a Fcos value which refreshes the lamps when there are stored/saved messages I will try and find the setting and post back

Share what you know - Learn what you don't

 

[kwbMitel]

FCOS? on Embedded Mail?

**********************************************
What's most important is that you realise ... There is no spoon.

 

[max1017]

HI kwbMitel, i tried to delete and recreate the Mailbox, Nextday, still turn on in the morning.

I saw on mitel forum,it recommended logging into the system on port resetting voicemail ("iPVM_Stop" at the prompt, wait a couple of minutes, then "iPVM_Start").

but where can i type iPVM_Stop command?

Thank you.

 

[kwbMitel]

Maintenance Port - using serial teminal @ 9600 Baud.

BTW - Here Are some other instances of the same issue.

thread1329-1162837 (Dec 2005)

thread1329-1535143 (Mar 2009)

thread1329-1569547 (Sept 2009)

thread1329-1561685 (July 2009) Some good suggestions here regarding the possibility about Non-Prime Keys and hunt groups.
Other good suggestions too. Definitely worth reading



**********************************************
What's most important is that you realise ... There is no spoon.

 

[kwbMitel]

BTW - The TT search function sucks.

Use google and specify the site before the search terms.

e.g. site:tek-tips.com Mitel Message Waiting

**********************************************
What's most important is that you realise ... There is no spoon.

 

[fissure]

re: "Maintenance Port - using serial teminal @ 9600 Baud."

you can also use putty.exe (google for it) in raw mode, connecting to port 2002 of the Mitel (rather than a serial cable)

Step 1: Stop voicemail -> iPVM_Stop ( )
Step 2: Start voicemail -> iPVM_Start ( )