Annotated logs for grammar updates.

Turn on the micro trace VUI : Info

Look in diag_cuvrt_X.log files.

07/28/2008 14:19:47.517 |24455,,,VUI,3,Parsed 0 database events; found 0 relevant events to process. (Src/DbEventHelper.cpp:233)|

07/28/2008 14:20:47.635 |24455,,,VUI,3,Parsed 0 database events; found 0 relevant events to process. (Src/DbEventHelper.cpp:233)|

07/28/2008 14:21:47.751 |24455,,,VUI,3,Parsed 0 database events; found 0 relevant events to process. (Src/DbEventHelper.cpp:233)|

These messages tell us how many events we processed and need to handle. You should see a message like this every minute.

07/28/2008 14:36:49.578 |24455,,,VUI,3,Parsed 3 database events; found 3 relevant events to process. (Src/DbEventHelper.cpp:233)|

When changes are picked up, you'll see non-zero values for the counts.

07/28/2008 14:36:49.590 |24455,,,VUI,3,Schedule Detail List Size: 1, Current Day of Week: 1 (Src/ScheduleHelper.cpp:104)|

07/28/2008 14:36:49.590 |24455,,,VUI,3,Evaluating Current Schedule Detail: (Src/ScheduleHelper.cpp:109)|

07/28/2008 14:36:49.590 |24455,,,VUI,3,CurrentTime: 876, Scheduled End Time: -1 (Src/ScheduleHelper.cpp:148)|

07/28/2008 14:36:49.590 |24455,,,VUI,3,CurrentTime: 876, Scheduled Start Time: -1 (Src/ScheduleHelper.cpp:160)|

07/28/2008 14:36:49.590 |24455,,,VUI,3,The current schedule is active for name grammar creation (Src/ScheduleHelper.cpp:171)|

The "Voice Recognition Update Schedule" is first checked to make sure we're allowed to make grammar changes right now. In this case, the last line above notes that the schedule is active right now.

07/28/2008 14:36:49.590 |24455,,,VUI,3,Starting grammar creation for pending changes. (Src/Controller.cpp:111)|

07/28/2008 14:36:49.601 |24455,,,VUI,3,Begin creating grammar: Directory (Src/GrammarHelper.cpp:218)|

07/28/2008 14:36:49.635 |24455,,,VUI,3,Finished creating grammar: Directory (Src/GrammarHelper.cpp:246)|

07/28/2008 14:36:49.659 |24455,,,VUI,3,Begin creating grammar: UserCity (Src/GrammarHelper.cpp:218)|

07/28/2008 14:36:49.676 |24455,,,VUI,3,Finished creating grammar: UserCity (Src/GrammarHelper.cpp:246)|

07/28/2008 14:36:49.702 |24455,,,VUI,3,Begin creating grammar: UserDepartment (Src/GrammarHelper.cpp:218)|

07/28/2008 14:36:49.718 |24455,,,VUI,3,Finished creating grammar: UserDepartment (Src/GrammarHelper.cpp:246)|

The relevant grammars are updated. Note that we log when each grammar begins and ends its update. You can see how long each grammar takes to build by looking at these timestamps.

07/28/2008 14:38:50.620 |24455,,,VUI,3,Parsed 2 database events; found 2 relevant events to process. (Src/DbEventHelper.cpp:233)|

07/28/2008 14:38:50.627 |24455,,,VUI,3,Schedule Detail List Size: 1, Current Day of Week: 1 (Src/ScheduleHelper.cpp:104)|

07/28/2008 14:38:50.627 |24455,,,VUI,3,Evaluating Current Schedule Detail: (Src/ScheduleHelper.cpp:109)|

07/28/2008 14:38:50.627 |24455,,,VUI,3,The current schedule is inactive for name grammar creation (Src/ScheduleHelper.cpp:179)|

07/28/2008 14:38:50.627 |24455,,,VUI,3,Postponing grammar creation because the current time is excluded in the current schedule: Voice Recognition Update Schedule (Src/Controller.cpp:103)|

In this case, note that the "Voice Recognition Update Schedule" doesn't allow updates right now.

07/28/2008 14:39:50.742 |24455,,,VUI,3,A manual grammar recompilation event was signalled. (Src/DbEventHelper.cpp:181)|

If you "force" a re-compile through the CLI or SA Grammar Statistics page, you'll see the above line.

07/28/2008 14:39:50.742 |24455,,,VUI,3,Parsed 1 database events; found 1 relevant events to process. (Src/DbEventHelper.cpp:233)|

07/28/2008 14:39:50.742 |24455,,,VUI,3,Starting grammar creation for pending changes. (Src/Controller.cpp:111)|

07/28/2008 14:39:50.752 |24455,,,VUI,3,Begin creating grammar: Directory (Src/GrammarHelper.cpp:218)|

07/28/2008 14:39:50.787 |24455,,,VUI,3,Finished creating grammar: Directory (Src/GrammarHelper.cpp:246)|

07/28/2008 14:39:50.814 |24455,,,VUI,3,Begin creating grammar: UserCity (Src/GrammarHelper.cpp:218)|

07/28/2008 14:39:50.829 |24455,,,VUI,3,Finished creating grammar: UserCity (Src/GrammarHelper.cpp:246)|

07/28/2008 14:39:50.857 |24455,,,VUI,3,Begin creating grammar: UserDepartment (Src/GrammarHelper.cpp:218)|

07/28/2008 14:39:50.873 |24455,,,VUI,3,Finished creating grammar: UserDepartment (Src/GrammarHelper.cpp:246)|

07/28/2008 14:40:51.345 |24455,,,VUI,3,Parsed 0 database events; found 0 relevant events to process. (Src/DbEventHelper.cpp:233)|

07/28/2008 14:41:51.469 |24455,,,VUI,3,Parsed 0 database events; found 0 relevant events to process. (Src/DbEventHelper.cpp:233)|

07/28/2008 14:42:51.596 |24455,,,VUI,3,Parsed 0 database events; found 0 relevant events to process. (Src/DbEventHelper.cpp:233)|

07/28/2008 14:43:51.709 |24455,,,VUI,3,Parsed 0 database events; found 0 relevant events to process. (Src/DbEventHelper.cpp:233)|

07/28/2008 14:44:51.825 |24455,,,VUI,3,Parsed 0 database events; found 0 relevant events to process. (Src/DbEventHelper.cpp:233)|

07/28/2008 14:45:51.944 |24455,,,VUI,3,Picked up request to pause grammar creation. (Src/DbEventHelper.cpp:221)|

Clients that perform bulk operations may request that we temporarily suspend grammar updates. We'll wait ten minutes from the last request. Clients may periodically send these requests while they perform operations. Look for the last request that we processed.

07/28/2008 14:45:52.023 |24455,,,VUI,3,Parsed 3 database events; found 3 relevant events to process. (Src/DbEventHelper.cpp:233)|

07/28/2008 14:45:52.023 |24455,,,VUI,3,Postponing grammar creation because a client requested a pause period. (Src/Controller.cpp:99)|

We'll note in the log that we're postponing grammar updates due to a client requesting a pause.

07/28/2008 14:46:52.139 |24455,,,VUI,3,Parsed 0 database events; found 0 relevant events to process. (Src/DbEventHelper.cpp:233)|

07/28/2008 14:46:52.139 |24455,,,VUI,3,Postponing grammar creation because a client requested a pause period. (Src/Controller.cpp:99)|

07/28/2008 14:47:52.253 |24455,,,VUI,3,Parsed 0 database events; found 0 relevant events to process. (Src/DbEventHelper.cpp:233)|

07/28/2008 14:47:52.253 |24455,,,VUI,3,Postponing grammar creation because a client requested a pause period. (Src/Controller.cpp:99)|

07/28/2008 14:48:52.367 |24455,,,VUI,3,Parsed 0 database events; found 0 relevant events to process. (Src/DbEventHelper.cpp:233)|

07/28/2008 14:48:52.368 |24455,,,VUI,3,Postponing grammar creation because a client requested a pause period. (Src/Controller.cpp:99)|

07/28/2008 14:49:52.483 |24455,,,VUI,3,Parsed 0 database events; found 0 relevant events to process. (Src/DbEventHelper.cpp:233)|

07/28/2008 14:49:52.483 |24455,,,VUI,3,Postponing grammar creation because a client requested a pause period. (Src/Controller.cpp:99)|

07/28/2008 14:50:52.596 |24455,,,VUI,3,Parsed 0 database events; found 0 relevant events to process. (Src/DbEventHelper.cpp:233)|

07/28/2008 14:50:52.596 |24455,,,VUI,3,Postponing grammar creation because a client requested a pause period. (Src/Controller.cpp:99)|

07/28/2008 14:51:52.715 |24455,,,VUI,3,Parsed 0 database events; found 0 relevant events to process. (Src/DbEventHelper.cpp:233)|

07/28/2008 14:51:52.715 |24455,,,VUI,3,Postponing grammar creation because a client requested a pause period. (Src/Controller.cpp:99)|

07/28/2008 14:52:52.864 |24455,,,VUI,3,Parsed 0 database events; found 0 relevant events to process. (Src/DbEventHelper.cpp:233)|

07/28/2008 14:52:52.864 |24455,,,VUI,3,Postponing grammar creation because a client requested a pause period. (Src/Controller.cpp:99)|

07/28/2008 14:53:52.984 |24455,,,VUI,3,Parsed 0 database events; found 0 relevant events to process. (Src/DbEventHelper.cpp:233)|

07/28/2008 14:53:52.984 |24455,,,VUI,3,Postponing grammar creation because a client requested a pause period. (Src/Controller.cpp:99)|

07/28/2008 14:54:53.101 |24455,,,VUI,3,Parsed 0 database events; found 0 relevant events to process. (Src/DbEventHelper.cpp:233)|

07/28/2008 14:54:53.101 |24455,,,VUI,3,Postponing grammar creation because a client requested a pause period. (Src/Controller.cpp:99)|

07/28/2008 14:55:53.215 |24455,,,VUI,3,Parsed 0 database events; found 0 relevant events to process. (Src/DbEventHelper.cpp:233)|

It's been ten minutes since the last request to pause grammar updates. Now we'll check the schedule and make sure we can update the grammars.

07/28/2008 14:55:53.223 |24455,,,VUI,3,Schedule Detail List Size: 1, Current Day of Week: 1 (Src/ScheduleHelper.cpp:104)|

07/28/2008 14:55:53.223 |24455,,,VUI,3,Evaluating Current Schedule Detail: (Src/ScheduleHelper.cpp:109)|

07/28/2008 14:55:53.223 |24455,,,VUI,3,CurrentTime: 895, Scheduled End Time: -1 (Src/ScheduleHelper.cpp:148)|

07/28/2008 14:55:53.223 |24455,,,VUI,3,CurrentTime: 895, Scheduled Start Time: 0 (Src/ScheduleHelper.cpp:160)|

07/28/2008 14:55:53.223 |24455,,,VUI,3,The current schedule is active for name grammar creation (Src/ScheduleHelper.cpp:171)|

07/28/2008 14:55:53.223 |24455,,,VUI,3,Starting grammar creation for pending changes. (Src/Controller.cpp:111)|

07/28/2008 14:55:53.233 |24455,,,VUI,3,Begin creating grammar: Directory (Src/GrammarHelper.cpp:218)|

07/28/2008 14:55:53.310 |24455,,,VUI,3,Finished creating grammar: Directory (Src/GrammarHelper.cpp:246)|

07/28/2008 14:55:53.351 |24455,,,VUI,3,Begin creating grammar: UserCity (Src/GrammarHelper.cpp:218)|

07/28/2008 14:55:53.365 |24455,,,VUI,3,Finished creating grammar: UserCity (Src/GrammarHelper.cpp:246)|

07/28/2008 14:55:53.389 |24455,,,VUI,3,Begin creating grammar: UserDepartment (Src/GrammarHelper.cpp:218)|

07/28/2008 14:55:53.404 |24455,,,VUI,3,Finished creating grammar: UserDepartment (Src/GrammarHelper.cpp:246)|

07/28/2008 14:56:53.869 |24455,,,VUI,3,Parsed 0 database events; found 0 relevant events to process. (Src/DbEventHelper.cpp:233)|