You've already forked UnrealEngineUWP
mirror of
https://github.com/izzy2lost/UnrealEngineUWP.git
synced 2026-03-26 18:15:20 -07:00
777 lines
28 KiB
C++
777 lines
28 KiB
C++
// Copyright Epic Games, Inc. All Rights Reserved.
|
|
|
|
#if WITH_STATETREE_TRACE
|
|
|
|
#include "Debugger/StateTreeTrace.h"
|
|
#include "Debugger/StateTreeTraceTypes.h"
|
|
#include "Exporters/Exporter.h"
|
|
#include "ObjectTrace.h"
|
|
#include "Serialization/BufferArchive.h"
|
|
#include "StateTree.h"
|
|
#include "StateTreeDelegates.h"
|
|
#include "StateTreeExecutionTypes.h"
|
|
#include "UObject/Package.h"
|
|
#include "Trace/Trace.inl"
|
|
|
|
#if WITH_EDITOR
|
|
#include "Editor.h"
|
|
#endif // WITH_EDITOR
|
|
|
|
UE_TRACE_CHANNEL_DEFINE(StateTreeDebugChannel)
|
|
|
|
UE_TRACE_EVENT_BEGIN(StateTreeDebugger, WorldTimestampEvent)
|
|
UE_TRACE_EVENT_FIELD(double, WorldTime)
|
|
UE_TRACE_EVENT_END()
|
|
|
|
UE_TRACE_EVENT_BEGIN(StateTreeDebugger, AssetDebugIdEvent)
|
|
UE_TRACE_EVENT_FIELD(uint64, Cycle)
|
|
UE_TRACE_EVENT_FIELD(UE::Trace::WideString, TreeName)
|
|
UE_TRACE_EVENT_FIELD(UE::Trace::WideString, TreePath)
|
|
UE_TRACE_EVENT_FIELD(uint32, CompiledDataHash)
|
|
UE_TRACE_EVENT_FIELD(uint16, AssetDebugId)
|
|
UE_TRACE_EVENT_END()
|
|
|
|
UE_TRACE_EVENT_BEGIN(StateTreeDebugger, InstanceEvent)
|
|
UE_TRACE_EVENT_FIELD(uint64, Cycle)
|
|
UE_TRACE_EVENT_FIELD(uint32, InstanceId)
|
|
UE_TRACE_EVENT_FIELD(uint32, InstanceSerial)
|
|
UE_TRACE_EVENT_FIELD(UE::Trace::WideString, InstanceName)
|
|
UE_TRACE_EVENT_FIELD(std::underlying_type_t<EStateTreeTraceEventType>, EventType)
|
|
UE_TRACE_EVENT_FIELD(uint16, AssetDebugId)
|
|
UE_TRACE_EVENT_END()
|
|
|
|
UE_TRACE_EVENT_BEGIN(StateTreeDebugger, InstanceFrameEvent)
|
|
UE_TRACE_EVENT_FIELD(uint64, Cycle)
|
|
UE_TRACE_EVENT_FIELD(uint32, InstanceId)
|
|
UE_TRACE_EVENT_FIELD(uint32, InstanceSerial)
|
|
UE_TRACE_EVENT_FIELD(uint16, AssetDebugId)
|
|
UE_TRACE_EVENT_END()
|
|
|
|
UE_TRACE_EVENT_BEGIN(StateTreeDebugger, PhaseEvent)
|
|
UE_TRACE_EVENT_FIELD(uint64, Cycle)
|
|
UE_TRACE_EVENT_FIELD(uint32, InstanceId)
|
|
UE_TRACE_EVENT_FIELD(uint32, InstanceSerial)
|
|
UE_TRACE_EVENT_FIELD(std::underlying_type_t<EStateTreeUpdatePhase>, Phase)
|
|
UE_TRACE_EVENT_FIELD(uint16, StateIndex)
|
|
UE_TRACE_EVENT_FIELD(std::underlying_type_t<EStateTreeTraceEventType>, EventType)
|
|
UE_TRACE_EVENT_END()
|
|
|
|
UE_TRACE_EVENT_BEGIN(StateTreeDebugger, LogEvent)
|
|
UE_TRACE_EVENT_FIELD(uint64, Cycle)
|
|
UE_TRACE_EVENT_FIELD(uint32, InstanceId)
|
|
UE_TRACE_EVENT_FIELD(uint32, InstanceSerial)
|
|
UE_TRACE_EVENT_FIELD(std::underlying_type_t<ELogVerbosity::Type>, Verbosity)
|
|
UE_TRACE_EVENT_FIELD(UE::Trace::WideString, Message)
|
|
UE_TRACE_EVENT_END()
|
|
|
|
UE_TRACE_EVENT_BEGIN(StateTreeDebugger, StateEvent)
|
|
UE_TRACE_EVENT_FIELD(uint64, Cycle)
|
|
UE_TRACE_EVENT_FIELD(uint32, InstanceId)
|
|
UE_TRACE_EVENT_FIELD(uint32, InstanceSerial)
|
|
UE_TRACE_EVENT_FIELD(uint16, StateIndex)
|
|
UE_TRACE_EVENT_FIELD(std::underlying_type_t<EStateTreeTraceEventType>, EventType)
|
|
UE_TRACE_EVENT_END()
|
|
|
|
UE_TRACE_EVENT_BEGIN(StateTreeDebugger, TaskEvent)
|
|
UE_TRACE_EVENT_FIELD(uint64, Cycle)
|
|
UE_TRACE_EVENT_FIELD(uint32, InstanceId)
|
|
UE_TRACE_EVENT_FIELD(uint32, InstanceSerial)
|
|
UE_TRACE_EVENT_FIELD(uint16, NodeIndex)
|
|
UE_TRACE_EVENT_FIELD(uint8[], DataView)
|
|
UE_TRACE_EVENT_FIELD(std::underlying_type_t<EStateTreeTraceEventType>, EventType)
|
|
UE_TRACE_EVENT_FIELD(uint8, Status)
|
|
UE_TRACE_EVENT_END()
|
|
|
|
UE_TRACE_EVENT_BEGIN(StateTreeDebugger, EvaluatorEvent)
|
|
UE_TRACE_EVENT_FIELD(uint64, Cycle)
|
|
UE_TRACE_EVENT_FIELD(uint32, InstanceId)
|
|
UE_TRACE_EVENT_FIELD(uint32, InstanceSerial)
|
|
UE_TRACE_EVENT_FIELD(uint16, NodeIndex)
|
|
UE_TRACE_EVENT_FIELD(uint8[], DataView)
|
|
UE_TRACE_EVENT_FIELD(std::underlying_type_t<EStateTreeTraceEventType>, EventType)
|
|
UE_TRACE_EVENT_END()
|
|
|
|
UE_TRACE_EVENT_BEGIN(StateTreeDebugger, TransitionEvent)
|
|
UE_TRACE_EVENT_FIELD(uint64, Cycle)
|
|
UE_TRACE_EVENT_FIELD(uint32, InstanceId)
|
|
UE_TRACE_EVENT_FIELD(uint32, InstanceSerial)
|
|
UE_TRACE_EVENT_FIELD(uint8, SourceType)
|
|
UE_TRACE_EVENT_FIELD(uint16, TransitionIndex)
|
|
UE_TRACE_EVENT_FIELD(uint16, TargetStateIndex)
|
|
UE_TRACE_EVENT_FIELD(uint8, Priority)
|
|
UE_TRACE_EVENT_FIELD(std::underlying_type_t<EStateTreeTraceEventType>, EventType)
|
|
UE_TRACE_EVENT_END()
|
|
|
|
UE_TRACE_EVENT_BEGIN(StateTreeDebugger, ConditionEvent)
|
|
UE_TRACE_EVENT_FIELD(uint64, Cycle)
|
|
UE_TRACE_EVENT_FIELD(uint32, InstanceId)
|
|
UE_TRACE_EVENT_FIELD(uint32, InstanceSerial)
|
|
UE_TRACE_EVENT_FIELD(uint16, NodeIndex)
|
|
UE_TRACE_EVENT_FIELD(uint8[], DataView)
|
|
UE_TRACE_EVENT_FIELD(std::underlying_type_t<EStateTreeTraceEventType>, EventType)
|
|
UE_TRACE_EVENT_END()
|
|
|
|
UE_TRACE_EVENT_BEGIN(StateTreeDebugger, ActiveStatesEvent)
|
|
UE_TRACE_EVENT_FIELD(uint64, Cycle)
|
|
UE_TRACE_EVENT_FIELD(uint32, InstanceId)
|
|
UE_TRACE_EVENT_FIELD(uint32, InstanceSerial)
|
|
UE_TRACE_EVENT_FIELD(uint16[], ActiveStates)
|
|
UE_TRACE_EVENT_FIELD(uint16[], AssetDebugIds)
|
|
UE_TRACE_EVENT_END()
|
|
|
|
namespace UE::StateTreeTrace
|
|
{
|
|
|
|
FDelegateHandle GOnWorldTickStartDelegateHandle;
|
|
FDelegateHandle GTracingStateChangedDelegateHandle;
|
|
|
|
/** Struct to keep track if a given phase was traced or not. */
|
|
struct FPhaseTraceStatusPair
|
|
{
|
|
explicit FPhaseTraceStatusPair(const EStateTreeUpdatePhase Phase, const FStateTreeStateHandle StateHandle)
|
|
: Phase(Phase)
|
|
, StateHandle(StateHandle)
|
|
{
|
|
}
|
|
|
|
EStateTreeUpdatePhase Phase = EStateTreeUpdatePhase::Unset;
|
|
FStateTreeStateHandle StateHandle = FStateTreeStateHandle::Invalid;
|
|
bool bTraced = false;
|
|
};
|
|
|
|
/** Struct to keep track of the list of stacked phases for a given statetree instance. */
|
|
struct FPhaseStack
|
|
{
|
|
FStateTreeInstanceDebugId InstanceId;
|
|
TArray<FPhaseTraceStatusPair> Stack;
|
|
};
|
|
|
|
/**
|
|
* Struct to hold data for asset debug id events until we are ready to trace the events (i.e. traces are active and channel is enabled).
|
|
*/
|
|
struct FAssetDebugIdEventBufferedData
|
|
{
|
|
FAssetDebugIdEventBufferedData() = default;
|
|
explicit FAssetDebugIdEventBufferedData(const UStateTree* StateTree, const FStateTreeIndex16 AssetDebugId) : WeakStateTree(StateTree), AssetDebugId(AssetDebugId)
|
|
{
|
|
}
|
|
|
|
void Trace() const
|
|
{
|
|
if (ensureMsgf(UE_TRACE_CHANNELEXPR_IS_ENABLED(StateTreeDebugChannel), TEXT("Tracing a buffered data is expected only if channel is enabled.")))
|
|
{
|
|
if (const UStateTree* StateTree = WeakStateTree.Get())
|
|
{
|
|
OutputAssetDebugIdEvent(StateTree, AssetDebugId);
|
|
}
|
|
}
|
|
}
|
|
|
|
TWeakObjectPtr<const UStateTree> WeakStateTree;
|
|
FStateTreeIndex16 AssetDebugId;
|
|
};
|
|
|
|
/**
|
|
* Struct to hold data for active states events until we are ready to trace the events (i.e. traces are active and channel is enabled).
|
|
*/
|
|
struct FInstanceEventBufferedData
|
|
{
|
|
struct FActiveStates
|
|
{
|
|
FActiveStates() = default;
|
|
explicit FActiveStates(const TConstArrayView<FStateTreeExecutionFrame> ActiveFrames)
|
|
{
|
|
for (const FStateTreeExecutionFrame& Frame : ActiveFrames)
|
|
{
|
|
const FStateTreeIndex16 AssetDebugId = FindOrAddDebugIdForAsset(Frame.StateTree.Get());
|
|
|
|
const int32 RequiredSize = StatesIndices.Num() + Frame.ActiveStates.Num();
|
|
StatesIndices.Reserve(RequiredSize);
|
|
AssetDebugIds.Reserve(RequiredSize);
|
|
|
|
for (const FStateTreeStateHandle StateHandle : Frame.ActiveStates)
|
|
{
|
|
StatesIndices.Add(StateHandle.Index);
|
|
AssetDebugIds.Add(AssetDebugId.Get());
|
|
}
|
|
}
|
|
}
|
|
|
|
bool IsValid() const { return StatesIndices.Num() > 0 && StatesIndices.Num() == AssetDebugIds.Num(); }
|
|
void Output(const FStateTreeInstanceDebugId InInstanceId) const
|
|
{
|
|
UE_TRACE_LOG(StateTreeDebugger, ActiveStatesEvent, StateTreeDebugChannel)
|
|
<< ActiveStatesEvent.Cycle(FPlatformTime::Cycles64())
|
|
<< ActiveStatesEvent.InstanceId(InInstanceId.Id)
|
|
<< ActiveStatesEvent.InstanceSerial(InInstanceId.SerialNumber)
|
|
<< ActiveStatesEvent.ActiveStates(StatesIndices.GetData(), StatesIndices.Num())
|
|
<< ActiveStatesEvent.AssetDebugIds(AssetDebugIds.GetData(), AssetDebugIds.Num());
|
|
}
|
|
|
|
TArray<uint16> StatesIndices;
|
|
TArray<uint16> AssetDebugIds;
|
|
};
|
|
|
|
FInstanceEventBufferedData() = default;
|
|
explicit FInstanceEventBufferedData(
|
|
const UStateTree* StateTree,
|
|
const FStateTreeInstanceDebugId InstanceId,
|
|
const FString& InstanceName)
|
|
: InstanceName(InstanceName)
|
|
, WeakStateTree(StateTree)
|
|
, InstanceId(InstanceId)
|
|
{
|
|
}
|
|
|
|
void CloseRecording(double WorldTime) const
|
|
{
|
|
// Output and empty active states event at the last recorded world time to close active states
|
|
UE_TRACE_LOG(StateTreeDebugger, WorldTimestampEvent, StateTreeDebugChannel) << WorldTimestampEvent.WorldTime(WorldTime);
|
|
FActiveStates EmptyState;
|
|
EmptyState.Output(InstanceId);
|
|
}
|
|
|
|
void Trace() const
|
|
{
|
|
if (ensureMsgf(UE_TRACE_CHANNELEXPR_IS_ENABLED(StateTreeDebugChannel), TEXT("Tracing a buffered data is expected only if channel is enabled.")))
|
|
{
|
|
if (const UStateTree* StateTree = WeakStateTree.Get())
|
|
{
|
|
OutputInstanceLifetimeEvent(InstanceId, StateTree, *InstanceName, EStateTreeTraceEventType::Push);
|
|
|
|
if (ActiveStates.IsValid())
|
|
{
|
|
ActiveStates.Output(InstanceId);
|
|
}
|
|
}
|
|
}
|
|
}
|
|
|
|
FActiveStates ActiveStates;
|
|
FString InstanceName;
|
|
TWeakObjectPtr<const UStateTree> WeakStateTree;
|
|
FStateTreeInstanceDebugId InstanceId;
|
|
};
|
|
|
|
/** Struct to keep track of the buffered event data and flush them. */
|
|
struct FBufferedDataList
|
|
{
|
|
double RecordingWorldTime = -1;
|
|
double TracedRecordingWorldTime = -1;
|
|
|
|
/**
|
|
* Stacks to keep track of all received phase events so other events will control when and if a given phase trace will be sent.
|
|
* This is per thread since it is possible to update execution contexts on multiple threads.
|
|
*/
|
|
TArray<FPhaseStack> PhaseStacks;
|
|
|
|
/** List of asset debug ids events that will be output if channel gets enabled. */
|
|
TArray<FAssetDebugIdEventBufferedData> AssetDebugIdEvents;
|
|
|
|
/** List of lifetime events that will be output if channel gets enabled in the Push - Pop lifetime window of an instance. */
|
|
TMap<FStateTreeInstanceDebugId, FInstanceEventBufferedData> InstanceLifetimeEvents;
|
|
|
|
/** Flag use to prevent reentrant calls */
|
|
bool bFlushing = false;
|
|
|
|
uint16 NextAssetDebugId = 1;
|
|
int32 CurrentVersion = 0;
|
|
int32 FlushedVersion = -1;
|
|
|
|
void Flush(const FStateTreeInstanceDebugId InstanceId)
|
|
{
|
|
if (bFlushing)
|
|
{
|
|
return;
|
|
}
|
|
|
|
TGuardValue<bool> GuardReentry(bFlushing, true);
|
|
|
|
const bool bTraceLifetimeEvents = FlushedVersion != CurrentVersion;
|
|
FlushedVersion = CurrentVersion;
|
|
|
|
// Trace asset events first since they are required for instance lifetime event types.
|
|
// Events are preserved in case the trace session is stopped and then a new one gets started
|
|
// in the same game session. In which case we need to output the ids to that new trace.
|
|
if (bTraceLifetimeEvents)
|
|
{
|
|
for (const FAssetDebugIdEventBufferedData& AssetDebugIdEventData : AssetDebugIdEvents)
|
|
{
|
|
AssetDebugIdEventData.Trace();
|
|
}
|
|
}
|
|
|
|
TraceWorldTime();
|
|
|
|
// Then trace instance lifetime events since they are required for other event types.
|
|
// They are associated to an older world time but to simplify the logic on the analysis side
|
|
// we will send them as if the instances were created at the beginning of the recording.
|
|
// Events are also preserved for the same reason as AssetDebugIdEvents.
|
|
if (bTraceLifetimeEvents)
|
|
{
|
|
for (TPair<FStateTreeInstanceDebugId, FInstanceEventBufferedData>& Pair : InstanceLifetimeEvents)
|
|
{
|
|
Pair.Value.Trace();
|
|
}
|
|
}
|
|
|
|
if (InstanceId.IsValid())
|
|
{
|
|
TraceStackedPhases(InstanceId);
|
|
}
|
|
}
|
|
|
|
/**
|
|
* Called by TraceBufferedEvents from the OutputXYZ methods to make sure we have the current world time was sent.
|
|
*/
|
|
void TraceWorldTime()
|
|
{
|
|
if (TracedRecordingWorldTime != RecordingWorldTime)
|
|
{
|
|
TracedRecordingWorldTime = RecordingWorldTime;
|
|
UE_TRACE_LOG(StateTreeDebugger, WorldTimestampEvent, StateTreeDebugChannel)
|
|
<< WorldTimestampEvent.WorldTime(RecordingWorldTime);
|
|
}
|
|
}
|
|
|
|
/**
|
|
* Called by TraceBufferedEvents from the OutputXYZ methods to flush pending phase events.
|
|
* Phases popped before TraceStackedPhases gets called will never produce any trace since
|
|
* they will not be required for the analysis.
|
|
*/
|
|
void TraceStackedPhases(const FStateTreeInstanceDebugId InstanceId)
|
|
{
|
|
for (FPhaseStack& PhaseStack : PhaseStacks)
|
|
{
|
|
if (PhaseStack.InstanceId == InstanceId)
|
|
{
|
|
for (FPhaseTraceStatusPair& StackEntry : PhaseStack.Stack)
|
|
{
|
|
// Trace push phase event and marked as traced only if not already traced and our channel is enabled.
|
|
// We need the pop phase event to be sent only in this case to enforce complementary events in case of
|
|
// late recording (e.g. recording started, or channel enabled, after simulation is running and instances are ticked)
|
|
if (StackEntry.bTraced == false && UE_TRACE_CHANNELEXPR_IS_ENABLED(StateTreeDebugChannel))
|
|
{
|
|
UE_TRACE_LOG(StateTreeDebugger, PhaseEvent, StateTreeDebugChannel)
|
|
<< PhaseEvent.Cycle(FPlatformTime::Cycles64())
|
|
<< PhaseEvent.InstanceId(InstanceId.Id)
|
|
<< PhaseEvent.InstanceSerial(InstanceId.SerialNumber)
|
|
<< PhaseEvent.Phase(static_cast<std::underlying_type_t<EStateTreeUpdatePhase>>(StackEntry.Phase))
|
|
<< PhaseEvent.StateIndex(StackEntry.StateHandle.Index)
|
|
<< PhaseEvent.EventType(static_cast<std::underlying_type_t<EStateTreeTraceEventType>>(EStateTreeTraceEventType::Push));
|
|
|
|
StackEntry.bTraced = true;
|
|
}
|
|
}
|
|
break;
|
|
}
|
|
}
|
|
}
|
|
|
|
void OnStoppingTraces()
|
|
{
|
|
for (TPair<FStateTreeInstanceDebugId, FInstanceEventBufferedData>& Pair : InstanceLifetimeEvents)
|
|
{
|
|
Pair.Value.CloseRecording(TracedRecordingWorldTime);
|
|
}
|
|
|
|
// Bump version so shareable data will be flush in the next trace (e.g. Asset ids, instance lifetime events, etc.)
|
|
CurrentVersion++;
|
|
|
|
// Force world time to trace on the next event
|
|
RecordingWorldTime = -1;
|
|
}
|
|
};
|
|
|
|
/**
|
|
* Buffered events (e.g. lifetime, active state, scoped phase) in case channel is not active yet or phase are empty and don't need to be traced.
|
|
* This is per thread since it is possible to update execution contexts on multiple threads.
|
|
* @note The current implementation of the lifetime events doesn't properly support same instance getting ticked in different threads.
|
|
*/
|
|
thread_local FBufferedDataList GBufferedEvents;
|
|
|
|
/**
|
|
* Pushed or pops an entry on the Phase stack for a given Instance.
|
|
* Will send the Pop events for phases popped if their associated Push events were sent.
|
|
*/
|
|
void OutputPhaseScopeEvent(const FStateTreeInstanceDebugId InstanceId, const EStateTreeUpdatePhase Phase, const EStateTreeTraceEventType EventType, const FStateTreeStateHandle StateHandle)
|
|
{
|
|
TArray<FPhaseStack>& PhaseStacks = GBufferedEvents.PhaseStacks;
|
|
int32 ExistingStackIndex = PhaseStacks.IndexOfByPredicate([InstanceId](const FPhaseStack& PhaseStack){ return PhaseStack.InstanceId == InstanceId; });
|
|
|
|
if (EventType == EStateTreeTraceEventType::Push)
|
|
{
|
|
if (ExistingStackIndex == INDEX_NONE)
|
|
{
|
|
ExistingStackIndex = PhaseStacks.AddDefaulted();
|
|
}
|
|
FPhaseStack& PhaseStack = PhaseStacks[ExistingStackIndex];
|
|
PhaseStack.InstanceId = InstanceId;
|
|
PhaseStack.Stack.Push(FPhaseTraceStatusPair(Phase, StateHandle));
|
|
}
|
|
else if (ensureMsgf(ExistingStackIndex != INDEX_NONE, TEXT("Not expected to pop phases for an instance that never pushed a phase.")))
|
|
{
|
|
FPhaseStack& PhaseStack = PhaseStacks[ExistingStackIndex];
|
|
|
|
if (ensureMsgf(PhaseStack.Stack.IsEmpty() == false, TEXT("Not expected to pop phases that never got pushed.")) &&
|
|
ensureMsgf(PhaseStack.InstanceId == InstanceId, TEXT("Not expected to pop phases for an instance that is not the one currently assigned to the stack.")))
|
|
{
|
|
const FPhaseTraceStatusPair RemovedPair = PhaseStack.Stack.Pop();
|
|
ensureMsgf(RemovedPair.Phase == Phase, TEXT("Not expected to pop a phase that is not on the top of the stack."));
|
|
|
|
// Clear associated InstanceId when removing last entry from the stack.
|
|
if (PhaseStack.Stack.IsEmpty())
|
|
{
|
|
PhaseStacks.RemoveAt(ExistingStackIndex, /*Count*/1, EAllowShrinking::No);
|
|
}
|
|
|
|
// Phase was previously traced (i.e. other events were traced in that scope so we need to trace the closing (i.e. Pop) event.
|
|
if (RemovedPair.bTraced)
|
|
{
|
|
UE_TRACE_LOG(StateTreeDebugger, PhaseEvent, StateTreeDebugChannel)
|
|
<< PhaseEvent.Cycle(FPlatformTime::Cycles64())
|
|
<< PhaseEvent.InstanceId(InstanceId.Id)
|
|
<< PhaseEvent.InstanceSerial(InstanceId.SerialNumber)
|
|
<< PhaseEvent.Phase(static_cast<std::underlying_type_t<EStateTreeUpdatePhase>>(Phase))
|
|
<< PhaseEvent.StateIndex(StateHandle.Index)
|
|
<< PhaseEvent.EventType(static_cast<std::underlying_type_t<EStateTreeTraceEventType>>(EStateTreeTraceEventType::Pop));
|
|
}
|
|
}
|
|
}
|
|
}
|
|
|
|
|
|
/**
|
|
* Called by the OutputXYZ methods to flush pending events (e.g. Push or WorldTime).
|
|
*/
|
|
void TraceBufferedEvents(const FStateTreeInstanceDebugId InstanceId)
|
|
{
|
|
GBufferedEvents.Flush(InstanceId);
|
|
}
|
|
|
|
void SerializeDataViewToArchive(FBufferArchive& Ar, const FStateTreeDataView DataView)
|
|
{
|
|
constexpr uint32 PortFlags =
|
|
PPF_PropertyWindow // limit to properties visible in Editor
|
|
| PPF_ExportsNotFullyQualified
|
|
| PPF_Delimited // property data should be wrapped in quotes
|
|
| PPF_ExternalEditor // uses authored names instead of internal names and default values are always written out
|
|
| PPF_SimpleObjectText // object property values should be exported without the package or class information
|
|
| PPF_ForDiff; // do not emit object path
|
|
|
|
if (const UScriptStruct* ScriptStruct = Cast<const UScriptStruct>(DataView.GetStruct()))
|
|
{
|
|
TRACE_CPUPROFILER_EVENT_SCOPE(UE::StateTree::ExportStructAsText)
|
|
FString StructPath = ScriptStruct->GetPathName();
|
|
FString TextValue;
|
|
|
|
ScriptStruct->ExportText(TextValue, DataView.GetMemory(), DataView.GetMemory(), /*OwnerObject*/nullptr, PortFlags | PPF_SeparateDefine, /*ExportRootScope*/nullptr);
|
|
|
|
Ar << StructPath;
|
|
Ar << TextValue;
|
|
}
|
|
else if (const UClass* Class = Cast<const UClass>(DataView.GetStruct()))
|
|
{
|
|
TRACE_CPUPROFILER_EVENT_SCOPE(UE::StateTree::ExportObjectAsText)
|
|
FString StructPath = Class->GetPathName();
|
|
FStringOutputDevice OutputDevice;
|
|
UObject* Object = DataView.GetMutablePtr<UObject>();
|
|
|
|
// Not using on scope FExportObjectInnerContext since it is very costly to build.
|
|
// Passing a null context will make the export use an already built thread local context.
|
|
UExporter::ExportToOutputDevice(nullptr, Object, /*Exporter*/nullptr, OutputDevice, TEXT("copy"), 0, PortFlags, false, Object->GetOuter());
|
|
|
|
Ar << StructPath;
|
|
Ar << OutputDevice;
|
|
}
|
|
}
|
|
|
|
void RegisterGlobalDelegates()
|
|
{
|
|
GOnWorldTickStartDelegateHandle = FWorldDelegates::OnWorldTickStart.AddLambda([&WorldTime=GBufferedEvents.RecordingWorldTime](const UWorld* TickedWorld, ELevelTick TickType, float DeltaTime)
|
|
{
|
|
#if OBJECT_TRACE_ENABLED
|
|
WorldTime = FObjectTrace::GetWorldElapsedTime(TickedWorld);
|
|
#endif// OBJECT_TRACE_ENABLED
|
|
});
|
|
|
|
GTracingStateChangedDelegateHandle = UE::StateTree::Delegates::OnTracingStateChanged.AddLambda([](const EStateTreeTraceStatus TraceStatus)
|
|
{
|
|
// Traces are about to be stopped so allow the buffered events to react.
|
|
if (TraceStatus == EStateTreeTraceStatus::StoppingTrace)
|
|
{
|
|
GBufferedEvents.OnStoppingTraces();
|
|
}
|
|
});
|
|
}
|
|
|
|
void UnregisterGlobalDelegates()
|
|
{
|
|
FWorldDelegates::OnWorldTickStart.Remove(GOnWorldTickStartDelegateHandle);
|
|
GOnWorldTickStartDelegateHandle.Reset();
|
|
|
|
UE::StateTree::Delegates::OnTracingStateChanged.Remove(GTracingStateChangedDelegateHandle);
|
|
GTracingStateChangedDelegateHandle.Reset();
|
|
}
|
|
|
|
FStateTreeIndex16 FindOrAddDebugIdForAsset(const UStateTree* StateTree)
|
|
{
|
|
FStateTreeIndex16 AssetDebugId;
|
|
const FAssetDebugIdEventBufferedData* ExistingPair = GBufferedEvents.AssetDebugIdEvents.FindByPredicate([StateTree](const FAssetDebugIdEventBufferedData& BufferedData)
|
|
{
|
|
return BufferedData.WeakStateTree == StateTree;
|
|
});
|
|
|
|
if (ExistingPair == nullptr)
|
|
{
|
|
if (ensure(StateTree != nullptr))
|
|
{
|
|
AssetDebugId = FStateTreeIndex16(GBufferedEvents.NextAssetDebugId++);
|
|
GBufferedEvents.AssetDebugIdEvents.Emplace(StateTree, AssetDebugId);
|
|
OutputAssetDebugIdEvent(StateTree, AssetDebugId);
|
|
}
|
|
}
|
|
else
|
|
{
|
|
AssetDebugId = ExistingPair->AssetDebugId;
|
|
}
|
|
|
|
return AssetDebugId;
|
|
}
|
|
|
|
void OutputAssetDebugIdEvent(
|
|
const UStateTree* StateTree,
|
|
const FStateTreeIndex16 AssetDebugId
|
|
)
|
|
{
|
|
if (UE_TRACE_CHANNELEXPR_IS_ENABLED(StateTreeDebugChannel))
|
|
{
|
|
TraceBufferedEvents(FStateTreeInstanceDebugId::Invalid);
|
|
|
|
check(StateTree);
|
|
const FString TreeName = StateTree->GetName();
|
|
const FString TreePath = StateTree->GetPathName();
|
|
|
|
UE_TRACE_LOG(StateTreeDebugger, AssetDebugIdEvent, StateTreeDebugChannel)
|
|
<< AssetDebugIdEvent.Cycle(FPlatformTime::Cycles64())
|
|
<< AssetDebugIdEvent.TreeName(*TreeName, TreeName.Len())
|
|
<< AssetDebugIdEvent.TreePath(*TreePath, TreePath.Len())
|
|
<< AssetDebugIdEvent.CompiledDataHash(StateTree->LastCompiledEditorDataHash)
|
|
<< AssetDebugIdEvent.AssetDebugId(AssetDebugId.Get());
|
|
}
|
|
}
|
|
|
|
void OutputInstanceLifetimeEvent(
|
|
const FStateTreeInstanceDebugId InstanceId,
|
|
const UStateTree* StateTree,
|
|
const TCHAR* InstanceName,
|
|
const EStateTreeTraceEventType EventType
|
|
)
|
|
{
|
|
if (UE_TRACE_CHANNELEXPR_IS_ENABLED(StateTreeDebugChannel))
|
|
{
|
|
TraceBufferedEvents(InstanceId);
|
|
|
|
const FStateTreeIndex16 AssetDebugId = FindOrAddDebugIdForAsset(StateTree);
|
|
|
|
UE_TRACE_LOG(StateTreeDebugger, InstanceEvent, StateTreeDebugChannel)
|
|
<< InstanceEvent.Cycle(FPlatformTime::Cycles64())
|
|
<< InstanceEvent.InstanceId(InstanceId.Id)
|
|
<< InstanceEvent.InstanceSerial(InstanceId.SerialNumber)
|
|
<< InstanceEvent.InstanceName(InstanceName)
|
|
<< InstanceEvent.EventType(static_cast<std::underlying_type_t<EStateTreeTraceEventType>>(EventType))
|
|
<< InstanceEvent.AssetDebugId(AssetDebugId.Get());
|
|
}
|
|
|
|
// Buffer these events regardless of the status of the channel since they will be used
|
|
// when flushing buffered event when a late recording is started or more than one trace are started
|
|
// during the same game session (i.e. Start Traces -> Stop Traces -> Start Traces).
|
|
if (!GBufferedEvents.bFlushing)
|
|
{
|
|
if (EventType == EStateTreeTraceEventType::Push)
|
|
{
|
|
GBufferedEvents.InstanceLifetimeEvents.Emplace(InstanceId, FInstanceEventBufferedData(StateTree, InstanceId, InstanceName));
|
|
}
|
|
else if (EventType == EStateTreeTraceEventType::Pop)
|
|
{
|
|
GBufferedEvents.InstanceLifetimeEvents.Remove(InstanceId);
|
|
}
|
|
else
|
|
{
|
|
ensureMsgf(false, TEXT("Unexpected EventType '%s' for instance lifetime event."), *UEnum::GetDisplayValueAsText(EventType).ToString());
|
|
}
|
|
}
|
|
}
|
|
|
|
void OutputInstanceFrameEvent(
|
|
const FStateTreeInstanceDebugId InstanceId,
|
|
const FStateTreeExecutionFrame* Frame
|
|
)
|
|
{
|
|
check(Frame != nullptr);
|
|
|
|
if (UE_TRACE_CHANNELEXPR_IS_ENABLED(StateTreeDebugChannel))
|
|
{
|
|
TraceBufferedEvents(InstanceId);
|
|
|
|
const FStateTreeIndex16 AssetDebugId = FindOrAddDebugIdForAsset(Frame->StateTree.Get());
|
|
|
|
UE_TRACE_LOG(StateTreeDebugger, InstanceFrameEvent, StateTreeDebugChannel)
|
|
<< InstanceFrameEvent.Cycle(FPlatformTime::Cycles64())
|
|
<< InstanceFrameEvent.InstanceId(InstanceId.Id)
|
|
<< InstanceFrameEvent.InstanceSerial(InstanceId.SerialNumber)
|
|
<< InstanceFrameEvent.AssetDebugId(AssetDebugId.Get());
|
|
}
|
|
// No need to buffer since frame event are sent each time a FrameScope is used by the execution context
|
|
// and we don't expect the trace channel to be enabled/disabled during a single execution context update.
|
|
}
|
|
|
|
void OutputLogEventTrace(
|
|
const FStateTreeInstanceDebugId InstanceId,
|
|
ELogVerbosity::Type Verbosity,
|
|
const TCHAR* Fmt, ...
|
|
)
|
|
{
|
|
static TCHAR TraceStaticBuffer[8192];
|
|
GET_TYPED_VARARGS(TCHAR, TraceStaticBuffer, UE_ARRAY_COUNT(TraceStaticBuffer), UE_ARRAY_COUNT(TraceStaticBuffer) - 1, Fmt, Fmt);
|
|
|
|
TraceBufferedEvents(InstanceId);
|
|
|
|
UE_TRACE_LOG(StateTreeDebugger, LogEvent, StateTreeDebugChannel)
|
|
<< LogEvent.Cycle(FPlatformTime::Cycles64())
|
|
<< LogEvent.InstanceId(InstanceId.Id)
|
|
<< LogEvent.InstanceSerial(InstanceId.SerialNumber)
|
|
<< LogEvent.Verbosity(Verbosity)
|
|
<< LogEvent.Message(TraceStaticBuffer);
|
|
}
|
|
|
|
void OutputStateEventTrace(
|
|
const FStateTreeInstanceDebugId InstanceId,
|
|
const FStateTreeStateHandle StateHandle,
|
|
const EStateTreeTraceEventType EventType
|
|
)
|
|
{
|
|
TraceBufferedEvents(InstanceId);
|
|
|
|
UE_TRACE_LOG(StateTreeDebugger, StateEvent, StateTreeDebugChannel)
|
|
<< StateEvent.Cycle(FPlatformTime::Cycles64())
|
|
<< StateEvent.InstanceId(InstanceId.Id)
|
|
<< StateEvent.InstanceSerial(InstanceId.SerialNumber)
|
|
<< StateEvent.StateIndex(StateHandle.Index)
|
|
<< StateEvent.EventType(static_cast<std::underlying_type_t<EStateTreeTraceEventType>>(EventType));
|
|
}
|
|
|
|
void OutputTaskEventTrace(
|
|
const FStateTreeInstanceDebugId InstanceId,
|
|
const FStateTreeIndex16 TaskIdx,
|
|
const FStateTreeDataView DataView,
|
|
const EStateTreeTraceEventType EventType,
|
|
const EStateTreeRunStatus Status
|
|
)
|
|
{
|
|
FBufferArchive Archive;
|
|
SerializeDataViewToArchive(Archive, DataView);
|
|
|
|
TraceBufferedEvents(InstanceId);
|
|
|
|
UE_TRACE_LOG(StateTreeDebugger, TaskEvent, StateTreeDebugChannel)
|
|
<< TaskEvent.Cycle(FPlatformTime::Cycles64())
|
|
<< TaskEvent.InstanceId(InstanceId.Id)
|
|
<< TaskEvent.InstanceSerial(InstanceId.SerialNumber)
|
|
<< TaskEvent.NodeIndex(TaskIdx.Get())
|
|
<< TaskEvent.DataView(Archive.GetData(), Archive.Num())
|
|
<< TaskEvent.EventType(static_cast<std::underlying_type_t<EStateTreeTraceEventType>>(EventType))
|
|
<< TaskEvent.Status(static_cast<std::underlying_type_t<EStateTreeRunStatus>>(Status));
|
|
}
|
|
|
|
void OutputEvaluatorEventTrace(
|
|
const FStateTreeInstanceDebugId InstanceId,
|
|
const FStateTreeIndex16 EvaluatorIdx,
|
|
const FStateTreeDataView DataView,
|
|
const EStateTreeTraceEventType EventType
|
|
)
|
|
{
|
|
FBufferArchive Archive;
|
|
SerializeDataViewToArchive(Archive, DataView);
|
|
|
|
TraceBufferedEvents(InstanceId);
|
|
|
|
UE_TRACE_LOG(StateTreeDebugger, EvaluatorEvent, StateTreeDebugChannel)
|
|
<< EvaluatorEvent.Cycle(FPlatformTime::Cycles64())
|
|
<< EvaluatorEvent.InstanceId(InstanceId.Id)
|
|
<< EvaluatorEvent.InstanceSerial(InstanceId.SerialNumber)
|
|
<< EvaluatorEvent.NodeIndex(EvaluatorIdx.Get())
|
|
<< EvaluatorEvent.DataView(Archive.GetData(), Archive.Num())
|
|
<< EvaluatorEvent.EventType(static_cast<std::underlying_type_t<EStateTreeTraceEventType>>(EventType));
|
|
}
|
|
|
|
void OutputTransitionEventTrace(
|
|
const FStateTreeInstanceDebugId InstanceId,
|
|
const FStateTreeTransitionSource Source,
|
|
const EStateTreeTraceEventType EventType
|
|
)
|
|
{
|
|
FBufferArchive Archive;
|
|
Archive << EventType;
|
|
|
|
TraceBufferedEvents(InstanceId);
|
|
|
|
UE_TRACE_LOG(StateTreeDebugger, TransitionEvent, StateTreeDebugChannel)
|
|
<< TransitionEvent.Cycle(FPlatformTime::Cycles64())
|
|
<< TransitionEvent.InstanceId(InstanceId.Id)
|
|
<< TransitionEvent.InstanceSerial(InstanceId.SerialNumber)
|
|
<< TransitionEvent.SourceType(static_cast<std::underlying_type_t<EStateTreeTransitionSourceType>>(Source.SourceType))
|
|
<< TransitionEvent.TransitionIndex(Source.TransitionIndex.Get())
|
|
<< TransitionEvent.TargetStateIndex(Source.TargetState.Index)
|
|
<< TransitionEvent.Priority(static_cast<std::underlying_type_t<EStateTreeTransitionPriority>>(Source.Priority))
|
|
<< TransitionEvent.EventType(static_cast<std::underlying_type_t<EStateTreeTraceEventType>>(EventType));
|
|
}
|
|
|
|
void OutputConditionEventTrace(
|
|
const FStateTreeInstanceDebugId InstanceId,
|
|
const FStateTreeIndex16 ConditionIdx,
|
|
const FStateTreeDataView DataView,
|
|
const EStateTreeTraceEventType EventType
|
|
)
|
|
{
|
|
FBufferArchive Archive;
|
|
SerializeDataViewToArchive(Archive, DataView);
|
|
|
|
TraceBufferedEvents(InstanceId);
|
|
|
|
UE_TRACE_LOG(StateTreeDebugger, ConditionEvent, StateTreeDebugChannel)
|
|
<< ConditionEvent.Cycle(FPlatformTime::Cycles64())
|
|
<< ConditionEvent.InstanceId(InstanceId.Id)
|
|
<< ConditionEvent.InstanceSerial(InstanceId.SerialNumber)
|
|
<< ConditionEvent.NodeIndex(ConditionIdx.Get())
|
|
<< ConditionEvent.DataView(Archive.GetData(), Archive.Num())
|
|
<< ConditionEvent.EventType(static_cast<std::underlying_type_t<EStateTreeTraceEventType>>(EventType));
|
|
}
|
|
|
|
void OutputActiveStatesEventTrace(
|
|
const FStateTreeInstanceDebugId InstanceId,
|
|
const TConstArrayView<FStateTreeExecutionFrame> ActiveFrames
|
|
)
|
|
{
|
|
if (UE_TRACE_CHANNELEXPR_IS_ENABLED(StateTreeDebugChannel))
|
|
{
|
|
TraceBufferedEvents(InstanceId);
|
|
|
|
const FInstanceEventBufferedData::FActiveStates ActiveStates(ActiveFrames);
|
|
ActiveStates.Output(InstanceId);
|
|
}
|
|
else
|
|
{
|
|
// We keep only the most recent active states since this is all we need to know in which state was the instance
|
|
// when we start receiving the events once the channel is enabled.
|
|
if (FInstanceEventBufferedData* ExisingBufferedData = GBufferedEvents.InstanceLifetimeEvents.Find(InstanceId))
|
|
{
|
|
ExisingBufferedData->ActiveStates= FInstanceEventBufferedData::FActiveStates(ActiveFrames);
|
|
}
|
|
}
|
|
}
|
|
|
|
} // UE::StateTreeTrace
|
|
|
|
#endif // WITH_STATETREE_TRACE
|