1 | //===------- JITLoaderPerf.cpp - Register profiler objects ------*- C++ -*-===// |
2 | // |
3 | // Part of the LLVM Project, under the Apache License v2.0 with LLVM Exceptions. |
4 | // See https://llvm.org/LICENSE.txt for license information. |
5 | // SPDX-License-Identifier: Apache-2.0 WITH LLVM-exception |
6 | // |
7 | //===----------------------------------------------------------------------===// |
8 | // |
9 | // Register objects for access by profilers via the perf JIT interface. |
10 | // |
11 | //===----------------------------------------------------------------------===// |
12 | |
13 | #include "llvm/ExecutionEngine/Orc/TargetProcess/JITLoaderPerf.h" |
14 | |
15 | #include "llvm/ExecutionEngine/Orc/Shared/PerfSharedStructs.h" |
16 | |
17 | #include "llvm/Support/FileSystem.h" |
18 | #include "llvm/Support/MemoryBuffer.h" |
19 | #include "llvm/Support/Path.h" |
20 | #include "llvm/Support/Process.h" |
21 | #include "llvm/Support/Threading.h" |
22 | |
23 | #include <mutex> |
24 | #include <optional> |
25 | |
26 | #ifdef __linux__ |
27 | |
28 | #include <sys/mman.h> // mmap() |
29 | #include <time.h> // clock_gettime(), time(), localtime_r() */ |
30 | |
31 | #define DEBUG_TYPE "orc" |
32 | |
33 | // language identifier (XXX: should we generate something better from debug |
34 | // info?) |
35 | #define JIT_LANG "llvm-IR" |
36 | #define LLVM_PERF_JIT_MAGIC \ |
37 | ((uint32_t)'J' << 24 | (uint32_t)'i' << 16 | (uint32_t)'T' << 8 | \ |
38 | (uint32_t)'D') |
39 | #define LLVM_PERF_JIT_VERSION 1 |
40 | |
41 | using namespace llvm; |
42 | using namespace llvm::orc; |
43 | |
44 | struct PerfState { |
45 | // cache lookups |
46 | uint32_t Pid; |
47 | |
48 | // base directory for output data |
49 | std::string JitPath; |
50 | |
51 | // output data stream, closed via Dumpstream |
52 | int DumpFd = -1; |
53 | |
54 | // output data stream |
55 | std::unique_ptr<raw_fd_ostream> Dumpstream; |
56 | |
57 | // perf mmap marker |
58 | void *MarkerAddr = NULL; |
59 | }; |
60 | |
61 | // prevent concurrent dumps from messing up the output file |
62 | static std::mutex Mutex; |
63 | static std::optional<PerfState> State; |
64 | |
65 | struct { |
66 | uint32_t ; |
67 | uint32_t ; |
68 | uint64_t ; |
69 | }; |
70 | |
71 | struct DIR { |
72 | RecHeader Prefix; |
73 | uint64_t CodeAddr; |
74 | uint64_t NrEntry; |
75 | }; |
76 | |
77 | struct DIE { |
78 | uint64_t CodeAddr; |
79 | uint32_t Line; |
80 | uint32_t Discrim; |
81 | }; |
82 | |
83 | struct CLR { |
84 | RecHeader Prefix; |
85 | uint32_t Pid; |
86 | uint32_t Tid; |
87 | uint64_t Vma; |
88 | uint64_t CodeAddr; |
89 | uint64_t CodeSize; |
90 | uint64_t CodeIndex; |
91 | }; |
92 | |
93 | struct UWR { |
94 | RecHeader Prefix; |
95 | uint64_t UnwindDataSize; |
96 | uint64_t ; |
97 | uint64_t MappedSize; |
98 | }; |
99 | |
100 | static inline uint64_t timespec_to_ns(const struct timespec *TS) { |
101 | const uint64_t NanoSecPerSec = 1000000000; |
102 | return ((uint64_t)TS->tv_sec * NanoSecPerSec) + TS->tv_nsec; |
103 | } |
104 | |
105 | static inline uint64_t perf_get_timestamp() { |
106 | timespec TS; |
107 | if (clock_gettime(CLOCK_MONOTONIC, tp: &TS)) |
108 | return 0; |
109 | |
110 | return timespec_to_ns(TS: &TS); |
111 | } |
112 | |
113 | static void writeDebugRecord(const PerfJITDebugInfoRecord &DebugRecord) { |
114 | assert(State && "PerfState not initialized" ); |
115 | LLVM_DEBUG(dbgs() << "Writing debug record with " |
116 | << DebugRecord.Entries.size() << " entries\n" ); |
117 | [[maybe_unused]] size_t Written = 0; |
118 | DIR Dir{.Prefix: RecHeader{.Id: static_cast<uint32_t>(DebugRecord.Prefix.Id), |
119 | .TotalSize: DebugRecord.Prefix.TotalSize, .Timestamp: perf_get_timestamp()}, |
120 | .CodeAddr: DebugRecord.CodeAddr, .NrEntry: DebugRecord.Entries.size()}; |
121 | State->Dumpstream->write(Ptr: reinterpret_cast<const char *>(&Dir), Size: sizeof(Dir)); |
122 | Written += sizeof(Dir); |
123 | for (auto &Die : DebugRecord.Entries) { |
124 | DIE d{.CodeAddr: Die.Addr, .Line: Die.Lineno, .Discrim: Die.Discrim}; |
125 | State->Dumpstream->write(Ptr: reinterpret_cast<const char *>(&d), Size: sizeof(d)); |
126 | State->Dumpstream->write(Ptr: Die.Name.data(), Size: Die.Name.size() + 1); |
127 | Written += sizeof(d) + Die.Name.size() + 1; |
128 | } |
129 | LLVM_DEBUG(dbgs() << "wrote " << Written << " bytes of debug info\n" ); |
130 | } |
131 | |
132 | static void writeCodeRecord(const PerfJITCodeLoadRecord &CodeRecord) { |
133 | assert(State && "PerfState not initialized" ); |
134 | uint32_t Tid = get_threadid(); |
135 | LLVM_DEBUG(dbgs() << "Writing code record with code size " |
136 | << CodeRecord.CodeSize << " and code index " |
137 | << CodeRecord.CodeIndex << "\n" ); |
138 | CLR Clr{.Prefix: RecHeader{.Id: static_cast<uint32_t>(CodeRecord.Prefix.Id), |
139 | .TotalSize: CodeRecord.Prefix.TotalSize, .Timestamp: perf_get_timestamp()}, |
140 | .Pid: State->Pid, |
141 | .Tid: Tid, |
142 | .Vma: CodeRecord.Vma, |
143 | .CodeAddr: CodeRecord.CodeAddr, |
144 | .CodeSize: CodeRecord.CodeSize, |
145 | .CodeIndex: CodeRecord.CodeIndex}; |
146 | LLVM_DEBUG(dbgs() << "wrote " << sizeof(Clr) << " bytes of CLR, " |
147 | << CodeRecord.Name.size() + 1 << " bytes of name, " |
148 | << CodeRecord.CodeSize << " bytes of code\n" ); |
149 | State->Dumpstream->write(Ptr: reinterpret_cast<const char *>(&Clr), Size: sizeof(Clr)); |
150 | State->Dumpstream->write(Ptr: CodeRecord.Name.data(), Size: CodeRecord.Name.size() + 1); |
151 | State->Dumpstream->write(Ptr: (const char *)CodeRecord.CodeAddr, |
152 | Size: CodeRecord.CodeSize); |
153 | } |
154 | |
155 | static void |
156 | writeUnwindRecord(const PerfJITCodeUnwindingInfoRecord &UnwindRecord) { |
157 | assert(State && "PerfState not initialized" ); |
158 | dbgs() << "Writing unwind record with unwind data size " |
159 | << UnwindRecord.UnwindDataSize << " and EH frame header size " |
160 | << UnwindRecord.EHFrameHdrSize << " and mapped size " |
161 | << UnwindRecord.MappedSize << "\n" ; |
162 | UWR Uwr{.Prefix: RecHeader{.Id: static_cast<uint32_t>(UnwindRecord.Prefix.Id), |
163 | .TotalSize: UnwindRecord.Prefix.TotalSize, .Timestamp: perf_get_timestamp()}, |
164 | .UnwindDataSize: UnwindRecord.UnwindDataSize, .EhFrameHeaderSize: UnwindRecord.EHFrameHdrSize, |
165 | .MappedSize: UnwindRecord.MappedSize}; |
166 | LLVM_DEBUG(dbgs() << "wrote " << sizeof(Uwr) << " bytes of UWR, " |
167 | << UnwindRecord.EHFrameHdrSize |
168 | << " bytes of EH frame header, " |
169 | << UnwindRecord.UnwindDataSize - UnwindRecord.EHFrameHdrSize |
170 | << " bytes of EH frame\n" ); |
171 | State->Dumpstream->write(Ptr: reinterpret_cast<const char *>(&Uwr), Size: sizeof(Uwr)); |
172 | if (UnwindRecord.EHFrameHdrAddr) |
173 | State->Dumpstream->write(Ptr: (const char *)UnwindRecord.EHFrameHdrAddr, |
174 | Size: UnwindRecord.EHFrameHdrSize); |
175 | else |
176 | State->Dumpstream->write(Ptr: UnwindRecord.EHFrameHdr.data(), |
177 | Size: UnwindRecord.EHFrameHdrSize); |
178 | State->Dumpstream->write(Ptr: (const char *)UnwindRecord.EHFrameAddr, |
179 | Size: UnwindRecord.UnwindDataSize - |
180 | UnwindRecord.EHFrameHdrSize); |
181 | } |
182 | |
183 | static Error registerJITLoaderPerfImpl(const PerfJITRecordBatch &Batch) { |
184 | if (!State) |
185 | return make_error<StringError>(Args: "PerfState not initialized" , |
186 | Args: inconvertibleErrorCode()); |
187 | |
188 | // Serialize the batch |
189 | std::lock_guard<std::mutex> Lock(Mutex); |
190 | if (Batch.UnwindingRecord.Prefix.TotalSize > 0) |
191 | writeUnwindRecord(UnwindRecord: Batch.UnwindingRecord); |
192 | |
193 | for (const auto &DebugInfo : Batch.DebugInfoRecords) |
194 | writeDebugRecord(DebugRecord: DebugInfo); |
195 | |
196 | for (const auto &CodeLoad : Batch.CodeLoadRecords) |
197 | writeCodeRecord(CodeRecord: CodeLoad); |
198 | |
199 | State->Dumpstream->flush(); |
200 | |
201 | return Error::success(); |
202 | } |
203 | |
204 | struct { |
205 | uint32_t ; // characters "JiTD" |
206 | uint32_t ; // header version |
207 | uint32_t ; // total size of header |
208 | uint32_t ; // elf mach target |
209 | uint32_t ; // reserved |
210 | uint32_t ; |
211 | uint64_t ; // timestamp |
212 | uint64_t ; // flags |
213 | }; |
214 | |
215 | static Error OpenMarker(PerfState &State) { |
216 | // We mmap the jitdump to create an MMAP RECORD in perf.data file. The mmap |
217 | // is captured either live (perf record running when we mmap) or in deferred |
218 | // mode, via /proc/PID/maps. The MMAP record is used as a marker of a jitdump |
219 | // file for more meta data info about the jitted code. Perf report/annotate |
220 | // detect this special filename and process the jitdump file. |
221 | // |
222 | // Mapping must be PROT_EXEC to ensure it is captured by perf record |
223 | // even when not using -d option. |
224 | State.MarkerAddr = |
225 | ::mmap(NULL, len: sys::Process::getPageSizeEstimate(), PROT_READ | PROT_EXEC, |
226 | MAP_PRIVATE, fd: State.DumpFd, offset: 0); |
227 | |
228 | if (State.MarkerAddr == MAP_FAILED) |
229 | return make_error<llvm::StringError>(Args: "could not mmap JIT marker" , |
230 | Args: inconvertibleErrorCode()); |
231 | |
232 | return Error::success(); |
233 | } |
234 | |
235 | void CloseMarker(PerfState &State) { |
236 | if (!State.MarkerAddr) |
237 | return; |
238 | |
239 | munmap(addr: State.MarkerAddr, len: sys::Process::getPageSizeEstimate()); |
240 | State.MarkerAddr = nullptr; |
241 | } |
242 | |
243 | static Expected<Header> FillMachine(PerfState &State) { |
244 | Header Hdr; |
245 | Hdr.Magic = LLVM_PERF_JIT_MAGIC; |
246 | Hdr.Version = LLVM_PERF_JIT_VERSION; |
247 | Hdr.TotalSize = sizeof(Hdr); |
248 | Hdr.Pid = State.Pid; |
249 | Hdr.Timestamp = perf_get_timestamp(); |
250 | |
251 | char Id[16]; |
252 | struct { |
253 | uint16_t e_type; |
254 | uint16_t e_machine; |
255 | } Info; |
256 | |
257 | size_t RequiredMemory = sizeof(Id) + sizeof(Info); |
258 | |
259 | ErrorOr<std::unique_ptr<MemoryBuffer>> MB = |
260 | MemoryBuffer::getFileSlice(Filename: "/proc/self/exe" , MapSize: RequiredMemory, Offset: 0); |
261 | |
262 | // This'll not guarantee that enough data was actually read from the |
263 | // underlying file. Instead the trailing part of the buffer would be |
264 | // zeroed. Given the ELF signature check below that seems ok though, |
265 | // it's unlikely that the file ends just after that, and the |
266 | // consequence would just be that perf wouldn't recognize the |
267 | // signature. |
268 | if (!MB) |
269 | return make_error<llvm::StringError>(Args: "could not open /proc/self/exe" , |
270 | Args: MB.getError()); |
271 | |
272 | memcpy(dest: &Id, src: (*MB)->getBufferStart(), n: sizeof(Id)); |
273 | memcpy(dest: &Info, src: (*MB)->getBufferStart() + sizeof(Id), n: sizeof(Info)); |
274 | |
275 | // check ELF signature |
276 | if (Id[0] != 0x7f || Id[1] != 'E' || Id[2] != 'L' || Id[3] != 'F') |
277 | return make_error<llvm::StringError>(Args: "invalid ELF signature" , |
278 | Args: inconvertibleErrorCode()); |
279 | |
280 | Hdr.ElfMach = Info.e_machine; |
281 | |
282 | return Hdr; |
283 | } |
284 | |
285 | static Error InitDebuggingDir(PerfState &State) { |
286 | time_t Time; |
287 | struct tm LocalTime; |
288 | char TimeBuffer[sizeof("YYYYMMDD" )]; |
289 | SmallString<64> Path; |
290 | |
291 | // search for location to dump data to |
292 | if (const char *BaseDir = getenv(name: "JITDUMPDIR" )) |
293 | Path.append(RHS: BaseDir); |
294 | else if (!sys::path::home_directory(result&: Path)) |
295 | Path = "." ; |
296 | |
297 | // create debug directory |
298 | Path += "/.debug/jit/" ; |
299 | if (auto EC = sys::fs::create_directories(path: Path)) { |
300 | std::string ErrStr; |
301 | raw_string_ostream ErrStream(ErrStr); |
302 | ErrStream << "could not create jit cache directory " << Path << ": " |
303 | << EC.message() << "\n" ; |
304 | return make_error<StringError>(Args: std::move(ErrStr), Args: inconvertibleErrorCode()); |
305 | } |
306 | |
307 | // create unique directory for dump data related to this process |
308 | time(timer: &Time); |
309 | localtime_r(timer: &Time, tp: &LocalTime); |
310 | strftime(s: TimeBuffer, maxsize: sizeof(TimeBuffer), format: "%Y%m%d" , tp: &LocalTime); |
311 | Path += JIT_LANG "-jit-" ; |
312 | Path += TimeBuffer; |
313 | |
314 | SmallString<128> UniqueDebugDir; |
315 | |
316 | using sys::fs::createUniqueDirectory; |
317 | if (auto EC = createUniqueDirectory(Prefix: Path, ResultPath&: UniqueDebugDir)) { |
318 | std::string ErrStr; |
319 | raw_string_ostream ErrStream(ErrStr); |
320 | ErrStream << "could not create unique jit cache directory " |
321 | << UniqueDebugDir << ": " << EC.message() << "\n" ; |
322 | return make_error<StringError>(Args: std::move(ErrStr), Args: inconvertibleErrorCode()); |
323 | } |
324 | |
325 | State.JitPath = std::string(UniqueDebugDir); |
326 | |
327 | return Error::success(); |
328 | } |
329 | |
330 | static Error registerJITLoaderPerfStartImpl() { |
331 | PerfState Tentative; |
332 | Tentative.Pid = sys::Process::getProcessId(); |
333 | // check if clock-source is supported |
334 | if (!perf_get_timestamp()) |
335 | return make_error<StringError>(Args: "kernel does not support CLOCK_MONOTONIC" , |
336 | Args: inconvertibleErrorCode()); |
337 | |
338 | if (auto Err = InitDebuggingDir(State&: Tentative)) |
339 | return Err; |
340 | |
341 | std::string Filename; |
342 | raw_string_ostream FilenameBuf(Filename); |
343 | FilenameBuf << Tentative.JitPath << "/jit-" << Tentative.Pid << ".dump" ; |
344 | |
345 | // Need to open ourselves, because we need to hand the FD to OpenMarker() and |
346 | // raw_fd_ostream doesn't expose the FD. |
347 | using sys::fs::openFileForWrite; |
348 | if (auto EC = openFileForReadWrite(Name: Filename, ResultFD&: Tentative.DumpFd, |
349 | Disp: sys::fs::CD_CreateNew, Flags: sys::fs::OF_None)) { |
350 | std::string ErrStr; |
351 | raw_string_ostream ErrStream(ErrStr); |
352 | ErrStream << "could not open JIT dump file " << Filename << ": " |
353 | << EC.message() << "\n" ; |
354 | return make_error<StringError>(Args: std::move(ErrStr), Args: inconvertibleErrorCode()); |
355 | } |
356 | |
357 | Tentative.Dumpstream = |
358 | std::make_unique<raw_fd_ostream>(args&: Tentative.DumpFd, args: true); |
359 | |
360 | auto = FillMachine(State&: Tentative); |
361 | if (!Header) |
362 | return Header.takeError(); |
363 | |
364 | // signal this process emits JIT information |
365 | if (auto Err = OpenMarker(State&: Tentative)) |
366 | return Err; |
367 | |
368 | Tentative.Dumpstream->write(Ptr: reinterpret_cast<const char *>(&Header.get()), |
369 | Size: sizeof(*Header)); |
370 | |
371 | // Everything initialized, can do profiling now. |
372 | if (Tentative.Dumpstream->has_error()) |
373 | return make_error<StringError>(Args: "could not write JIT dump header" , |
374 | Args: inconvertibleErrorCode()); |
375 | |
376 | State = std::move(Tentative); |
377 | return Error::success(); |
378 | } |
379 | |
380 | static Error registerJITLoaderPerfEndImpl() { |
381 | if (!State) |
382 | return make_error<StringError>(Args: "PerfState not initialized" , |
383 | Args: inconvertibleErrorCode()); |
384 | |
385 | RecHeader Close; |
386 | Close.Id = static_cast<uint32_t>(PerfJITRecordType::JIT_CODE_CLOSE); |
387 | Close.TotalSize = sizeof(Close); |
388 | Close.Timestamp = perf_get_timestamp(); |
389 | State->Dumpstream->write(Ptr: reinterpret_cast<const char *>(&Close), |
390 | Size: sizeof(Close)); |
391 | if (State->MarkerAddr) |
392 | CloseMarker(State&: *State); |
393 | |
394 | State.reset(); |
395 | return Error::success(); |
396 | } |
397 | |
398 | extern "C" llvm::orc::shared::CWrapperFunctionResult |
399 | llvm_orc_registerJITLoaderPerfImpl(const char *ArgData, size_t ArgSize) { |
400 | using namespace orc::shared; |
401 | return WrapperFunction<SPSError(SPSPerfJITRecordBatch)>::handle( |
402 | ArgData, ArgSize, Handler&: registerJITLoaderPerfImpl) |
403 | .release(); |
404 | } |
405 | |
406 | extern "C" llvm::orc::shared::CWrapperFunctionResult |
407 | llvm_orc_registerJITLoaderPerfStart(const char *ArgData, size_t ArgSize) { |
408 | using namespace orc::shared; |
409 | return WrapperFunction<SPSError()>::handle(ArgData, ArgSize, |
410 | Handler&: registerJITLoaderPerfStartImpl) |
411 | .release(); |
412 | } |
413 | |
414 | extern "C" llvm::orc::shared::CWrapperFunctionResult |
415 | llvm_orc_registerJITLoaderPerfEnd(const char *ArgData, size_t ArgSize) { |
416 | using namespace orc::shared; |
417 | return WrapperFunction<SPSError()>::handle(ArgData, ArgSize, |
418 | Handler&: registerJITLoaderPerfEndImpl) |
419 | .release(); |
420 | } |
421 | |
422 | #else |
423 | |
424 | using namespace llvm; |
425 | using namespace llvm::orc; |
426 | |
427 | static Error badOS() { |
428 | using namespace llvm; |
429 | return llvm::make_error<StringError>( |
430 | "unsupported OS (perf support is only available on linux!)" , |
431 | inconvertibleErrorCode()); |
432 | } |
433 | |
434 | static Error badOSBatch(PerfJITRecordBatch &Batch) { return badOS(); } |
435 | |
436 | extern "C" llvm::orc::shared::CWrapperFunctionResult |
437 | llvm_orc_registerJITLoaderPerfImpl(const char *ArgData, size_t ArgSize) { |
438 | using namespace shared; |
439 | return WrapperFunction<SPSError(SPSPerfJITRecordBatch)>::handle( |
440 | ArgData, ArgSize, badOSBatch) |
441 | .release(); |
442 | } |
443 | |
444 | extern "C" llvm::orc::shared::CWrapperFunctionResult |
445 | llvm_orc_registerJITLoaderPerfStart(const char *ArgData, size_t ArgSize) { |
446 | using namespace shared; |
447 | return WrapperFunction<SPSError()>::handle(ArgData, ArgSize, badOS).release(); |
448 | } |
449 | |
450 | extern "C" llvm::orc::shared::CWrapperFunctionResult |
451 | llvm_orc_registerJITLoaderPerfEnd(const char *ArgData, size_t ArgSize) { |
452 | using namespace shared; |
453 | return WrapperFunction<SPSError()>::handle(ArgData, ArgSize, badOS).release(); |
454 | } |
455 | |
456 | #endif |
457 | |