Utilizzo di Service Trace Viewer per la visualizzazione di tracce correlate e risoluzione dei problemi

Articolo
02/27/2011

In questo argomento viene illustrato il formato dei dati di traccia, come visualizzarlo e gli approcci che utilizzano Service Trace Viewer per risolvere i problemi dell'applicazione.

Utilizzo dello strumento Service Trace Viewer

Lo strumento Service Trace Viewer di Windows Communication Foundation (WCF) aiuta a correlare le tracce di diagnostica prodotte dai listener WCF per individuare la causa principale di un errore. Questo strumento consente di visualizzare, raggruppare e filtrare facilmente le tracce per diagnosticare, riparare e verificare i problemi dei servizi WCF. Per ulteriori informazioni sull'utilizzo di questo strumento, vedere Strumento Visualizzatore di tracce dei servizi (SvcTraceViewer.exe).

In questo argomento sono riportate le schermate relative alle tracce generate eseguendo l'esempio Traccia e registrazione dei messaggi, in caso di visualizzazione con lo strumento Strumento Visualizzatore di tracce dei servizi (SvcTraceViewer.exe). In questo argomento viene dimostrato come capire il contenuto della traccia, le attività e la loro correlazione e come analizzare moltissime tracce in caso di risoluzione dei problemi.

Visualizzazione del contenuto di una traccia

Un evento traccia contiene le seguenti informazioni più significative:

Nome dell'attività quando impostato.
Ora di emissione.
Livello di traccia.
Nome dell'origine di traccia.
Nome processo.
ID thread.
Un identificatore di traccia univoco, ovvero un URL che punta a una destinazione nella libreria MSDN in linea, dalla quale è possibile ottenere più informazioni relative alla traccia.

Tutte queste informazioni sono visualizzate nel riquadro in alto a destra in Service Trace Viewer o nella sezione Informazioni di base nella visualizzazione formattata del riquadro in basso a destra, quando viene selezionata una traccia.

Nota:
Se il client e il servizio si trovano nello stesso computer, saranno presenti le tracce per entrambe le applicazioni. Tali tracce possono essere filtrate tramite la colonna Nome processo.

La visualizzazione formattata fornisce inoltre anche una descrizione per la traccia e ulteriori informazioni dettagliate quando disponibili. Le informazioni possono includere il tipo di eccezione e il messaggio, gli stack di chiamate, l'azione del messaggio, i campi da/a e altre informazioni sull'eccezione.

Nella visualizzazione XML, i tag xml utili includono gli elementi seguenti:

<SubType> (livello di traccia).
<TimeCreated>.
<Source> (nome dell'origine di traccia).
<Correlation> (ID attività impostato quando viene emessa la traccia).
<Execution> (processo e ID thread).
<Computer>.
<ExtendedData>, inclusi <Action>, <MessageID> e <ActivityId> impostati nell'intestazione del messaggio al momento di inviare un messaggio.

Se si esamina la traccia "Messaggio inviato tramite canale", è possibile vedere il contenuto seguente.

<E2ETraceEvent xmlns="https://schemas.microsoft.com/2004/06/E2ETraceEvent">
   <System xmlns="https://schemas.microsoft.com/2004/06/windows/eventlog/system">
      <EventID>262163</EventID>
      <Type>3</Type>
      <SubType Name="Information">0</SubType>
      <Level>8</Level>
      <TimeCreated SystemTime="2006-08-04T18:45:30.8491051Z" />
      <Source Name="System.ServiceModel" />
       <Correlation ActivityID="{27c6331d-8998-43aa-a382-03239013a6bd}"/>
       <Execution ProcessName="client" ProcessID="1808" ThreadID="1" />
       <Channel />
       <Computer>TEST1</Computer>
   </System>
   <ApplicationData>
       <TraceData>
          <DataItem>
             <TraceRecord xmlns="https://schemas.microsoft.com/2004/10/E2ETraceEvent/TraceRecord" Severity="Information">
                 <TraceIdentifier>https://msdn.microsoft.com/en-US/library/System.ServiceModel.Channels.MessageSent.aspx</TraceIdentifier>
                 <Description>Sent a message over a channel.</Description>
                 <AppDomain>client.exe</AppDomain>
                 <Source>System.ServiceModel.Channels.ClientFramingDuplexSessionChannel/35191196</Source>
                <ExtendedData xmlns="https://schemas.microsoft.com/2006/08/ServiceModel/MessageTransmitTraceRecord">

                  <MessageProperties>
                     <AllowOutputBatching>False</AllowOutputBatching>
                  </MessageProperties>
                  <MessageHeaders>
                     <Action d4p1:mustUnderstand="1" xmlns:d4p1="http://www.w3.org/2003/05/soap-envelope" xmlns="http://www.w3.org/2005/08/addressing">http://Microsoft.ServiceModel.Samples/ICalculator/Multiply</Action>
                     <MessageID xmlns="http://www.w3.org/2005/08/addressing">urn:uuid:7c6670d8-4c9c-496e-b6a0-2ceb6db35338</MessageID>
                     <ActivityId CorrelationId="b02e2189-0816-4387-980c-dd8e306440f5" xmlns="https://schemas.microsoft.com/2004/09/ServiceModel/Diagnostics">27c6331d-8998-43aa-a382-03239013a6bd</ActivityId>
                     <ReplyTo xmlns="http://www.w3.org/2005/08/addressing">
                        <Address>http://www.w3.org/2005/08/addressing/anonymous</Address>
                    </ReplyTo>
                    <To d4p1:mustUnderstand="1" xmlns:d4p1="http://www.w3.org/2003/05/soap-envelope" xmlns="http://www.w3.org/2005/08/addressing">net.tcp://localhost/servicemodelsamples/service</To>
                  </MessageHeaders>
                  <RemoteAddress>net.tcp://localhost/servicemodelsamples/service</RemoteAddress>
                </ExtendedData>
            </TraceRecord>
          </DataItem>
       </TraceData>
   </ApplicationData>
</E2ETraceEvent>

Traccia E2E ServiceModel

Quando l'origine di traccia System.ServiceModel è impostata con un switchValue diverso da Off e ActivityTracing, WCF crea attività e trasferimenti per l'elaborazione WCF.

Un'attività è un'unità logica di elaborazione che raggruppa tutte le tracce relative a quell'unità di elaborazione. È possibile definire, ad esempio, un'attività per ogni richiesta. I trasferimenti creano una relazione causale tra le attività all'interno di endpoint. La propagazione dell'ID attività consente di correlare le attività attraverso gli endpoint. A tale fine, impostare propagateActivity=true nella configurazione su ogni endpoint. Attività, trasferimenti e propagazione consentono di eseguire la correlazione degli errori. In questo modo è possibile individuare più rapidamente la causa fondamentale di un errore.

Nel client viene creata un'attività WCF per ogni chiamata al modello oggetto (ad esempio apertura di ChannelFactory, addizione, divisione e così via). Ogni chiamata dell'operazione viene elaborata in un'attività "Elaborazione azione".

Nella schermata seguente, tratta dall'esempio Traccia e registrazione dei messaggi, nel riquadro di sinistra è visualizzato l'elenco delle attività create nel processo client, ordinate in base all'ora di creazione. Di seguito è riportato un elenco cronologico delle attività:

È stata costruita la channel factory (ClientBase).
È stata aperta la channel factory.
È stata elaborata l'azione di addizione.
È stata impostata la sessione di sicurezza (questo si è VERIFICATO alla prima richiesta) e sono stati elaborati tre messaggi di risposta dell'infrastruttura di sicurezza: RST, RSTR, SCT (elaborazione messaggio 1, 2, 3).
Sono state elaborate le richieste di sottrazione, moltiplicazione e divisione.
È stata chiusa la channel factory e, così facendo, è stata chiusa la sessione di sicurezza ed è stata elaborata la risposta del messaggio di sicurezza di annullamento.

La visualizzazione dei messaggi dell'infrastruttura di sicurezza è resa possibile da wsHttpBinding.

Nota:
In WCF, i messaggi di risposta elaborati inizialmente vengono riportati in un'attività separata (elaborazione messaggio), quindi vengono correlati all'attività Elaborazione azione corrispondente che include il messaggio di richiesta, tramite un trasferimento. Ciò vale per i messaggi dell'infrastruttura e le richieste asincrone ed è dovuto al fatto che è necessario ispezionare il messaggio, leggere l'intestazione activityId e identificare l'attività Elaborazione azione esistente con quell'ID per correlarla ad esso. Per le richieste sincrone, viene bloccata la risposta e pertanto viene riconosciuta a quale Elaborazione azione è correlata la risposta.

In WCF, i messaggi di risposta elaborati inizialmente vengono riportati in un'attività separata (elaborazione messaggio), quindi vengono correlati all'attività Elaborazione azione corrispondente che include il messaggio di richiesta, tramite un trasferimento. Ciò vale per i messaggi dell'infrastruttura e le richieste asincrone ed è dovuto al fatto che è necessario ispezionare il messaggio, leggere l'intestazione activityId e identificare l'attività Elaborazione azione esistente con quell'ID per correlarla ad esso. Per le richieste sincrone, viene bloccata la risposta e pertanto viene riconosciuta a quale Elaborazione azione è correlata la risposta.