1 //===- Trace.cpp - XRay Trace Loading implementation. ---------------------===// 2 // 3 // The LLVM Compiler Infrastructure 4 // 5 // This file is distributed under the University of Illinois Open Source 6 // License. See LICENSE.TXT for details. 7 // 8 //===----------------------------------------------------------------------===// 9 // 10 // XRay log reader implementation. 11 // 12 //===----------------------------------------------------------------------===// 13 #include "llvm/XRay/Trace.h" 14 #include "llvm/ADT/STLExtras.h" 15 #include "llvm/Support/DataExtractor.h" 16 #include "llvm/Support/Error.h" 17 #include "llvm/Support/FileSystem.h" 18 #include "llvm/XRay/YAMLXRayRecord.h" 19 20 using namespace llvm; 21 using namespace llvm::xray; 22 using llvm::yaml::Input; 23 24 namespace { 25 using XRayRecordStorage = 26 std::aligned_storage<sizeof(XRayRecord), alignof(XRayRecord)>::type; 27 28 // Populates the FileHeader reference by reading the first 32 bytes of the file. 29 Error readBinaryFormatHeader(StringRef Data, XRayFileHeader &FileHeader) { 30 // FIXME: Maybe deduce whether the data is little or big-endian using some 31 // magic bytes in the beginning of the file? 32 33 // First 32 bytes of the file will always be the header. We assume a certain 34 // format here: 35 // 36 // (2) uint16 : version 37 // (2) uint16 : type 38 // (4) uint32 : bitfield 39 // (8) uint64 : cycle frequency 40 // (16) - : padding 41 42 DataExtractor HeaderExtractor(Data, true, 8); 43 uint32_t OffsetPtr = 0; 44 FileHeader.Version = HeaderExtractor.getU16(&OffsetPtr); 45 FileHeader.Type = HeaderExtractor.getU16(&OffsetPtr); 46 uint32_t Bitfield = HeaderExtractor.getU32(&OffsetPtr); 47 FileHeader.ConstantTSC = Bitfield & 1uL; 48 FileHeader.NonstopTSC = Bitfield & 1uL << 1; 49 FileHeader.CycleFrequency = HeaderExtractor.getU64(&OffsetPtr); 50 std::memcpy(&FileHeader.FreeFormData, Data.bytes_begin() + OffsetPtr, 16); 51 if (FileHeader.Version != 1 && FileHeader.Version != 2 && 52 FileHeader.Version != 3) 53 return make_error<StringError>( 54 Twine("Unsupported XRay file version: ") + Twine(FileHeader.Version), 55 std::make_error_code(std::errc::invalid_argument)); 56 return Error::success(); 57 } 58 59 Error loadNaiveFormatLog(StringRef Data, XRayFileHeader &FileHeader, 60 std::vector<XRayRecord> &Records) { 61 if (Data.size() < 32) 62 return make_error<StringError>( 63 "Not enough bytes for an XRay log.", 64 std::make_error_code(std::errc::invalid_argument)); 65 66 if (Data.size() - 32 == 0 || Data.size() % 32 != 0) 67 return make_error<StringError>( 68 "Invalid-sized XRay data.", 69 std::make_error_code(std::errc::invalid_argument)); 70 71 if (auto E = readBinaryFormatHeader(Data, FileHeader)) 72 return E; 73 74 // Each record after the header will be 32 bytes, in the following format: 75 // 76 // (2) uint16 : record type 77 // (1) uint8 : cpu id 78 // (1) uint8 : type 79 // (4) sint32 : function id 80 // (8) uint64 : tsc 81 // (4) uint32 : thread id 82 // (4) uint32 : process id 83 // (8) - : padding 84 for (auto S = Data.drop_front(32); !S.empty(); S = S.drop_front(32)) { 85 DataExtractor RecordExtractor(S, true, 8); 86 uint32_t OffsetPtr = 0; 87 switch (auto RecordType = RecordExtractor.getU16(&OffsetPtr)) { 88 case 0: { // Normal records. 89 Records.emplace_back(); 90 auto &Record = Records.back(); 91 Record.RecordType = RecordType; 92 Record.CPU = RecordExtractor.getU8(&OffsetPtr); 93 auto Type = RecordExtractor.getU8(&OffsetPtr); 94 switch (Type) { 95 case 0: 96 Record.Type = RecordTypes::ENTER; 97 break; 98 case 1: 99 Record.Type = RecordTypes::EXIT; 100 break; 101 case 2: 102 Record.Type = RecordTypes::TAIL_EXIT; 103 break; 104 case 3: 105 Record.Type = RecordTypes::ENTER_ARG; 106 break; 107 default: 108 return make_error<StringError>( 109 Twine("Unknown record type '") + Twine(int{Type}) + "'", 110 std::make_error_code(std::errc::executable_format_error)); 111 } 112 Record.FuncId = RecordExtractor.getSigned(&OffsetPtr, sizeof(int32_t)); 113 Record.TSC = RecordExtractor.getU64(&OffsetPtr); 114 Record.TId = RecordExtractor.getU32(&OffsetPtr); 115 Record.PId = RecordExtractor.getU32(&OffsetPtr); 116 break; 117 } 118 case 1: { // Arg payload record. 119 auto &Record = Records.back(); 120 // Advance two bytes to avoid padding. 121 OffsetPtr += 2; 122 int32_t FuncId = RecordExtractor.getSigned(&OffsetPtr, sizeof(int32_t)); 123 auto TId = RecordExtractor.getU32(&OffsetPtr); 124 auto PId = RecordExtractor.getU32(&OffsetPtr); 125 126 // Make a check for versions above 3 for the Pid field 127 if (Record.FuncId != FuncId || Record.TId != TId || 128 (FileHeader.Version >= 3 ? Record.PId != PId : false)) 129 return make_error<StringError>( 130 Twine("Corrupted log, found arg payload following non-matching " 131 "function + thread record. Record for function ") + 132 Twine(Record.FuncId) + " != " + Twine(FuncId) + "; offset: " + 133 Twine(S.data() - Data.data()), 134 std::make_error_code(std::errc::executable_format_error)); 135 136 auto Arg = RecordExtractor.getU64(&OffsetPtr); 137 Record.CallArgs.push_back(Arg); 138 break; 139 } 140 default: 141 return make_error<StringError>( 142 Twine("Unknown record type == ") + Twine(RecordType), 143 std::make_error_code(std::errc::executable_format_error)); 144 } 145 } 146 return Error::success(); 147 } 148 149 /// When reading from a Flight Data Recorder mode log, metadata records are 150 /// sparse compared to packed function records, so we must maintain state as we 151 /// read through the sequence of entries. This allows the reader to denormalize 152 /// the CPUId and Thread Id onto each Function Record and transform delta 153 /// encoded TSC values into absolute encodings on each record. 154 struct FDRState { 155 uint16_t CPUId; 156 uint16_t ThreadId; 157 int32_t ProcessId; 158 uint64_t BaseTSC; 159 160 /// Encode some of the state transitions for the FDR log reader as explicit 161 /// checks. These are expectations for the next Record in the stream. 162 enum class Token { 163 NEW_BUFFER_RECORD_OR_EOF, 164 WALLCLOCK_RECORD, 165 NEW_CPU_ID_RECORD, 166 FUNCTION_SEQUENCE, 167 SCAN_TO_END_OF_THREAD_BUF, 168 CUSTOM_EVENT_DATA, 169 CALL_ARGUMENT, 170 BUFFER_EXTENTS, 171 PID_RECORD, 172 }; 173 Token Expects; 174 175 // Each threads buffer may have trailing garbage to scan over, so we track our 176 // progress. 177 uint64_t CurrentBufferSize; 178 uint64_t CurrentBufferConsumed; 179 }; 180 181 const char *fdrStateToTwine(const FDRState::Token &state) { 182 switch (state) { 183 case FDRState::Token::NEW_BUFFER_RECORD_OR_EOF: 184 return "NEW_BUFFER_RECORD_OR_EOF"; 185 case FDRState::Token::WALLCLOCK_RECORD: 186 return "WALLCLOCK_RECORD"; 187 case FDRState::Token::NEW_CPU_ID_RECORD: 188 return "NEW_CPU_ID_RECORD"; 189 case FDRState::Token::FUNCTION_SEQUENCE: 190 return "FUNCTION_SEQUENCE"; 191 case FDRState::Token::SCAN_TO_END_OF_THREAD_BUF: 192 return "SCAN_TO_END_OF_THREAD_BUF"; 193 case FDRState::Token::CUSTOM_EVENT_DATA: 194 return "CUSTOM_EVENT_DATA"; 195 case FDRState::Token::CALL_ARGUMENT: 196 return "CALL_ARGUMENT"; 197 case FDRState::Token::BUFFER_EXTENTS: 198 return "BUFFER_EXTENTS"; 199 case FDRState::Token::PID_RECORD: 200 return "PID_RECORD"; 201 } 202 return "UNKNOWN"; 203 } 204 205 /// State transition when a NewBufferRecord is encountered. 206 Error processFDRNewBufferRecord(FDRState &State, uint8_t RecordFirstByte, 207 DataExtractor &RecordExtractor) { 208 209 if (State.Expects != FDRState::Token::NEW_BUFFER_RECORD_OR_EOF) 210 return make_error<StringError>( 211 Twine("Malformed log. Read New Buffer record kind out of sequence; " 212 "expected: ") + 213 fdrStateToTwine(State.Expects), 214 std::make_error_code(std::errc::executable_format_error)); 215 uint32_t OffsetPtr = 1; // 1 byte into record. 216 State.ThreadId = RecordExtractor.getU16(&OffsetPtr); 217 State.Expects = FDRState::Token::WALLCLOCK_RECORD; 218 return Error::success(); 219 } 220 221 /// State transition when an EndOfBufferRecord is encountered. 222 Error processFDREndOfBufferRecord(FDRState &State, uint8_t RecordFirstByte, 223 DataExtractor &RecordExtractor) { 224 if (State.Expects == FDRState::Token::NEW_BUFFER_RECORD_OR_EOF) 225 return make_error<StringError>( 226 Twine("Malformed log. Received EOB message without current buffer; " 227 "expected: ") + 228 fdrStateToTwine(State.Expects), 229 std::make_error_code(std::errc::executable_format_error)); 230 State.Expects = FDRState::Token::SCAN_TO_END_OF_THREAD_BUF; 231 return Error::success(); 232 } 233 234 /// State transition when a NewCPUIdRecord is encountered. 235 Error processFDRNewCPUIdRecord(FDRState &State, uint8_t RecordFirstByte, 236 DataExtractor &RecordExtractor) { 237 if (State.Expects != FDRState::Token::FUNCTION_SEQUENCE && 238 State.Expects != FDRState::Token::NEW_CPU_ID_RECORD) 239 return make_error<StringError>( 240 Twine("Malformed log. Read NewCPUId record kind out of sequence; " 241 "expected: ") + 242 fdrStateToTwine(State.Expects), 243 std::make_error_code(std::errc::executable_format_error)); 244 uint32_t OffsetPtr = 1; // Read starting after the first byte. 245 State.CPUId = RecordExtractor.getU16(&OffsetPtr); 246 State.BaseTSC = RecordExtractor.getU64(&OffsetPtr); 247 State.Expects = FDRState::Token::FUNCTION_SEQUENCE; 248 return Error::success(); 249 } 250 251 /// State transition when a TSCWrapRecord (overflow detection) is encountered. 252 Error processFDRTSCWrapRecord(FDRState &State, uint8_t RecordFirstByte, 253 DataExtractor &RecordExtractor) { 254 if (State.Expects != FDRState::Token::FUNCTION_SEQUENCE) 255 return make_error<StringError>( 256 Twine("Malformed log. Read TSCWrap record kind out of sequence; " 257 "expecting: ") + 258 fdrStateToTwine(State.Expects), 259 std::make_error_code(std::errc::executable_format_error)); 260 uint32_t OffsetPtr = 1; // Read starting after the first byte. 261 State.BaseTSC = RecordExtractor.getU64(&OffsetPtr); 262 return Error::success(); 263 } 264 265 /// State transition when a WallTimeMarkerRecord is encountered. 266 Error processFDRWallTimeRecord(FDRState &State, uint8_t RecordFirstByte, 267 DataExtractor &RecordExtractor) { 268 if (State.Expects != FDRState::Token::WALLCLOCK_RECORD) 269 return make_error<StringError>( 270 Twine("Malformed log. Read Wallclock record kind out of sequence; " 271 "expecting: ") + 272 fdrStateToTwine(State.Expects), 273 std::make_error_code(std::errc::executable_format_error)); 274 275 // TODO: Someday, reconcile the TSC ticks to wall clock time for presentation 276 // purposes. For now, we're ignoring these records. 277 State.Expects = FDRState::Token::NEW_CPU_ID_RECORD; 278 return Error::success(); 279 } 280 281 /// State transition when a PidRecord is encountered. 282 Error processFDRPidRecord(FDRState &State, uint8_t RecordFirstByte, 283 DataExtractor &RecordExtractor) { 284 285 if (State.Expects != FDRState::Token::PID_RECORD) 286 return make_error<StringError>( 287 Twine("Malformed log. Read Pid record kind out of sequence; " 288 "expected: ") + 289 fdrStateToTwine(State.Expects), 290 std::make_error_code(std::errc::executable_format_error)); 291 292 uint32_t OffsetPtr = 1; // Read starting after the first byte. 293 State.ProcessId = RecordExtractor.getU32(&OffsetPtr); 294 State.Expects = FDRState::Token::NEW_CPU_ID_RECORD; 295 return Error::success(); 296 } 297 298 /// State transition when a CustomEventMarker is encountered. 299 Error processCustomEventMarker(FDRState &State, uint8_t RecordFirstByte, 300 DataExtractor &RecordExtractor, 301 size_t &RecordSize) { 302 // We can encounter a CustomEventMarker anywhere in the log, so we can handle 303 // it regardless of the expectation. However, we do set the expectation to 304 // read a set number of fixed bytes, as described in the metadata. 305 uint32_t OffsetPtr = 1; // Read after the first byte. 306 uint32_t DataSize = RecordExtractor.getU32(&OffsetPtr); 307 uint64_t TSC = RecordExtractor.getU64(&OffsetPtr); 308 309 // FIXME: Actually represent the record through the API. For now we only 310 // skip through the data. 311 (void)TSC; 312 RecordSize = 16 + DataSize; 313 return Error::success(); 314 } 315 316 /// State transition when an BufferExtents record is encountered. 317 Error processBufferExtents(FDRState &State, uint8_t RecordFirstByte, 318 DataExtractor &RecordExtractor) { 319 if (State.Expects != FDRState::Token::BUFFER_EXTENTS) 320 return make_error<StringError>( 321 Twine("Malformed log. Buffer Extents unexpected; expected: ") + 322 fdrStateToTwine(State.Expects), 323 std::make_error_code(std::errc::executable_format_error)); 324 uint32_t OffsetPtr = 1; // Read after the first byte. 325 State.CurrentBufferSize = RecordExtractor.getU64(&OffsetPtr); 326 State.Expects = FDRState::Token::NEW_BUFFER_RECORD_OR_EOF; 327 return Error::success(); 328 } 329 330 /// State transition when a CallArgumentRecord is encountered. 331 Error processFDRCallArgumentRecord(FDRState &State, uint8_t RecordFirstByte, 332 DataExtractor &RecordExtractor, 333 std::vector<XRayRecord> &Records) { 334 uint32_t OffsetPtr = 1; // Read starting after the first byte. 335 auto &Enter = Records.back(); 336 337 if (Enter.Type != RecordTypes::ENTER) 338 return make_error<StringError>( 339 "CallArgument needs to be right after a function entry", 340 std::make_error_code(std::errc::executable_format_error)); 341 Enter.Type = RecordTypes::ENTER_ARG; 342 Enter.CallArgs.emplace_back(RecordExtractor.getU64(&OffsetPtr)); 343 return Error::success(); 344 } 345 346 /// Advances the state machine for reading the FDR record type by reading one 347 /// Metadata Record and updating the State appropriately based on the kind of 348 /// record encountered. The RecordKind is encoded in the first byte of the 349 /// Record, which the caller should pass in because they have already read it 350 /// to determine that this is a metadata record as opposed to a function record. 351 /// 352 /// Beginning with Version 2 of the FDR log, we do not depend on the size of the 353 /// buffer, but rather use the extents to determine how far to read in the log 354 /// for this particular buffer. 355 /// 356 /// In Version 3, FDR log now includes a pid metadata record after 357 /// WallTimeMarker 358 Error processFDRMetadataRecord(FDRState &State, uint8_t RecordFirstByte, 359 DataExtractor &RecordExtractor, 360 size_t &RecordSize, 361 std::vector<XRayRecord> &Records, 362 uint16_t Version) { 363 // The remaining 7 bits are the RecordKind enum. 364 uint8_t RecordKind = RecordFirstByte >> 1; 365 switch (RecordKind) { 366 case 0: // NewBuffer 367 if (auto E = 368 processFDRNewBufferRecord(State, RecordFirstByte, RecordExtractor)) 369 return E; 370 break; 371 case 1: // EndOfBuffer 372 if (Version >= 2) 373 return make_error<StringError>( 374 "Since Version 2 of FDR logging, we no longer support EOB records.", 375 std::make_error_code(std::errc::executable_format_error)); 376 if (auto E = processFDREndOfBufferRecord(State, RecordFirstByte, 377 RecordExtractor)) 378 return E; 379 break; 380 case 2: // NewCPUId 381 if (auto E = 382 processFDRNewCPUIdRecord(State, RecordFirstByte, RecordExtractor)) 383 return E; 384 break; 385 case 3: // TSCWrap 386 if (auto E = 387 processFDRTSCWrapRecord(State, RecordFirstByte, RecordExtractor)) 388 return E; 389 break; 390 case 4: // WallTimeMarker 391 if (auto E = 392 processFDRWallTimeRecord(State, RecordFirstByte, RecordExtractor)) 393 return E; 394 // In Version 3 and and above, a PidRecord is expected after WallTimeRecord 395 if (Version >= 3) 396 State.Expects = FDRState::Token::PID_RECORD; 397 break; 398 case 5: // CustomEventMarker 399 if (auto E = processCustomEventMarker(State, RecordFirstByte, 400 RecordExtractor, RecordSize)) 401 return E; 402 break; 403 case 6: // CallArgument 404 if (auto E = processFDRCallArgumentRecord(State, RecordFirstByte, 405 RecordExtractor, Records)) 406 return E; 407 break; 408 case 7: // BufferExtents 409 if (auto E = processBufferExtents(State, RecordFirstByte, RecordExtractor)) 410 return E; 411 break; 412 case 9: // Pid 413 if (auto E = processFDRPidRecord(State, RecordFirstByte, RecordExtractor)) 414 return E; 415 break; 416 default: 417 // Widen the record type to uint16_t to prevent conversion to char. 418 return make_error<StringError>( 419 Twine("Illegal metadata record type: ") 420 .concat(Twine(static_cast<unsigned>(RecordKind))), 421 std::make_error_code(std::errc::executable_format_error)); 422 } 423 return Error::success(); 424 } 425 426 /// Reads a function record from an FDR format log, appending a new XRayRecord 427 /// to the vector being populated and updating the State with a new value 428 /// reference value to interpret TSC deltas. 429 /// 430 /// The XRayRecord constructed includes information from the function record 431 /// processed here as well as Thread ID and CPU ID formerly extracted into 432 /// State. 433 Error processFDRFunctionRecord(FDRState &State, uint8_t RecordFirstByte, 434 DataExtractor &RecordExtractor, 435 std::vector<XRayRecord> &Records) { 436 switch (State.Expects) { 437 case FDRState::Token::NEW_BUFFER_RECORD_OR_EOF: 438 return make_error<StringError>( 439 "Malformed log. Received Function Record before new buffer setup.", 440 std::make_error_code(std::errc::executable_format_error)); 441 case FDRState::Token::WALLCLOCK_RECORD: 442 return make_error<StringError>( 443 "Malformed log. Received Function Record when expecting wallclock.", 444 std::make_error_code(std::errc::executable_format_error)); 445 case FDRState::Token::PID_RECORD: 446 return make_error<StringError>( 447 "Malformed log. Received Function Record when expecting pid.", 448 std::make_error_code(std::errc::executable_format_error)); 449 case FDRState::Token::NEW_CPU_ID_RECORD: 450 return make_error<StringError>( 451 "Malformed log. Received Function Record before first CPU record.", 452 std::make_error_code(std::errc::executable_format_error)); 453 default: 454 Records.emplace_back(); 455 auto &Record = Records.back(); 456 Record.RecordType = 0; // Record is type NORMAL. 457 // Strip off record type bit and use the next three bits. 458 uint8_t RecordType = (RecordFirstByte >> 1) & 0x07; 459 switch (RecordType) { 460 case static_cast<uint8_t>(RecordTypes::ENTER): 461 Record.Type = RecordTypes::ENTER; 462 break; 463 case static_cast<uint8_t>(RecordTypes::EXIT): 464 Record.Type = RecordTypes::EXIT; 465 break; 466 case static_cast<uint8_t>(RecordTypes::TAIL_EXIT): 467 Record.Type = RecordTypes::TAIL_EXIT; 468 break; 469 default: 470 // Cast to an unsigned integer to not interpret the record type as a char. 471 return make_error<StringError>( 472 Twine("Illegal function record type: ") 473 .concat(Twine(static_cast<unsigned>(RecordType))), 474 std::make_error_code(std::errc::executable_format_error)); 475 } 476 Record.CPU = State.CPUId; 477 Record.TId = State.ThreadId; 478 Record.PId = State.ProcessId; 479 // Back up to read first 32 bits, including the 4 we pulled RecordType 480 // and RecordKind out of. The remaining 28 are FunctionId. 481 uint32_t OffsetPtr = 0; 482 // Despite function Id being a signed int on XRayRecord, 483 // when it is written to an FDR format, the top bits are truncated, 484 // so it is effectively an unsigned value. When we shift off the 485 // top four bits, we want the shift to be logical, so we read as 486 // uint32_t. 487 uint32_t FuncIdBitField = RecordExtractor.getU32(&OffsetPtr); 488 Record.FuncId = FuncIdBitField >> 4; 489 // FunctionRecords have a 32 bit delta from the previous absolute TSC 490 // or TSC delta. If this would overflow, we should read a TSCWrap record 491 // with an absolute TSC reading. 492 uint64_t NewTSC = State.BaseTSC + RecordExtractor.getU32(&OffsetPtr); 493 State.BaseTSC = NewTSC; 494 Record.TSC = NewTSC; 495 } 496 return Error::success(); 497 } 498 499 /// Reads a log in FDR mode for version 1 of this binary format. FDR mode is 500 /// defined as part of the compiler-rt project in xray_fdr_logging.h, and such 501 /// a log consists of the familiar 32 bit XRayHeader, followed by sequences of 502 /// of interspersed 16 byte Metadata Records and 8 byte Function Records. 503 /// 504 /// The following is an attempt to document the grammar of the format, which is 505 /// parsed by this function for little-endian machines. Since the format makes 506 /// use of BitFields, when we support big-endian architectures, we will need to 507 /// adjust not only the endianness parameter to llvm's RecordExtractor, but also 508 /// the bit twiddling logic, which is consistent with the little-endian 509 /// convention that BitFields within a struct will first be packed into the 510 /// least significant bits the address they belong to. 511 /// 512 /// We expect a format complying with the grammar in the following pseudo-EBNF 513 /// in Version 1 of the FDR log. 514 /// 515 /// FDRLog: XRayFileHeader ThreadBuffer* 516 /// XRayFileHeader: 32 bytes to identify the log as FDR with machine metadata. 517 /// Includes BufferSize 518 /// ThreadBuffer: NewBuffer WallClockTime NewCPUId FunctionSequence EOB 519 /// BufSize: 8 byte unsigned integer indicating how large the buffer is. 520 /// NewBuffer: 16 byte metadata record with Thread Id. 521 /// WallClockTime: 16 byte metadata record with human readable time. 522 /// Pid: 16 byte metadata record with Pid 523 /// NewCPUId: 16 byte metadata record with CPUId and a 64 bit TSC reading. 524 /// EOB: 16 byte record in a thread buffer plus mem garbage to fill BufSize. 525 /// FunctionSequence: NewCPUId | TSCWrap | FunctionRecord 526 /// TSCWrap: 16 byte metadata record with a full 64 bit TSC reading. 527 /// FunctionRecord: 8 byte record with FunctionId, entry/exit, and TSC delta. 528 /// 529 /// In Version 2, we make the following changes: 530 /// 531 /// ThreadBuffer: BufferExtents NewBuffer WallClockTime NewCPUId 532 /// FunctionSequence 533 /// BufferExtents: 16 byte metdata record describing how many usable bytes are 534 /// in the buffer. This is measured from the start of the buffer 535 /// and must always be at least 48 (bytes). 536 /// 537 /// In Version 3, we make the following changes: 538 /// 539 /// ThreadBuffer: BufferExtents NewBuffer WallClockTime Pid NewCPUId 540 /// FunctionSequence 541 /// EOB: *deprecated* 542 Error loadFDRLog(StringRef Data, XRayFileHeader &FileHeader, 543 std::vector<XRayRecord> &Records) { 544 if (Data.size() < 32) 545 return make_error<StringError>( 546 "Not enough bytes for an XRay log.", 547 std::make_error_code(std::errc::invalid_argument)); 548 549 // For an FDR log, there are records sized 16 and 8 bytes. 550 // There actually may be no records if no non-trivial functions are 551 // instrumented. 552 if (Data.size() % 8 != 0) 553 return make_error<StringError>( 554 "Invalid-sized XRay data.", 555 std::make_error_code(std::errc::invalid_argument)); 556 557 if (auto E = readBinaryFormatHeader(Data, FileHeader)) 558 return E; 559 560 uint64_t BufferSize = 0; 561 { 562 StringRef ExtraDataRef(FileHeader.FreeFormData, 16); 563 DataExtractor ExtraDataExtractor(ExtraDataRef, true, 8); 564 uint32_t ExtraDataOffset = 0; 565 BufferSize = ExtraDataExtractor.getU64(&ExtraDataOffset); 566 } 567 568 FDRState::Token InitialExpectation; 569 switch (FileHeader.Version) { 570 case 1: 571 InitialExpectation = FDRState::Token::NEW_BUFFER_RECORD_OR_EOF; 572 break; 573 case 2: 574 case 3: 575 InitialExpectation = FDRState::Token::BUFFER_EXTENTS; 576 break; 577 default: 578 return make_error<StringError>( 579 Twine("Unsupported version '") + Twine(FileHeader.Version) + "'", 580 std::make_error_code(std::errc::executable_format_error)); 581 } 582 FDRState State{0, 0, 0, 0, InitialExpectation, BufferSize, 0}; 583 584 // RecordSize will tell the loop how far to seek ahead based on the record 585 // type that we have just read. 586 size_t RecordSize = 0; 587 for (auto S = Data.drop_front(32); !S.empty(); S = S.drop_front(RecordSize)) { 588 DataExtractor RecordExtractor(S, true, 8); 589 uint32_t OffsetPtr = 0; 590 if (State.Expects == FDRState::Token::SCAN_TO_END_OF_THREAD_BUF) { 591 RecordSize = State.CurrentBufferSize - State.CurrentBufferConsumed; 592 if (S.size() < RecordSize) { 593 return make_error<StringError>( 594 Twine("Incomplete thread buffer. Expected at least ") + 595 Twine(RecordSize) + " bytes but found " + Twine(S.size()), 596 make_error_code(std::errc::invalid_argument)); 597 } 598 State.CurrentBufferConsumed = 0; 599 State.Expects = FDRState::Token::NEW_BUFFER_RECORD_OR_EOF; 600 continue; 601 } 602 uint8_t BitField = RecordExtractor.getU8(&OffsetPtr); 603 bool isMetadataRecord = BitField & 0x01uL; 604 bool isBufferExtents = 605 (BitField >> 1) == 7; // BufferExtents record kind == 7 606 if (isMetadataRecord) { 607 RecordSize = 16; 608 if (auto E = 609 processFDRMetadataRecord(State, BitField, RecordExtractor, 610 RecordSize, Records, FileHeader.Version)) 611 return E; 612 } else { // Process Function Record 613 RecordSize = 8; 614 if (auto E = processFDRFunctionRecord(State, BitField, RecordExtractor, 615 Records)) 616 return E; 617 } 618 619 // The BufferExtents record is technically not part of the buffer, so we 620 // don't count the size of that record against the buffer's actual size. 621 if (!isBufferExtents) 622 State.CurrentBufferConsumed += RecordSize; 623 assert(State.CurrentBufferConsumed <= State.CurrentBufferSize); 624 if ((FileHeader.Version == 2 || FileHeader.Version == 3) && 625 State.CurrentBufferSize == State.CurrentBufferConsumed) { 626 // In Version 2 of the log, we don't need to scan to the end of the thread 627 // buffer if we've already consumed all the bytes we need to. 628 State.Expects = FDRState::Token::BUFFER_EXTENTS; 629 State.CurrentBufferSize = BufferSize; 630 State.CurrentBufferConsumed = 0; 631 } 632 } 633 634 // Having iterated over everything we've been given, we've either consumed 635 // everything and ended up in the end state, or were told to skip the rest. 636 bool Finished = State.Expects == FDRState::Token::SCAN_TO_END_OF_THREAD_BUF && 637 State.CurrentBufferSize == State.CurrentBufferConsumed; 638 if ((State.Expects != FDRState::Token::NEW_BUFFER_RECORD_OR_EOF && 639 State.Expects != FDRState::Token::BUFFER_EXTENTS) && 640 !Finished) 641 return make_error<StringError>( 642 Twine("Encountered EOF with unexpected state expectation ") + 643 fdrStateToTwine(State.Expects) + 644 ". Remaining expected bytes in thread buffer total " + 645 Twine(State.CurrentBufferSize - State.CurrentBufferConsumed), 646 std::make_error_code(std::errc::executable_format_error)); 647 648 return Error::success(); 649 } 650 651 Error loadYAMLLog(StringRef Data, XRayFileHeader &FileHeader, 652 std::vector<XRayRecord> &Records) { 653 YAMLXRayTrace Trace; 654 Input In(Data); 655 In >> Trace; 656 if (In.error()) 657 return make_error<StringError>("Failed loading YAML Data.", In.error()); 658 659 FileHeader.Version = Trace.Header.Version; 660 FileHeader.Type = Trace.Header.Type; 661 FileHeader.ConstantTSC = Trace.Header.ConstantTSC; 662 FileHeader.NonstopTSC = Trace.Header.NonstopTSC; 663 FileHeader.CycleFrequency = Trace.Header.CycleFrequency; 664 665 if (FileHeader.Version != 1) 666 return make_error<StringError>( 667 Twine("Unsupported XRay file version: ") + Twine(FileHeader.Version), 668 std::make_error_code(std::errc::invalid_argument)); 669 670 Records.clear(); 671 std::transform(Trace.Records.begin(), Trace.Records.end(), 672 std::back_inserter(Records), [&](const YAMLXRayRecord &R) { 673 return XRayRecord{R.RecordType, R.CPU, R.Type, R.FuncId, 674 R.TSC, R.TId, R.PId, R.CallArgs}; 675 }); 676 return Error::success(); 677 } 678 } // namespace 679 680 Expected<Trace> llvm::xray::loadTraceFile(StringRef Filename, bool Sort) { 681 int Fd; 682 if (auto EC = sys::fs::openFileForRead(Filename, Fd)) { 683 return make_error<StringError>( 684 Twine("Cannot read log from '") + Filename + "'", EC); 685 } 686 687 uint64_t FileSize; 688 if (auto EC = sys::fs::file_size(Filename, FileSize)) { 689 return make_error<StringError>( 690 Twine("Cannot read log from '") + Filename + "'", EC); 691 } 692 if (FileSize < 4) { 693 return make_error<StringError>( 694 Twine("File '") + Filename + "' too small for XRay.", 695 std::make_error_code(std::errc::executable_format_error)); 696 } 697 698 // Map the opened file into memory and use a StringRef to access it later. 699 std::error_code EC; 700 sys::fs::mapped_file_region MappedFile( 701 Fd, sys::fs::mapped_file_region::mapmode::readonly, FileSize, 0, EC); 702 if (EC) { 703 return make_error<StringError>( 704 Twine("Cannot read log from '") + Filename + "'", EC); 705 } 706 auto Data = StringRef(MappedFile.data(), MappedFile.size()); 707 708 // Attempt to detect the file type using file magic. We have a slight bias 709 // towards the binary format, and we do this by making sure that the first 4 710 // bytes of the binary file is some combination of the following byte 711 // patterns: (observe the code loading them assumes they're little endian) 712 // 713 // 0x01 0x00 0x00 0x00 - version 1, "naive" format 714 // 0x01 0x00 0x01 0x00 - version 1, "flight data recorder" format 715 // 0x02 0x00 0x01 0x00 - version 2, "flight data recorder" format 716 // 717 // YAML files don't typically have those first four bytes as valid text so we 718 // try loading assuming YAML if we don't find these bytes. 719 // 720 // Only if we can't load either the binary or the YAML format will we yield an 721 // error. 722 StringRef Magic(MappedFile.data(), 4); 723 DataExtractor HeaderExtractor(Magic, true, 8); 724 uint32_t OffsetPtr = 0; 725 uint16_t Version = HeaderExtractor.getU16(&OffsetPtr); 726 uint16_t Type = HeaderExtractor.getU16(&OffsetPtr); 727 728 enum BinaryFormatType { NAIVE_FORMAT = 0, FLIGHT_DATA_RECORDER_FORMAT = 1 }; 729 730 Trace T; 731 switch (Type) { 732 case NAIVE_FORMAT: 733 if (Version == 1 || Version == 2 || Version == 3) { 734 if (auto E = loadNaiveFormatLog(Data, T.FileHeader, T.Records)) 735 return std::move(E); 736 } else { 737 return make_error<StringError>( 738 Twine("Unsupported version for Basic/Naive Mode logging: ") + 739 Twine(Version), 740 std::make_error_code(std::errc::executable_format_error)); 741 } 742 break; 743 case FLIGHT_DATA_RECORDER_FORMAT: 744 if (Version == 1 || Version == 2 || Version == 3) { 745 if (auto E = loadFDRLog(Data, T.FileHeader, T.Records)) 746 return std::move(E); 747 } else { 748 return make_error<StringError>( 749 Twine("Unsupported version for FDR Mode logging: ") + Twine(Version), 750 std::make_error_code(std::errc::executable_format_error)); 751 } 752 break; 753 default: 754 if (auto E = loadYAMLLog(Data, T.FileHeader, T.Records)) 755 return std::move(E); 756 } 757 758 if (Sort) 759 std::stable_sort(T.Records.begin(), T.Records.end(), 760 [&](const XRayRecord &L, const XRayRecord &R) { 761 return L.TSC < R.TSC; 762 }); 763 764 return std::move(T); 765 } 766