/**************************************************************************** ** ** Copyright (C) 2016 The Qt Company Ltd. ** Contact: https://www.qt.io/licensing/ ** ** This file is part of Qt Creator. ** ** Commercial License Usage ** Licensees holding valid commercial Qt licenses may use this file in ** accordance with the commercial license agreement provided with the ** Software or, alternatively, in accordance with the terms contained in ** a written agreement between you and The Qt Company. For licensing terms ** and conditions see https://www.qt.io/terms-conditions. For further ** information use the contact form at https://www.qt.io/contact-us. ** ** GNU General Public License Usage ** Alternatively, this file may be used under the terms of the GNU ** General Public License version 3 as published by the Free Software ** Foundation with exceptions as appearing in the file LICENSE.GPL3-EXCEPT ** included in the packaging of this file. Please review the following ** information to ensure the GNU General Public License requirements will ** be met: https://www.gnu.org/licenses/gpl-3.0.html. ** ****************************************************************************/ #include "qmlprofilertracefile.h" #include #include #include #include #include #include // import QmlEventType, QmlBindingType enums, QmlEventLocation using namespace QmlDebug; const char PROFILER_FILE_VERSION[] = "1.02"; static const char *RANGE_TYPE_STRINGS[] = { "Painting", "Compiling", "Creating", "Binding", "HandlingSignal", "Javascript" }; Q_STATIC_ASSERT(sizeof(RANGE_TYPE_STRINGS) == QmlDebug::MaximumRangeType * sizeof(const char *)); static const char *MESSAGE_STRINGS[] = { // So far only pixmap and scenegraph are used. The others are padding. "Event", "RangeStart", "RangeData", "RangeLocation", "RangeEnd", "Complete", "PixmapCache", "SceneGraph", "MemoryAllocation", "DebugMessage" }; Q_STATIC_ASSERT(sizeof(MESSAGE_STRINGS) == QmlDebug::MaximumMessage * sizeof(const char *)); #define _(X) QLatin1String(X) // // "be strict in your output but tolerant in your inputs" // namespace QmlProfiler { namespace Internal { static QPair qmlTypeAsEnum(const QString &typeString) { QPair ret(MaximumMessage, MaximumRangeType); for (int i = 0; i < MaximumMessage; ++i) { if (typeString == _(MESSAGE_STRINGS[i])) { ret.first = static_cast(i); break; } } for (int i = 0; i < MaximumRangeType; ++i) { if (typeString == _(RANGE_TYPE_STRINGS[i])) { ret.second = static_cast(i); break; } } if (ret.first == MaximumMessage && ret.second == MaximumRangeType) { bool isNumber = false; int type = typeString.toUInt(&isNumber); if (isNumber && type < MaximumRangeType) // Allow saving ranges as numbers, but not messages. ret.second = static_cast(type); } return ret; } static QString qmlTypeAsString(Message message, RangeType rangeType) { if (rangeType < MaximumRangeType) return _(RANGE_TYPE_STRINGS[rangeType]); else if (message != MaximumMessage) return _(MESSAGE_STRINGS[message]); else return QString::number((int)rangeType); } QmlProfilerFileReader::QmlProfilerFileReader(QObject *parent) : QObject(parent), m_traceStart(-1), m_traceEnd(-1), m_future(0), m_loadedFeatures(0) { } void QmlProfilerFileReader::setFuture(QFutureInterface *future) { m_future = future; } bool QmlProfilerFileReader::load(QIODevice *device) { if (m_future) { m_future->setProgressRange(0, 1000); m_future->setProgressValue(0); } QXmlStreamReader stream(device); bool validVersion = true; while (validVersion && !stream.atEnd() && !stream.hasError()) { if (isCanceled()) return false; QXmlStreamReader::TokenType token = stream.readNext(); const QStringRef elementName = stream.name(); switch (token) { case QXmlStreamReader::StartDocument : continue; case QXmlStreamReader::StartElement : { if (elementName == _("trace")) { QXmlStreamAttributes attributes = stream.attributes(); if (attributes.hasAttribute(_("version"))) validVersion = attributes.value(_("version")) == _(PROFILER_FILE_VERSION); else validVersion = false; if (attributes.hasAttribute(_("traceStart"))) m_traceStart = attributes.value(_("traceStart")).toLongLong(); if (attributes.hasAttribute(_("traceEnd"))) m_traceEnd = attributes.value(_("traceEnd")).toLongLong(); } if (elementName == _("eventData")) { loadEventData(stream); break; } if (elementName == _("profilerDataModel")) { loadProfilerDataModel(stream); break; } if (elementName == _("noteData")) { loadNoteData(stream); break; } break; } default: break; } } if (stream.hasError()) { emit error(tr("Error while parsing trace data file: %1").arg(stream.errorString())); return false; } else { emit success(); return true; } } quint64 QmlProfilerFileReader::loadedFeatures() const { return m_loadedFeatures; } QmlDebug::ProfileFeature featureFromEvent(const QmlProfilerDataModel::QmlEventTypeData &event) { if (event.rangeType < MaximumRangeType) return featureFromRangeType(event.rangeType); switch (event.message) { case Event: switch (event.detailType) { case AnimationFrame: return ProfileAnimations; case Key: case Mouse: return ProfileInputEvents; default: return MaximumProfileFeature; } case PixmapCacheEvent: return ProfilePixmapCache; case SceneGraphFrame: return ProfileSceneGraph; case MemoryAllocation: return ProfileMemory; case DebugMessage: return ProfileDebugMessages; default: return MaximumProfileFeature; } } void QmlProfilerFileReader::loadEventData(QXmlStreamReader &stream) { QTC_ASSERT(stream.name() == _("eventData"), return); int eventIndex = -1; QmlProfilerDataModel::QmlEventTypeData event = { QString(), // displayname QmlEventLocation(), MaximumMessage, Painting, // type QmlBinding, // bindingType, set for backwards compatibility QString(), // details }; const QmlProfilerDataModel::QmlEventTypeData defaultEvent = event; while (!stream.atEnd() && !stream.hasError()) { if (isCanceled()) return; QXmlStreamReader::TokenType token = stream.readNext(); const QStringRef elementName = stream.name(); switch (token) { case QXmlStreamReader::StartElement: { if (elementName == _("event")) { progress(stream.device()); event = defaultEvent; const QXmlStreamAttributes attributes = stream.attributes(); if (attributes.hasAttribute(_("index"))) { eventIndex = attributes.value(_("index")).toInt(); } else { // ignore event eventIndex = -1; } break; } stream.readNext(); if (stream.tokenType() != QXmlStreamReader::Characters) break; const QString readData = stream.text().toString(); if (elementName == _("displayname")) { event.displayName = readData; break; } if (elementName == _("type")) { QPair enums = qmlTypeAsEnum(readData); event.message = enums.first; event.rangeType = enums.second; break; } if (elementName == _("filename")) { event.location.filename = readData; break; } if (elementName == _("line")) { event.location.line = readData.toInt(); break; } if (elementName == _("column")) { event.location.column = readData.toInt(); break; } if (elementName == _("details")) { event.data = readData; break; } if (elementName == _("animationFrame")) { event.detailType = readData.toInt(); // new animation frames used to be saved as ranges of range type Painting with // binding type 4 (which was called "AnimationFrame" to make everything even more // confusing), even though they clearly aren't ranges. Convert that to something // sane here. if (event.detailType == 4) { event.message = Event; event.rangeType = MaximumRangeType; event.detailType = AnimationFrame; } } if (elementName == _("bindingType") || elementName == _("cacheEventType") || elementName == _("sgEventType") || elementName == _("memoryEventType") || elementName == _("mouseEvent") || elementName == _("keyEvent") || elementName == _("level")) { event.detailType = readData.toInt(); break; } break; } case QXmlStreamReader::EndElement: { if (elementName == _("event")) { if (eventIndex >= 0) { if (eventIndex >= m_qmlEvents.size()) m_qmlEvents.resize(eventIndex + 1); m_qmlEvents[eventIndex] = event; ProfileFeature feature = featureFromEvent(event); if (feature != MaximumProfileFeature) m_loadedFeatures |= (1ULL << static_cast(feature)); } break; } if (elementName == _("eventData")) { // done reading eventData return; } break; } default: break; } // switch } } void QmlProfilerFileReader::loadProfilerDataModel(QXmlStreamReader &stream) { QTC_ASSERT(stream.name() == _("profilerDataModel"), return); while (!stream.atEnd() && !stream.hasError()) { if (isCanceled()) return; QXmlStreamReader::TokenType token = stream.readNext(); const QStringRef elementName = stream.name(); switch (token) { case QXmlStreamReader::StartElement: { if (elementName == _("range")) { progress(stream.device()); QmlProfilerDataModel::QmlEventData range(0, 0, -1, 0, 0, 0, 0, 0); const QXmlStreamAttributes attributes = stream.attributes(); if (!attributes.hasAttribute(_("startTime")) || !attributes.hasAttribute(_("eventIndex"))) { // ignore incomplete entry continue; } range.setStartTime(attributes.value(_("startTime")).toLongLong()); if (attributes.hasAttribute(_("duration"))) range.setDuration(attributes.value(_("duration")).toLongLong()); // attributes for special events if (attributes.hasAttribute(_("framerate"))) range.setNumericData(0, attributes.value(_("framerate")).toLongLong()); if (attributes.hasAttribute(_("animationcount"))) range.setNumericData(1, attributes.value(_("animationcount")).toLongLong()); if (attributes.hasAttribute(_("thread"))) range.setNumericData(2, attributes.value(_("thread")).toLongLong()); if (attributes.hasAttribute(_("width"))) range.setNumericData(0, attributes.value(_("width")).toLongLong()); if (attributes.hasAttribute(_("height"))) range.setNumericData(1, attributes.value(_("height")).toLongLong()); if (attributes.hasAttribute(_("refCount"))) range.setNumericData(2, attributes.value(_("refCount")).toLongLong()); if (attributes.hasAttribute(_("amount"))) range.setNumericData(0, attributes.value(_("amount")).toLongLong()); if (attributes.hasAttribute(_("timing1"))) range.setNumericData(0, attributes.value(_("timing1")).toLongLong()); if (attributes.hasAttribute(_("timing2"))) range.setNumericData(1, attributes.value(_("timing2")).toLongLong()); if (attributes.hasAttribute(_("timing3"))) range.setNumericData(2, attributes.value(_("timing3")).toLongLong()); if (attributes.hasAttribute(_("timing4"))) range.setNumericData(3, attributes.value(_("timing4")).toLongLong()); if (attributes.hasAttribute(_("timing5"))) range.setNumericData(4, attributes.value(_("timing5")).toLongLong()); if (attributes.hasAttribute(_("type"))) range.setNumericData(0, attributes.value(_("type")).toLongLong()); if (attributes.hasAttribute(_("data1"))) range.setNumericData(1, attributes.value(_("data1")).toLongLong()); if (attributes.hasAttribute(_("data2"))) range.setNumericData(2, attributes.value(_("data2")).toLongLong()); if (attributes.hasAttribute(_("text"))) range.setStringData(attributes.value(_("text")).toString()); range.setTypeIndex(attributes.value(_("eventIndex")).toInt()); m_ranges.append(range); } break; } case QXmlStreamReader::EndElement: { if (elementName == _("profilerDataModel")) { // done reading profilerDataModel return; } break; } default: break; } // switch } } void QmlProfilerFileReader::loadNoteData(QXmlStreamReader &stream) { QmlProfilerDataModel::QmlEventNoteData currentNote; while (!stream.atEnd() && !stream.hasError()) { if (isCanceled()) return; QXmlStreamReader::TokenType token = stream.readNext(); const QStringRef elementName = stream.name(); switch (token) { case QXmlStreamReader::StartElement: { if (elementName == _("note")) { progress(stream.device()); QXmlStreamAttributes attrs = stream.attributes(); currentNote.startTime = attrs.value(_("startTime")).toLongLong(); currentNote.duration = attrs.value(_("duration")).toLongLong(); currentNote.typeIndex = attrs.value(_("eventIndex")).toInt(); } break; } case QXmlStreamReader::Characters: { currentNote.text = stream.text().toString(); break; } case QXmlStreamReader::EndElement: { if (elementName == _("note")) { m_notes.append(currentNote); } else if (elementName == _("noteData")) { return; } break; } default: break; } } } void QmlProfilerFileReader::progress(QIODevice *device) { if (!m_future) return; m_future->setProgressValue(device->pos() * 1000 / device->size()); } bool QmlProfilerFileReader::isCanceled() const { return m_future && m_future->isCanceled(); } QmlProfilerFileWriter::QmlProfilerFileWriter(QObject *parent) : QObject(parent), m_startTime(0), m_endTime(0), m_measuredTime(0), m_future(0) { } void QmlProfilerFileWriter::setTraceTime(qint64 startTime, qint64 endTime, qint64 measuredTime) { m_startTime = startTime; m_endTime = endTime; m_measuredTime = measuredTime; } void QmlProfilerFileWriter::setQmlEvents(const QVector &types, const QVector &events) { m_qmlEvents = types; m_ranges = events; } void QmlProfilerFileWriter::setNotes(const QVector ¬es) { m_notes = notes; } void QmlProfilerFileWriter::setFuture(QFutureInterface *future) { m_future = future; } void QmlProfilerFileWriter::save(QIODevice *device) { if (m_future) { m_future->setProgressRange(0, qMax(m_qmlEvents.size() + m_ranges.size() + m_notes.size(), 1)); m_future->setProgressValue(0); m_newProgressValue = 0; } QXmlStreamWriter stream(device); stream.setAutoFormatting(true); stream.writeStartDocument(); stream.writeStartElement(_("trace")); stream.writeAttribute(_("version"), _(PROFILER_FILE_VERSION)); stream.writeAttribute(_("traceStart"), QString::number(m_startTime)); stream.writeAttribute(_("traceEnd"), QString::number(m_endTime)); stream.writeStartElement(_("eventData")); stream.writeAttribute(_("totalTime"), QString::number(m_measuredTime)); for (int typeIndex = 0; typeIndex < m_qmlEvents.size(); ++typeIndex) { if (isCanceled()) return; const QmlProfilerDataModel::QmlEventTypeData &event = m_qmlEvents[typeIndex]; stream.writeStartElement(_("event")); stream.writeAttribute(_("index"), QString::number(typeIndex)); stream.writeTextElement(_("displayname"), event.displayName); stream.writeTextElement(_("type"), qmlTypeAsString(event.message, event.rangeType)); if (!event.location.filename.isEmpty()) { stream.writeTextElement(_("filename"), event.location.filename); stream.writeTextElement(_("line"), QString::number(event.location.line)); stream.writeTextElement(_("column"), QString::number(event.location.column)); } if (!event.data.isEmpty()) stream.writeTextElement(_("details"), event.data); if (event.rangeType == Binding) { stream.writeTextElement(_("bindingType"), QString::number(event.detailType)); } else if (event.message == Event) { switch (event.detailType) { case AnimationFrame: stream.writeTextElement(_("animationFrame"), QString::number(event.detailType)); break; case Key: stream.writeTextElement(_("keyEvent"), QString::number(event.detailType)); break; case Mouse: stream.writeTextElement(_("mouseEvent"), QString::number(event.detailType)); break; default: break; } } else if (event.message == PixmapCacheEvent) { stream.writeTextElement(_("cacheEventType"), QString::number(event.detailType)); } else if (event.message == SceneGraphFrame) { stream.writeTextElement(_("sgEventType"), QString::number(event.detailType)); } else if (event.message == MemoryAllocation) { stream.writeTextElement(_("memoryEventType"), QString::number(event.detailType)); } else if (event.message == DebugMessage) { stream.writeTextElement(_("level"), QString::number(event.detailType)); } stream.writeEndElement(); incrementProgress(); } stream.writeEndElement(); // eventData stream.writeStartElement(_("profilerDataModel")); for (int rangeIndex = 0; rangeIndex < m_ranges.size(); ++rangeIndex) { if (isCanceled()) return; const QmlProfilerDataModel::QmlEventData &range = m_ranges[rangeIndex]; stream.writeStartElement(_("range")); stream.writeAttribute(_("startTime"), QString::number(range.startTime())); if (range.duration() > 0) // no need to store duration of instantaneous events stream.writeAttribute(_("duration"), QString::number(range.duration())); stream.writeAttribute(_("eventIndex"), QString::number(range.typeIndex())); const QmlProfilerDataModel::QmlEventTypeData &event = m_qmlEvents[range.typeIndex()]; if (event.message == Event) { if (event.detailType == AnimationFrame) { // special: animation event stream.writeAttribute(_("framerate"), QString::number(range.numericData(0))); stream.writeAttribute(_("animationcount"), QString::number(range.numericData(1))); stream.writeAttribute(_("thread"), QString::number(range.numericData(2))); } else if (event.detailType == Key || event.detailType == Mouse) { // special: input event stream.writeAttribute(_("type"), QString::number(range.numericData(0))); stream.writeAttribute(_("data1"), QString::number(range.numericData(1))); stream.writeAttribute(_("data2"), QString::number(range.numericData(2))); } } // special: pixmap cache event if (event.message == PixmapCacheEvent) { if (event.detailType == PixmapSizeKnown) { stream.writeAttribute(_("width"), QString::number(range.numericData(0))); stream.writeAttribute(_("height"), QString::number(range.numericData(1))); } if (event.detailType == PixmapReferenceCountChanged || event.detailType == PixmapCacheCountChanged) stream.writeAttribute(_("refCount"), QString::number(range.numericData(2))); } if (event.message == SceneGraphFrame) { // special: scenegraph frame events if (range.numericData(0) > 0) stream.writeAttribute(_("timing1"), QString::number(range.numericData(0))); if (range.numericData(1) > 0) stream.writeAttribute(_("timing2"), QString::number(range.numericData(1))); if (range.numericData(2) > 0) stream.writeAttribute(_("timing3"), QString::number(range.numericData(2))); if (range.numericData(3) > 0) stream.writeAttribute(_("timing4"), QString::number(range.numericData(3))); if (range.numericData(4) > 0) stream.writeAttribute(_("timing5"), QString::number(range.numericData(4))); } // special: memory allocation event if (event.message == MemoryAllocation) stream.writeAttribute(_("amount"), QString::number(range.numericData(0))); if (event.message == DebugMessage) stream.writeAttribute(_("text"), range.stringData()); stream.writeEndElement(); incrementProgress(); } stream.writeEndElement(); // profilerDataModel stream.writeStartElement(_("noteData")); for (int noteIndex = 0; noteIndex < m_notes.size(); ++noteIndex) { if (isCanceled()) return; const QmlProfilerDataModel::QmlEventNoteData ¬es = m_notes[noteIndex]; stream.writeStartElement(_("note")); stream.writeAttribute(_("startTime"), QString::number(notes.startTime)); stream.writeAttribute(_("duration"), QString::number(notes.duration)); stream.writeAttribute(_("eventIndex"), QString::number(notes.typeIndex)); stream.writeCharacters(notes.text); stream.writeEndElement(); // note incrementProgress(); } stream.writeEndElement(); // noteData if (isCanceled()) return; stream.writeEndElement(); // trace stream.writeEndDocument(); } void QmlProfilerFileWriter::incrementProgress() { if (!m_future) return; m_newProgressValue++; if (float(m_newProgressValue - m_future->progressValue()) / float(m_future->progressMaximum() - m_future->progressMinimum()) >= 0.01) { m_future->setProgressValue(m_newProgressValue); } } bool QmlProfilerFileWriter::isCanceled() const { return m_future && m_future->isCanceled(); } } // namespace Internal } // namespace QmlProfiler