Trace Logs

This article explains how trace log generation works, what the trace logs look like when opened in Microsoft Excel (though you can open them in basically any spreadsheet or database program), and what the different headers in the files mean.

Whenever you start a test run with any tracer active, Ranorex Studio creates four timestamped CSV log files in the configured output folder (default: %MyDocuments%RanorexTraceLogs):

1. The log for all Input tracers
2. The log for the Misc tracer
3. The log for the All tracer
4. The log for the Repository tracer

During the test run, Ranorex Studio does the following:

• It checks which tracer is active and fills its log with the relevant data.
• It also enters this data into the log for the All tracer in a more concise format.

For example, if the Repository tracer is active, Ranorex Studio fills the Repository log and the All log with data. The other logs remain empty.

When you start a new test run with a tracer active, this process is repeated with new timestamped logs.

Excel delimiter troubleshooting

Normally, you shouldn’t need to do anything for the logs to display correctly in a spreadsheet or database program. In some cases, however, you may need to import them manually and/or set the delimiter.

Symptom: All values appear in column A (Excel didn’t split the CSV by commas).

To fix it in Excel:

1. Select the entire column A.

2. Go to Data > Text to Columns.

3. Select Delimited > Next, check Comma, and click Finish.

The logs are created as CSV files with a header section. The headers specify what information was collected. The different logs have different headers, but they also share some. Below, you’ll find an explanation of the headers in each log.

There are three headers that you’ll find in all logs:

• TimeStamp: The time an event (search for a repository item, action execution, etc.) started.
• Module: The module the event occurred in.
• TotalTime: The total time an event took in milliseconds.

1. RepoItem: Full name of the searched repository item.
2. RepoItemId: ID of the searched repository item.
3. RepoItemPath: Full RanoreXPath of the searched repository item.
4. EffectiveTimeout: Effective timeout in ms, as set in the properties of the repository item.
5. TimesSearched: How often Ranorex Studio attempt to find the repository item within the defined effective timeout.
6. LastSearchTime: How long the last successful search take in milliseconds.
7. Found: Whether the item was found (TRUE) or not (FALSE).

1. RepoItem: Full name of the searched repository item.
2. RepoItemId: ID of the searched repository item.
3. Device: Whether the action is a mouse or a keyboard action.
4. InputType: The specific type of mouse or keyboard input. This can be for mouse: click, move; or for keyboard: sequence, press (Key shortcut press action in the recording module)
   Other mouse/keyboard actions are practically instantaneous and therefore not collected.
5. RepeatCount: How often the action was performed.
6. NominalDuration: Nominal duration is set in the properties of the action.

1. EventType: The type of event that occurred. This can be:
   - fixed-delay: A delay action.
   - datasource-load: Ranorex Studio loads a data source, e.g. an Excel file.
   - proc-start: A Run application action.
   - wait-proc-close: A Close application action.
   - screenshot-trace: Tracing screenshots (Foreground/Background corresponds to the setting in the Report tab in the test suite properties).
   - report-slow: Various reporting events that take longer than 10 ms.
   - report-test-text-slow and report-test-data-slow: Ranorex Studio is busy creating the report and performance tracing is on hold.
   - other: Events not native to Ranorex Studio, e.g. user code actions.
2. Details: More information relating to the EventType.

1. TestContainer: The test container in which the event occurred.
2. EventType: The type of event that occurred. This can be:
   - fixed-delay: A delay action.
   - datasource-load: Ranorex Studio loads a data source, for example, an Excel file.
   - proc-start: A Run application action.
   - wait-proc-close: A Close application action.
   - screenshot-trace: Tracing screenshots (Foreground/Background corresponds to the setting in the Report tab in the test suite properties).
   - report-slow: Various reporting events that take longer than 10 ms.
   - report-test-text-slow and report-test-data-slow: Ranorex Studio is busy creating the report, and performance tracing is on hold.
   - other: Events not native to Ranorex Studio, e.g., user code actions.
3. Details: More information relating to the EventType.