Compare commits
10 Commits
cross-buil
...
audit-hand
| Author | SHA1 | Date | |
|---|---|---|---|
|
|
bbffd8d20c | ||
|
|
17f4612b79 | ||
|
|
33dee75c03 | ||
|
|
5427f14f1b | ||
|
|
a594f95f77 | ||
|
|
dde48f287b | ||
|
|
fc89e68155 | ||
|
|
289c2f3a3e | ||
|
|
1e5648c9a5 | ||
|
|
d031d7c513 |
@@ -41,6 +41,30 @@
|
||||
|
||||
DEFINE_bool(debugprint_trap_log, false,
|
||||
"Log debugprint traps to the active debugger", "CPU");
|
||||
DEFINE_uint32(audit_jit_prolog_pc, 0,
|
||||
"Guest function entry PC at which to emit one XELOGKERNEL line "
|
||||
"per JIT-compiled entry. When non-zero, the x64 emitter inserts "
|
||||
"a CallNative to AuditLogJitPrologArgs at the start of the JIT "
|
||||
"body of the matching guest function. Dumps r3..r10, LR, and 64 "
|
||||
"bytes at host(r3). Zero (default) disables the probe. Audit-059 "
|
||||
"round 7+ JIT-prolog probe — generic PC-configurable variant.",
|
||||
"Auditing");
|
||||
DEFINE_uint32(audit_jit_prolog_mem_dump, 0,
|
||||
"Audit-059 round 14 — paired memory-dump VA. When non-zero "
|
||||
"AND audit_jit_prolog_pc fires, dereference the guest VA 3 "
|
||||
"levels deep and emit one XELOGKERNEL line: addr -> val "
|
||||
"(singleton instance), val -> vtable, vtable -> vtable[0] / "
|
||||
"vtable[24]. Reads the singleton at [0x828E1F08], its vtable, "
|
||||
"and its vtable[0] (first virtual method = bctrl target at "
|
||||
"sub_822F1AA8+0x90). Zero (default) disables.",
|
||||
"Auditing");
|
||||
DEFINE_uint32(audit_jit_prolog_r3_bytes, 0x40,
|
||||
"Audit-052 — number of bytes to dump from host(r3) on every "
|
||||
"audit_jit_prolog_pc fire (capped at 256, 16-byte aligned). "
|
||||
"Default 64 (existing behaviour). Set to 80 to capture the "
|
||||
"audit-051 stack-local struct at sub_82452DC0's r31+96 "
|
||||
"(probe sub_8245B000 entry where r3 IS the struct ptr).",
|
||||
"Auditing");
|
||||
DEFINE_bool(ignore_undefined_externs, true,
|
||||
"Don't exit when an undefined extern is called.", "CPU");
|
||||
DEFINE_bool(emit_source_annotations, false,
|
||||
@@ -270,6 +294,17 @@ bool X64Emitter::Emit(HIRBuilder* builder, EmitFunctionInfo& func_info) {
|
||||
count on no other code modifying it. mov(GetMembaseReg(),
|
||||
qword[GetContextReg() + offsetof(ppc::PPCContext, virtual_membase)]);
|
||||
*/
|
||||
// Audit-059: PC-configurable JIT-prolog probe. Runtime-gated on the cvar
|
||||
// audit_jit_prolog_pc (uint32; 0 disables). When non-zero and the current
|
||||
// guest function's entry PC matches, emit a single CallNative to
|
||||
// AuditLogJitPrologArgs that dumps r3..r10, LR, and 64 bytes at host(r3).
|
||||
// Emits *before* any body instruction runs, so r3..r10 / LR in PPCContext
|
||||
// still reflect the caller's args (no LOAD/STORE_CONTEXT has executed yet).
|
||||
if (cvars::audit_jit_prolog_pc != 0u &&
|
||||
current_guest_function_ == cvars::audit_jit_prolog_pc) {
|
||||
extern uint64_t AuditLogJitPrologArgs(void* raw_context, uint64_t arg0);
|
||||
CallNative(AuditLogJitPrologArgs, 0);
|
||||
}
|
||||
// Body.
|
||||
auto block = builder->first_block();
|
||||
synchronize_stack_on_next_instruction_ = false;
|
||||
@@ -438,6 +473,82 @@ uint64_t TrapDebugBreak(void* raw_context, uint64_t address) {
|
||||
return 0;
|
||||
}
|
||||
|
||||
// Audit-059 JIT-prolog probe: dump r3..r10, LR, and 64 bytes at host(r3)
|
||||
// when the guest hits the JIT-compiled entry of the function whose entry PC
|
||||
// matches cvars::audit_jit_prolog_pc. Generic PC-configurable variant of the
|
||||
// round-7 sub_824F7800 hook. The hook logs the current guest PC so multiple
|
||||
// instrumentation campaigns can share log output.
|
||||
uint64_t AuditLogJitPrologArgs(void* raw_context, uint64_t /*unused*/) {
|
||||
auto* ctx = reinterpret_cast<ppc::PPCContext_s*>(raw_context);
|
||||
uint32_t pc = static_cast<uint32_t>(cvars::audit_jit_prolog_pc);
|
||||
uint32_t r3 = static_cast<uint32_t>(ctx->r[3]);
|
||||
uint32_t r4 = static_cast<uint32_t>(ctx->r[4]);
|
||||
uint32_t r5 = static_cast<uint32_t>(ctx->r[5]);
|
||||
uint32_t r6 = static_cast<uint32_t>(ctx->r[6]);
|
||||
uint32_t r7 = static_cast<uint32_t>(ctx->r[7]);
|
||||
uint32_t r8 = static_cast<uint32_t>(ctx->r[8]);
|
||||
uint32_t r9 = static_cast<uint32_t>(ctx->r[9]);
|
||||
uint32_t r10 = static_cast<uint32_t>(ctx->r[10]);
|
||||
uint32_t lr = static_cast<uint32_t>(ctx->lr);
|
||||
|
||||
uint32_t tid = ctx->thread_state ? ctx->thread_state->thread_id() : 0u;
|
||||
|
||||
XELOGKERNEL(
|
||||
"AUDIT-HLC JitProlog pc={:08X} tid={:08X} r3={:08X} r4={:08X} r5={:08X} "
|
||||
"r6={:08X} r7={:08X} r8={:08X} r9={:08X} r10={:08X} lr={:08X}",
|
||||
pc, tid, r3, r4, r5, r6, r7, r8, r9, r10, lr);
|
||||
|
||||
// Dump N bytes at host(r3) if r3 looks like a plausible guest VA.
|
||||
// N comes from cvar `audit_jit_prolog_r3_bytes` (default 64 = existing
|
||||
// behaviour). Round up to a 16-byte multiple; cap at 256.
|
||||
uint32_t r3_dump_bytes = static_cast<uint32_t>(cvars::audit_jit_prolog_r3_bytes);
|
||||
if (r3_dump_bytes > 256) r3_dump_bytes = 256;
|
||||
r3_dump_bytes = (r3_dump_bytes + 15) & ~15u;
|
||||
if (r3 >= 0x10000 && r3 < 0xE0000000) {
|
||||
uint8_t* host = ctx->TranslateVirtual(r3);
|
||||
if (host) {
|
||||
for (uint32_t off = 0; off < r3_dump_bytes; off += 16) {
|
||||
uint32_t d0 = xe::load_and_swap<uint32_t>(host + off + 0);
|
||||
uint32_t d1 = xe::load_and_swap<uint32_t>(host + off + 4);
|
||||
uint32_t d2 = xe::load_and_swap<uint32_t>(host + off + 8);
|
||||
uint32_t d3 = xe::load_and_swap<uint32_t>(host + off + 12);
|
||||
XELOGKERNEL(
|
||||
"AUDIT-HLC JitProlog pc={:08X} r3+{:02X}: {:08X} {:08X} {:08X} "
|
||||
"{:08X}",
|
||||
pc, off, d0, d1, d2, d3);
|
||||
}
|
||||
} else {
|
||||
XELOGKERNEL("AUDIT-HLC JitProlog pc={:08X} r3 translate failed", pc);
|
||||
}
|
||||
} else {
|
||||
XELOGKERNEL("AUDIT-HLC JitProlog pc={:08X} r3 out of VA range, skipping dump",
|
||||
pc);
|
||||
}
|
||||
|
||||
// Audit-059 round 14 — paired 3-level dereference. When
|
||||
// `audit_jit_prolog_mem_dump` is set, read the singleton at that VA,
|
||||
// its vtable, vtable[0] (first virtual method = bctrl target), and
|
||||
// vtable[24] (slot 6 = silph chain method per round 9).
|
||||
uint32_t mem_addr = static_cast<uint32_t>(cvars::audit_jit_prolog_mem_dump);
|
||||
if (mem_addr != 0u && mem_addr >= 0x10000 && mem_addr < 0xE0000000) {
|
||||
auto load_be32 = [&](uint32_t va) -> uint32_t {
|
||||
if (va < 0x10000 || va >= 0xE0000000) return 0u;
|
||||
uint8_t* h = ctx->TranslateVirtual(va);
|
||||
if (!h) return 0u;
|
||||
return xe::load_and_swap<uint32_t>(h);
|
||||
};
|
||||
uint32_t val = load_be32(mem_addr);
|
||||
uint32_t vtable = val != 0u ? load_be32(val) : 0u;
|
||||
uint32_t m0 = vtable != 0u ? load_be32(vtable) : 0u;
|
||||
uint32_t m6 = vtable != 0u ? load_be32(vtable + 24u) : 0u;
|
||||
XELOGKERNEL(
|
||||
"AUDIT-MEM-READ addr={:08X} val={:08X} vtable={:08X} vtable[0]={:08X} "
|
||||
"vtable[24]={:08X} pc={:08X} tid={:08X}",
|
||||
mem_addr, val, vtable, m0, m6, pc, tid);
|
||||
}
|
||||
return 0;
|
||||
}
|
||||
|
||||
void X64Emitter::Trap(uint16_t trap_type) {
|
||||
switch (trap_type) {
|
||||
case 20:
|
||||
|
||||
@@ -13,6 +13,8 @@
|
||||
#include "xenia/base/clock.h"
|
||||
#include "xenia/base/logging.h"
|
||||
#include "xenia/base/math.h"
|
||||
#include "xenia/base/memory.h"
|
||||
#include "xenia/base/string_util.h"
|
||||
#include "xenia/base/profiling.h"
|
||||
#include "xenia/base/threading.h"
|
||||
#include "xenia/config.h"
|
||||
@@ -36,6 +38,32 @@ DEFINE_bool(
|
||||
"runtime spikes and freezes when playing the game not for the first time.",
|
||||
"GPU");
|
||||
|
||||
// Audit memory-watch: poll-based value-change logger for arbitrary guest VAs.
|
||||
// Reads the configured guest virtual address(es) once per vblank (per frame)
|
||||
// from inside GraphicsSystem::MarkVblank() and emits one XELOGKERNEL
|
||||
// "AUDIT-MEM-WATCH" line whenever the read value changes vs the previous
|
||||
// frame. Greppable on the same log stream as AUDIT-HLC / AUDIT-MEM-READ.
|
||||
// Default empty => disabled => zero overhead. Mechanism is poll/value-change
|
||||
// (NOT a write-trap), so it captures WHEN a value changes (vblank index +
|
||||
// emulator instruction count) but NOT the writer guest-PC. To find the writer
|
||||
// PC, pair this with audit_jit_prolog_pc on the suspected writer function.
|
||||
DEFINE_string(
|
||||
audit_mem_watch_addr, "",
|
||||
"Audit memory-watch — comma-separated list of guest virtual addresses "
|
||||
"(hex, e.g. \"0x40d09a40\" or \"0x40d09a40,0x40929c00\") to poll once per "
|
||||
"vblank. On every value change vs the previous frame, emit one "
|
||||
"XELOGKERNEL AUDIT-MEM-WATCH line (watched VA, old value, new value, "
|
||||
"vblank index, instruction count). Empty (default) disables the watch. "
|
||||
"Poll-based value-change log: tells you WHEN a value changes, not the "
|
||||
"writer PC.",
|
||||
"Auditing");
|
||||
DEFINE_uint32(
|
||||
audit_mem_watch_size, 4,
|
||||
"Audit memory-watch — number of bytes to read at each watched VA (1, 2, "
|
||||
"4, or 8). Read big-endian (guest byte order) and compared as a 64-bit "
|
||||
"value. Default 4.",
|
||||
"Auditing");
|
||||
|
||||
namespace xe {
|
||||
namespace gpu {
|
||||
|
||||
@@ -333,12 +361,117 @@ void GraphicsSystem::DispatchInterruptCallback(uint32_t source, uint32_t cpu) {
|
||||
interrupt_callback_data_, source, cpu);
|
||||
}
|
||||
|
||||
// Audit memory-watch poll. Called once per vblank from MarkVblank(). Parses
|
||||
// the comma-separated VA list from cvars::audit_mem_watch_addr exactly once
|
||||
// (cached), then reads each VA (big-endian, audit_mem_watch_size bytes) and
|
||||
// logs an AUDIT-MEM-WATCH line on every value change vs the previous frame.
|
||||
// Poll/value-change mechanism: captures WHEN, not the writer PC. Zero work
|
||||
// when the cvar is empty.
|
||||
static void AuditMemWatchPoll(Memory* memory, uint64_t vblank_index) {
|
||||
struct WatchEntry {
|
||||
uint32_t va;
|
||||
uint64_t last_value;
|
||||
bool have_last;
|
||||
};
|
||||
static std::vector<WatchEntry> entries;
|
||||
static std::string parsed_spec;
|
||||
static bool parse_failed = false;
|
||||
|
||||
const std::string& spec = cvars::audit_mem_watch_addr;
|
||||
if (spec.empty()) {
|
||||
return;
|
||||
}
|
||||
// (Re)parse only when the cvar string changes (set once at startup).
|
||||
if (spec != parsed_spec) {
|
||||
parsed_spec = spec;
|
||||
entries.clear();
|
||||
parse_failed = false;
|
||||
size_t start = 0;
|
||||
while (start <= spec.size()) {
|
||||
size_t comma = spec.find(',', start);
|
||||
std::string tok = spec.substr(
|
||||
start, comma == std::string::npos ? std::string::npos : comma - start);
|
||||
// Trim whitespace.
|
||||
while (!tok.empty() && (tok.front() == ' ' || tok.front() == '\t'))
|
||||
tok.erase(tok.begin());
|
||||
while (!tok.empty() && (tok.back() == ' ' || tok.back() == '\t'))
|
||||
tok.pop_back();
|
||||
if (!tok.empty()) {
|
||||
uint32_t va = 0;
|
||||
try {
|
||||
va = static_cast<uint32_t>(std::stoul(tok, nullptr, 16));
|
||||
} catch (...) {
|
||||
XELOGKERNEL("AUDIT-MEM-WATCH bad VA token '{}' in '{}'", tok, spec);
|
||||
parse_failed = true;
|
||||
va = 0;
|
||||
}
|
||||
if (va != 0) {
|
||||
entries.push_back({va, 0, false});
|
||||
}
|
||||
}
|
||||
if (comma == std::string::npos) break;
|
||||
start = comma + 1;
|
||||
}
|
||||
XELOGKERNEL("AUDIT-MEM-WATCH armed: {} address(es), size={} bytes",
|
||||
entries.size(),
|
||||
static_cast<uint32_t>(cvars::audit_mem_watch_size));
|
||||
}
|
||||
if (entries.empty()) {
|
||||
return;
|
||||
}
|
||||
(void)parse_failed;
|
||||
|
||||
uint32_t size = static_cast<uint32_t>(cvars::audit_mem_watch_size);
|
||||
for (auto& e : entries) {
|
||||
if (e.va < 0x10000 || e.va >= 0xE0000000) {
|
||||
continue;
|
||||
}
|
||||
uint8_t* host = memory->TranslateVirtual(e.va);
|
||||
if (!host) {
|
||||
continue;
|
||||
}
|
||||
uint64_t value = 0;
|
||||
switch (size) {
|
||||
case 1:
|
||||
value = *host;
|
||||
break;
|
||||
case 2:
|
||||
value = xe::load_and_swap<uint16_t>(host);
|
||||
break;
|
||||
case 8:
|
||||
value = xe::load_and_swap<uint64_t>(host);
|
||||
break;
|
||||
case 4:
|
||||
default:
|
||||
value = xe::load_and_swap<uint32_t>(host);
|
||||
break;
|
||||
}
|
||||
if (!e.have_last) {
|
||||
e.have_last = true;
|
||||
e.last_value = value;
|
||||
XELOGKERNEL(
|
||||
"AUDIT-MEM-WATCH va={:08X} init={:016X} vblank={} (first read)",
|
||||
e.va, value, vblank_index);
|
||||
continue;
|
||||
}
|
||||
if (value != e.last_value) {
|
||||
XELOGKERNEL(
|
||||
"AUDIT-MEM-WATCH va={:08X} old={:016X} new={:016X} vblank={}",
|
||||
e.va, e.last_value, value, vblank_index);
|
||||
e.last_value = value;
|
||||
}
|
||||
}
|
||||
}
|
||||
|
||||
void GraphicsSystem::MarkVblank() {
|
||||
SCOPE_profile_cpu_f("gpu");
|
||||
|
||||
// Increment vblank counter (so the game sees us making progress).
|
||||
command_processor_->increment_counter();
|
||||
|
||||
// Audit memory-watch (poll-based; no-op unless audit_mem_watch_addr set).
|
||||
AuditMemWatchPoll(memory_, command_processor_->counter());
|
||||
|
||||
// TODO(benvanik): we shouldn't need to do the dispatch here, but there's
|
||||
// something wrong and the CP will block waiting for code that
|
||||
// needs to be run in the interrupt.
|
||||
|
||||
@@ -14,3 +14,12 @@ DEFINE_bool(headless, false,
|
||||
"UI");
|
||||
DEFINE_bool(log_high_frequency_kernel_calls, false,
|
||||
"Log kernel calls with the kHighFrequency tag.", "Logging");
|
||||
DEFINE_bool(audit_handle_lifecycle, false,
|
||||
"Emit XELOGKERNEL on Event/Semaphore/Wait lifecycle "
|
||||
"(create/set/wait/complete). Audit oracle probe — off by default.",
|
||||
"Auditing");
|
||||
DEFINE_uint32(audit_track_event_handle, 0,
|
||||
"If non-zero and AUDIT-HLC enabled, log underlying X_KEVENT "
|
||||
"guest VA whenever NtCreateEvent returns this handle. "
|
||||
"Audit round-24 oracle probe.",
|
||||
"Auditing");
|
||||
|
||||
@@ -13,5 +13,7 @@
|
||||
|
||||
DECLARE_bool(headless);
|
||||
DECLARE_bool(log_high_frequency_kernel_calls);
|
||||
DECLARE_bool(audit_handle_lifecycle);
|
||||
DECLARE_uint32(audit_track_event_handle);
|
||||
|
||||
#endif // XENIA_KERNEL_KERNEL_FLAGS_H_
|
||||
|
||||
@@ -15,6 +15,7 @@
|
||||
#include "xenia/base/logging.h"
|
||||
#include "xenia/emulator.h"
|
||||
#include "xenia/hid/input_system.h"
|
||||
#include "xenia/kernel/kernel_flags.h"
|
||||
#include "xenia/kernel/user_module.h"
|
||||
#include "xenia/kernel/util/shim_utils.h"
|
||||
#include "xenia/kernel/xboxkrnl/xboxkrnl_memory.h"
|
||||
@@ -1070,6 +1071,14 @@ void KernelState::CompleteOverlappedEx(uint32_t overlapped_ptr, X_RESULT result,
|
||||
auto ev = object_table()->LookupObject<XEvent>(event_handle);
|
||||
assert_not_null(ev);
|
||||
if (ev) {
|
||||
if (cvars::audit_handle_lifecycle) {
|
||||
uint32_t lr =
|
||||
static_cast<uint32_t>(cpu::ThreadState::Get()->context()->lr);
|
||||
XELOGKERNEL(
|
||||
"AUDIT-HLC CompleteOverlappedEx_signal_event handle={:08X} "
|
||||
"kevent_va={:08X} lr={:08X}",
|
||||
uint32_t(event_handle), ev->guest_object(), lr);
|
||||
}
|
||||
ev->Set(0, false);
|
||||
}
|
||||
}
|
||||
@@ -1373,6 +1382,47 @@ void KernelState::EmulateCPInterruptDPC(uint32_t interrupt_callback,
|
||||
return;
|
||||
}
|
||||
|
||||
if (cvars::audit_handle_lifecycle) {
|
||||
XELOGKERNEL(
|
||||
"AUDIT-HLC EmulateCPInterruptDPC callback={:08X} data={:08X} source={} "
|
||||
"cpu={}",
|
||||
interrupt_callback, interrupt_callback_data, source, cpu);
|
||||
|
||||
// AUDIT-2BF round 14 — one-shot singleton + vtable dump. Resolves
|
||||
// the silph init chain bctrl target at PC 0x822F1B4C (vtable[0] of
|
||||
// ANON_Class_2D56F86D at [0x828E1F08]). Dereferences 3 deep:
|
||||
// [0x828E1F08] (singleton) → vtable → vtable[0] (=first virtual
|
||||
// method, the bctrl target) and vtable[24] (=slot 6, canary's silph
|
||||
// chain target sub_821B55D8). Done once per process via atomic
|
||||
// flag. Defensive null-checks at each level.
|
||||
static std::atomic<bool> g_audit_singleton_dumped{false};
|
||||
bool expected = false;
|
||||
if (g_audit_singleton_dumped.compare_exchange_strong(expected, true)) {
|
||||
const uint32_t addr = 0x828E1F08;
|
||||
uint32_t val = 0, vtable = 0, m0 = 0, m6 = 0;
|
||||
auto* host_addr = memory()->TranslateVirtual<uint32_t*>(addr);
|
||||
if (host_addr) {
|
||||
val = xe::load_and_swap<uint32_t>(host_addr);
|
||||
}
|
||||
if (val) {
|
||||
auto* host_val = memory()->TranslateVirtual<uint32_t*>(val);
|
||||
if (host_val) {
|
||||
vtable = xe::load_and_swap<uint32_t>(host_val);
|
||||
}
|
||||
}
|
||||
if (vtable) {
|
||||
auto* host_vt0 = memory()->TranslateVirtual<uint32_t*>(vtable);
|
||||
auto* host_vt6 = memory()->TranslateVirtual<uint32_t*>(vtable + 24);
|
||||
if (host_vt0) m0 = xe::load_and_swap<uint32_t>(host_vt0);
|
||||
if (host_vt6) m6 = xe::load_and_swap<uint32_t>(host_vt6);
|
||||
}
|
||||
XELOGKERNEL(
|
||||
"AUDIT-HLC singleton[0x828E1F08]={:08X} vtable={:08X} "
|
||||
"vtable[0]={:08X} vtable[24]={:08X}",
|
||||
val, vtable, m0, m6);
|
||||
}
|
||||
}
|
||||
|
||||
auto thread = kernel::XThread::GetCurrentThread();
|
||||
assert_not_null(thread);
|
||||
|
||||
|
||||
@@ -8,7 +8,9 @@
|
||||
*/
|
||||
|
||||
#include "xenia/base/logging.h"
|
||||
#include "xenia/cpu/thread_state.h"
|
||||
#include "xenia/kernel/info/file.h"
|
||||
#include "xenia/kernel/kernel_flags.h"
|
||||
#include "xenia/kernel/kernel_state.h"
|
||||
#include "xenia/kernel/util/shim_utils.h"
|
||||
#include "xenia/kernel/xboxkrnl/xboxkrnl_private.h"
|
||||
@@ -208,6 +210,13 @@ dword_result_t NtReadFile_entry(dword_t file_handle, dword_t event_handle,
|
||||
}
|
||||
|
||||
if (ev && signal_event) {
|
||||
if (cvars::audit_handle_lifecycle) {
|
||||
uint32_t lr = static_cast<uint32_t>(cpu::ThreadState::Get()->context()->lr);
|
||||
XELOGKERNEL(
|
||||
"AUDIT-HLC NtReadFile_signal_event handle={:08X} kevent_va={:08X} "
|
||||
"lr={:08X}",
|
||||
uint32_t(event_handle), ev->guest_object(), lr);
|
||||
}
|
||||
ev->Set(0, false);
|
||||
}
|
||||
|
||||
@@ -294,6 +303,13 @@ dword_result_t NtReadFileScatter_entry(
|
||||
}
|
||||
|
||||
if (ev && signal_event) {
|
||||
if (cvars::audit_handle_lifecycle) {
|
||||
uint32_t lr = static_cast<uint32_t>(cpu::ThreadState::Get()->context()->lr);
|
||||
XELOGKERNEL(
|
||||
"AUDIT-HLC NtReadFileScatter_signal_event handle={:08X} "
|
||||
"kevent_va={:08X} lr={:08X}",
|
||||
uint32_t(event_handle), ev->guest_object(), lr);
|
||||
}
|
||||
ev->Set(0, false);
|
||||
}
|
||||
|
||||
@@ -381,6 +397,13 @@ dword_result_t NtWriteFile_entry(dword_t file_handle, dword_t event_handle,
|
||||
}
|
||||
|
||||
if (ev && signal_event) {
|
||||
if (cvars::audit_handle_lifecycle) {
|
||||
uint32_t lr = static_cast<uint32_t>(cpu::ThreadState::Get()->context()->lr);
|
||||
XELOGKERNEL(
|
||||
"AUDIT-HLC NtWriteFile_signal_event handle={:08X} kevent_va={:08X} "
|
||||
"lr={:08X}",
|
||||
uint32_t(event_handle), ev->guest_object(), lr);
|
||||
}
|
||||
ev->Set(0, false);
|
||||
}
|
||||
|
||||
|
||||
@@ -10,6 +10,8 @@
|
||||
#include "xenia/kernel/xboxkrnl/xboxkrnl_ob.h"
|
||||
#include "xenia/base/logging.h"
|
||||
#include "xenia/cpu/processor.h"
|
||||
#include "xenia/cpu/thread_state.h"
|
||||
#include "xenia/kernel/kernel_flags.h"
|
||||
#include "xenia/kernel/kernel_state.h"
|
||||
#include "xenia/kernel/xboxkrnl/xboxkrnl_private.h"
|
||||
#include "xenia/kernel/xboxkrnl/xboxkrnl_threading.h"
|
||||
@@ -398,6 +400,14 @@ dword_result_t NtDuplicateObject_entry(dword_t handle, lpdword_t new_handle_ptr,
|
||||
X_STATUS result =
|
||||
kernel_state()->object_table()->DuplicateHandle(handle, &new_handle);
|
||||
|
||||
if (cvars::audit_handle_lifecycle) {
|
||||
uint32_t lr = static_cast<uint32_t>(cpu::ThreadState::Get()->context()->lr);
|
||||
XELOGKERNEL(
|
||||
"AUDIT-HLC NtDuplicateObject src={:08X} dst={:08X} options={:08X} "
|
||||
"lr={:08X}",
|
||||
uint32_t(handle), uint32_t(new_handle), uint32_t(options), lr);
|
||||
}
|
||||
|
||||
if (new_handle_ptr) {
|
||||
*new_handle_ptr = new_handle;
|
||||
}
|
||||
|
||||
@@ -8,10 +8,12 @@
|
||||
*/
|
||||
|
||||
#include "xenia/kernel/xboxkrnl/xboxkrnl_threading.h"
|
||||
#include <atomic>
|
||||
#include "xenia/base/atomic.h"
|
||||
#include "xenia/base/clock.h"
|
||||
#include "xenia/base/platform.h"
|
||||
#include "xenia/cpu/processor.h"
|
||||
#include "xenia/kernel/kernel_flags.h"
|
||||
#include "xenia/kernel/util/shim_utils.h"
|
||||
#include "xenia/kernel/xboxkrnl/xboxkrnl_private.h"
|
||||
#include "xenia/kernel/xsemaphore.h"
|
||||
@@ -22,6 +24,9 @@ namespace xe {
|
||||
namespace kernel {
|
||||
namespace xboxkrnl {
|
||||
|
||||
// AUDIT-HLC: one-shot guard for silph::WorkerCtx context dump (round5).
|
||||
static std::atomic<bool> g_audit_silph_ctx_dumped{false};
|
||||
|
||||
// r13 + 0x100: pointer to thread local state
|
||||
// Thread local state:
|
||||
// 0x058: kernel time
|
||||
@@ -157,6 +162,30 @@ dword_result_t ExCreateThread_entry(lpdword_t handle_ptr, dword_t stack_size,
|
||||
lpvoid_t start_address,
|
||||
lpvoid_t start_context,
|
||||
dword_t creation_flags) {
|
||||
if (cvars::audit_handle_lifecycle) {
|
||||
auto* ctx = cpu::ThreadState::Get()->context();
|
||||
uint32_t lr = static_cast<uint32_t>(ctx->lr);
|
||||
// Walk one PPC stack frame up from the shim's frame to recover the GUEST
|
||||
// caller's LR (lr_enter is just the kernel-internal shim's return
|
||||
// address; we want the function that called *it*). Same convention as
|
||||
// the NtWaitForSingleObjectEx probe above.
|
||||
uint32_t guest_lr = 0;
|
||||
uint32_t sp = static_cast<uint32_t>(ctx->r[1]);
|
||||
uint32_t back1 = xe::load_and_swap<uint32_t>(ctx->TranslateVirtual(sp));
|
||||
if (back1) {
|
||||
uint32_t back2 =
|
||||
xe::load_and_swap<uint32_t>(ctx->TranslateVirtual(back1));
|
||||
if (back2) {
|
||||
guest_lr =
|
||||
xe::load_and_swap<uint32_t>(ctx->TranslateVirtual(back2 - 8));
|
||||
}
|
||||
}
|
||||
XELOGKERNEL(
|
||||
"AUDIT-HLC ExCreateThread entry={:08X} start_ctx={:08X} xapi={:08X} "
|
||||
"flags={:08X} lr={:08X} guest_lr={:08X}",
|
||||
uint32_t(start_address), uint32_t(start_context),
|
||||
uint32_t(xapi_thread_startup), uint32_t(creation_flags), lr, guest_lr);
|
||||
}
|
||||
return ExCreateThread(handle_ptr, stack_size, thread_id_ptr,
|
||||
xapi_thread_startup, start_address, start_context,
|
||||
creation_flags);
|
||||
@@ -547,6 +576,48 @@ uint32_t xeKeSetEvent(X_KEVENT* event_ptr, uint32_t increment, uint32_t wait) {
|
||||
|
||||
dword_result_t KeSetEvent_entry(pointer_t<X_KEVENT> event_ptr,
|
||||
dword_t increment, dword_t wait) {
|
||||
if (cvars::audit_handle_lifecycle) {
|
||||
uint32_t lr = static_cast<uint32_t>(cpu::ThreadState::Get()->context()->lr);
|
||||
XELOGKERNEL("AUDIT-HLC KeSetEvent guest_ptr={:08X} lr={:08X}",
|
||||
uint32_t(event_ptr.guest_address()), lr);
|
||||
// AUDIT-HLC round5: one-shot hexdump of the silph::WorkerCtx context when
|
||||
// KeSetEvent first fires into the silph UI PKEVENT cluster
|
||||
// (0xBCE25214/24/34/44 in current builds; widened a bit for allocator
|
||||
// drift). Used by iterate 2.BF context-replication.
|
||||
uint32_t ev_addr = uint32_t(event_ptr.guest_address());
|
||||
if (ev_addr >= 0xBCE25200 && ev_addr < 0xBCE25300) {
|
||||
if (!g_audit_silph_ctx_dumped.exchange(true)) {
|
||||
// Events live at ctx+0x54, +0x64, +0x74, +0x84 (16-byte stride).
|
||||
// Compute ctx_base assuming the canonical layout (lowest event at
|
||||
// ctx+0x54 → ctx_base = 0xBCE251C0 when ev_addr == 0xBCE25214).
|
||||
uint32_t event_offset_in_ctx = ev_addr - 0xBCE251C0;
|
||||
uint32_t ctx_base = ev_addr - event_offset_in_ctx;
|
||||
auto* ctx = cpu::ThreadState::Get()->context();
|
||||
uint8_t* host = ctx->TranslateVirtual(ctx_base);
|
||||
XELOGKERNEL(
|
||||
"AUDIT-HLC silph_ctx_dump ctx_base={:08X} (event {:08X} at +{:02X})",
|
||||
ctx_base, ev_addr, event_offset_in_ctx);
|
||||
for (uint32_t off = 0; off < 0x300; off += 16) {
|
||||
uint32_t d0 = xe::load_and_swap<uint32_t>(host + off + 0);
|
||||
uint32_t d1 = xe::load_and_swap<uint32_t>(host + off + 4);
|
||||
uint32_t d2 = xe::load_and_swap<uint32_t>(host + off + 8);
|
||||
uint32_t d3 = xe::load_and_swap<uint32_t>(host + off + 12);
|
||||
XELOGKERNEL("AUDIT-HLC DUMP {:08X}: {:08X} {:08X} {:08X} {:08X}",
|
||||
ctx_base + off, d0, d1, d2, d3);
|
||||
}
|
||||
XELOGKERNEL("AUDIT-HLC silph_ctx event-slots:");
|
||||
for (uint32_t i = 0; i < 8; ++i) {
|
||||
uint32_t ev_off = 0x54 + i * 0x10;
|
||||
uint32_t hdr = xe::load_and_swap<uint32_t>(host + ev_off + 0);
|
||||
uint32_t state = xe::load_and_swap<uint32_t>(host + ev_off + 4);
|
||||
XELOGKERNEL(
|
||||
"AUDIT-HLC slot[{}] off=+{:02X} addr={:08X} hdr={:08X} "
|
||||
"state={:08X}",
|
||||
i, ev_off, ctx_base + ev_off, hdr, state);
|
||||
}
|
||||
}
|
||||
}
|
||||
}
|
||||
return xeKeSetEvent(event_ptr, increment, wait);
|
||||
}
|
||||
DECLARE_XBOXKRNL_EXPORT2(KeSetEvent, kThreading, kImplemented, kHighFrequency);
|
||||
@@ -604,6 +675,29 @@ dword_result_t NtCreateEvent_entry(
|
||||
if (handle_ptr) {
|
||||
*handle_ptr = ev->handle();
|
||||
}
|
||||
if (cvars::audit_handle_lifecycle) {
|
||||
uint32_t lr = static_cast<uint32_t>(cpu::ThreadState::Get()->context()->lr);
|
||||
uint32_t out_handle = handle_ptr ? uint32_t(*handle_ptr) : 0u;
|
||||
XELOGKERNEL(
|
||||
"AUDIT-HLC NtCreateEvent handle={:08X} type={} initial_state={} "
|
||||
"lr={:08X}",
|
||||
out_handle, uint32_t(event_type), uint32_t(initial_state), lr);
|
||||
// Round-24: also log the underlying X_KEVENT guest VA for every
|
||||
// NtCreateEvent so KeSetEvent probes can be cross-referenced by ptr.
|
||||
XELOGKERNEL(
|
||||
"AUDIT-HLC NtCreateEvent_inner handle={:08X} kevent_va={:08X} "
|
||||
"lr={:08X}",
|
||||
out_handle, ev->guest_object(), lr);
|
||||
// When caller pinned a target handle, additionally emit the legacy
|
||||
// _target line so older round-24 grep recipes still match.
|
||||
if (cvars::audit_track_event_handle != 0 &&
|
||||
out_handle == cvars::audit_track_event_handle) {
|
||||
XELOGKERNEL(
|
||||
"AUDIT-HLC NtCreateEvent_target handle={:08X} object_va={:08X} "
|
||||
"lr={:08X}",
|
||||
out_handle, ev->guest_object(), lr);
|
||||
}
|
||||
}
|
||||
return X_STATUS_SUCCESS;
|
||||
}
|
||||
DECLARE_XBOXKRNL_EXPORT1(NtCreateEvent, kThreading, kImplemented);
|
||||
@@ -629,6 +723,26 @@ uint32_t xeNtSetEvent(uint32_t handle, xe::be<uint32_t>* previous_state_ptr) {
|
||||
}
|
||||
|
||||
dword_result_t NtSetEvent_entry(dword_t handle, lpdword_t previous_state_ptr) {
|
||||
if (cvars::audit_handle_lifecycle) {
|
||||
auto* ctx = cpu::ThreadState::Get()->context();
|
||||
uint32_t lr = static_cast<uint32_t>(ctx->lr);
|
||||
// Round-24: walk PPC back-chain for caller's guest LR (same idiom as
|
||||
// NtWaitForSingleObjectEx probe).
|
||||
uint32_t guest_lr = 0;
|
||||
uint32_t sp = static_cast<uint32_t>(ctx->r[1]);
|
||||
uint32_t back1 = xe::load_and_swap<uint32_t>(ctx->TranslateVirtual(sp));
|
||||
if (back1) {
|
||||
uint32_t back2 =
|
||||
xe::load_and_swap<uint32_t>(ctx->TranslateVirtual(back1));
|
||||
if (back2) {
|
||||
guest_lr = xe::load_and_swap<uint32_t>(
|
||||
ctx->TranslateVirtual(back2 - 8));
|
||||
}
|
||||
}
|
||||
XELOGKERNEL(
|
||||
"AUDIT-HLC NtSetEvent handle={:08X} lr={:08X} guest_lr={:08X}",
|
||||
uint32_t(handle), lr, guest_lr);
|
||||
}
|
||||
return xeNtSetEvent(handle, previous_state_ptr);
|
||||
}
|
||||
DECLARE_XBOXKRNL_EXPORT2(NtSetEvent, kThreading, kImplemented, kHighFrequency);
|
||||
@@ -1003,9 +1117,43 @@ dword_result_t NtWaitForSingleObjectEx_entry(dword_t object_handle,
|
||||
dword_t wait_mode,
|
||||
dword_t alertable,
|
||||
lpqword_t timeout_ptr) {
|
||||
uint32_t lr_enter = 0;
|
||||
uint32_t guest_lr = 0;
|
||||
if (cvars::audit_handle_lifecycle) {
|
||||
auto* ctx = cpu::ThreadState::Get()->context();
|
||||
lr_enter = static_cast<uint32_t>(ctx->lr);
|
||||
// Walk one PPC stack frame up from the wait wrapper's frame to recover
|
||||
// the GUEST caller's LR (lr_enter is just the kernel-internal wait
|
||||
// wrapper's return address; we want the function that called *it*).
|
||||
// Xbox 360 PPC convention: prologue stores caller's LR at [old_sp - 8]
|
||||
// *before* bumping r1 to the new frame, so from any frame, the LR saved
|
||||
// by that frame's prologue lives at (back_chain - 8). See xenia-rs
|
||||
// walk_guest_back_chain in crates/xenia-kernel/src/state.rs.
|
||||
uint32_t sp = static_cast<uint32_t>(ctx->r[1]);
|
||||
uint32_t back1 = xe::load_and_swap<uint32_t>(ctx->TranslateVirtual(sp));
|
||||
if (back1) {
|
||||
uint32_t back2 =
|
||||
xe::load_and_swap<uint32_t>(ctx->TranslateVirtual(back1));
|
||||
if (back2) {
|
||||
guest_lr = xe::load_and_swap<uint32_t>(
|
||||
ctx->TranslateVirtual(back2 - 8));
|
||||
}
|
||||
}
|
||||
XELOGKERNEL(
|
||||
"AUDIT-HLC NtWaitForSingleObjectEx handle={:08X} alertable={} "
|
||||
"lr={:08X} guest_lr={:08X}",
|
||||
uint32_t(object_handle), uint32_t(alertable), lr_enter, guest_lr);
|
||||
}
|
||||
uint64_t timeout = timeout_ptr ? static_cast<uint64_t>(*timeout_ptr) : 0u;
|
||||
return NtWaitForSingleObjectEx(object_handle, wait_mode, alertable,
|
||||
timeout_ptr ? &timeout : nullptr);
|
||||
uint32_t result = NtWaitForSingleObjectEx(object_handle, wait_mode, alertable,
|
||||
timeout_ptr ? &timeout : nullptr);
|
||||
if (cvars::audit_handle_lifecycle) {
|
||||
XELOGKERNEL(
|
||||
"AUDIT-HLC NtWaitForSingleObjectEx_done handle={:08X} result={:08X} "
|
||||
"lr={:08X} guest_lr={:08X}",
|
||||
uint32_t(object_handle), result, lr_enter, guest_lr);
|
||||
}
|
||||
return result;
|
||||
}
|
||||
DECLARE_XBOXKRNL_EXPORT3(NtWaitForSingleObjectEx, kThreading, kImplemented,
|
||||
kBlocking, kHighFrequency);
|
||||
|
||||
@@ -11,6 +11,8 @@
|
||||
|
||||
#include "xenia/base/byte_stream.h"
|
||||
#include "xenia/base/logging.h"
|
||||
#include "xenia/cpu/thread_state.h"
|
||||
#include "xenia/kernel/kernel_flags.h"
|
||||
|
||||
namespace xe {
|
||||
namespace kernel {
|
||||
@@ -58,6 +60,13 @@ void XEvent::InitializeNative(void* native_ptr, X_DISPATCH_HEADER* header) {
|
||||
}
|
||||
|
||||
int32_t XEvent::Set(uint32_t priority_increment, bool wait) {
|
||||
if (cvars::audit_handle_lifecycle) {
|
||||
auto* ts = cpu::ThreadState::Get();
|
||||
uint32_t lr = ts ? static_cast<uint32_t>(ts->context()->lr) : 0u;
|
||||
XELOGKERNEL(
|
||||
"AUDIT-HLC XEvent::Set handle={:08X} kevent_va={:08X} prio={} lr={:08X}",
|
||||
handle(), guest_object(), priority_increment, lr);
|
||||
}
|
||||
set_priority_increment(priority_increment);
|
||||
event_->Set();
|
||||
return 1;
|
||||
|
||||
@@ -21,6 +21,7 @@
|
||||
#include "xenia/base/threading.h"
|
||||
#include "xenia/cpu/processor.h"
|
||||
#include "xenia/emulator.h"
|
||||
#include "xenia/kernel/kernel_flags.h"
|
||||
#include "xenia/kernel/kernel_state.h"
|
||||
#include "xenia/kernel/user_module.h"
|
||||
#include "xenia/kernel/xboxkrnl/xboxkrnl_threading.h"
|
||||
@@ -544,6 +545,13 @@ X_STATUS XThread::Terminate(int exit_code) {
|
||||
void XThread::Execute() {
|
||||
XELOGKERNEL("XThread::Execute thid {} (handle={:08X}, '{}', native={:08X})",
|
||||
thread_id_, handle(), thread_name_, thread_->system_id());
|
||||
if (cvars::audit_handle_lifecycle) {
|
||||
XELOGKERNEL(
|
||||
"AUDIT-HLC XThread::Execute tid={} start_address={:08X} "
|
||||
"start_context={:08X} xapi={:08X}",
|
||||
thread_id_, creation_params_.start_address,
|
||||
creation_params_.start_context, creation_params_.xapi_thread_startup);
|
||||
}
|
||||
// Let the kernel know we are starting.
|
||||
kernel_state()->OnThreadExecute(this);
|
||||
|
||||
|
||||
Reference in New Issue
Block a user