Search Unity

Unity Introducing the Editor Iteration Profiler

Discussion in 'Profiler Previews' started by Rarepops, Jun 9, 2020.

Page 1 of 2

  1. Rarepops

    Rarepops

    Unity Technologies

    Joined:
    Sep 5, 2019
    Posts:
    40
    Editor Iteration Profiler (EIP)
    Before diving into the details, I will start by defining what an iteration is. An iteration is a process that contains instructions that are repeated until a condition is met. Unity relies on different types of iterations.

    The Editor Iteration Profiler monitors iterations that are related to the scripting side of Unity, specifically entering and exiting playmode, assembly compilation, and assembly reload.

    The tool is an attempt to empower you, our users, to understand and help you solve the common question “Why does it take so long to compile my scripts/enter playmode?”. EIP accomplishes this by monitoring profiler frames and saving them in a window where you can more easily navigate through the data the profiler produces. Additionally, the data persists for the whole lifetime of the Editor (or until it’s cleared), as opposed to the Profiler, which has a limit to the number of previously stored frames.

    Disclaimer: This tool is still under development and anything could change on the API side.

    High-level features summary
    • Monitor and capture profiling data from assembly reload, assembly compilation, and enter playmode.

    • Export captured data or Profiler data to a number of formats such as HTML, JSON (for chrome://tracing, which is a fast flame-graph style data visualizer), CSV, and Plaintext.

    • Export to a special type of HTML (HTML Performance Report), which attempts to minimize the number of clicks needed to get to the important areas of the profiled data, as well as aggregate possible areas of interest which could be optimized (e.g. OnEnable calls)
    How to use
    Compatible with 2019.3 and later. It might work with earlier versions, but it is not tested.
    1. Download the repository from GitHub - https://github.com/Unity-Technologies/com.unity.editoriterationprofiler. Alternatively, you can get it through OpenUPM: https://openupm.com/packages/com.unity.editoriterationprofiler/

    2. Place the contents in a folder in your Project’s Packages folder

    3. Open up the project and open the window from Windows → Analysis → Editor Iteration Profiler → Show Window

    4. You should see a window very similar to this

    The basics
    To enable the tool, you just need to click the Enable button in the window. The window doesn’t need to be open afterward: it will run in the background.


    After an iteration happens, it will show up in the window as follows:





    UI
    Please note that the UI might change/have changed slightly, however, the functionality should be the same.



    • Enable - enables the Profiler and sets it to run in Editor mode.

    • Deep Profile - useful to get all information about managed calls. (https://docs.unity3d.com/Manual/ProfilerWindow.html#deep-profiling)

    • Flattening - attempts to reduce the number of clicks needed to get to the place that is of interest. Works by ‘collapsing’ levels which contain multiple parented items with 1 child. Useful for GUI code and Deep Profiling.

    • User Code - is an attempt to filter out engine code and only show code the User might be interested in.

    • Clear - removes recorded events and events which the EIP is looking for.

    • Collapse All - recursively collapses every item.

    • Print to Console - logs the captured data into plaintext into the console/log file.

    • Export… - dropdown to export captured data in various formats.

    • Export Profiler Data… - dropdown to choose between exporting the selected frame in the Profiler Window or exporting multiple frames, frame by frame, between 2 ranges. It will automatically export the data to a selected folder.


    • Search Bar - works as you would expect. Selecting an item and either pressing the F key or clearing the search will automatically expand the tree view to that item.
    Exporters

    After you have captured some data, you might want to export it. You can do this by clicking the Export… dropdown and choosing a format.





    Here you can get the samples exported above for you to test out.

    The Formats

    Opening the HTML, you will see something similar to this:



    It mostly contains the same data as the EIP Window, with the addition of the percentages. Items in square brackets “[ ]” are leaf items without any children.


    The JSON format is meant to be used within Google Chrome's chrome://tracing, which works on chromium-based browsers like Google Chrome, Microsoft Edge Chromium (edge://tracing - chrome://tracing will be replaced by it if typed), Opera, etc.. It is a fast, lightweight and Editor-agnostic way to view the captured data in the flame-graph style. In this gif, we show how to load and use the file into chrome://tracing.


    CSV can be used to load the data into other programs, for example. It is pretty difficult for humans to make sense of it. Also, please be aware of the ‘header’ which contains environment information in case you plan to do further processing.


    Exporting Plaintext is the same as the one it is printed in the console with the “Print to Console” button. Using this, you have the option to isolate the data and not have other information which is in the Editor.log file.


    The HTML Performance Report is based on the same structure as the regular HTML report, however, functionally it is different. The purpose of it is to distill the information into something humans would more easily understand. It basically does this by reducing the number of levels you have to click through to get to the areas of interest, where code diverges more.




    The items in curly brackets “{ }” represent items that have more children, which were hidden due to the parents being under the minimum set threshold (currently a hard-coded value of 1%).

    The colored items represent ‘buckets’ of similar data, which is grouped in one place for convenience. The total time of these items is not added to the original time, it’s only there to give an estimate for that iteration.


    Known Bugs/Limitations (must read this before using it)
    • Data might overlap on chrome://tracing because timestamp mismatches between the EIP's timestamp and the Profiler timestamp (to be fixed in the future)

    • Sorting data doesn't work in-window

    • In order to get the most accurate data (especially with DeepProfile enabled), close as many Editor Windows as possible, including the EIP Window itself (it will keep working even when closed if it's Enabled). The reason is that rebuilding the Tree Hierarchy view and repainting the GUI takes time, and it will "pollute" the data you might be looking for. The more data, the more it will be polluted (Deep Profile will naturally lead to this faster). This has been mostly mitigated in 0.1.2-preview (cost is still there, just delayed so it doesn't pollute the data).

    • When clicking the Profiler Window after clicking Enable in the EIP Window, the EIP's state will be overridden to whatever the original setting in the Profiler was

    • May cause unity to crash when closing it while the EIP is Enabled
    Feedback
    In terms of feedback, we're especially looking for:

    • Are there any useful use-cases not covered?

    • Are there any workflows that are unclear or missing?

    • Is there anything that is unclear or that you don’t understand?

    • Are there any issues or unclear parts in the documentation or this post?

    Please feel free to post any feedback in this sub-forum.

    How to report bugs
    Please open bugs/suggestions at https://github.com/Unity-Technologies/com.unity.editoriterationprofiler/issues.
    Please describe the steps as well as include any relevant files necessary for reproduction.

    Troubleshooting
    If you encounter any problems, the simplest fix is usually to use the Clear button for the window. Another option you can try is through Window → Analysis → Editor Iteration Profiler → Purge Caches.
     
    Last edited: Sep 23, 2021
    Rarepops, Jun 9, 2020
    #1
    a436t4ataf, Laicasaane, joshcamas and 16 others like this.

  2. sebas77

    sebas77

    Joined:
    Nov 4, 2011
    Posts:
    1,388
    "Place the contents in a folder in your Project’s Packages folder"

    doesn't this miss the part where we should change the manifest.json too?

    Code (CSharp):
    1. "dependencies": {
    2.     "com.unity.editoriterationprofiler": "com.unity.editoriterationprofiler-master",
     
    sebas77, Jun 10, 2020
    #2

  3. miniwolf_unity

    miniwolf_unity

    Unity Technologies

    Joined:
    Apr 10, 2018
    Posts:
    104
    That is not necessary. You can either embed a package in your Package folder or reference it in a local folder

    Code (CSharp):
    1.  "com.unity.editoriterationprofiler": "file:../path/to/com.unity.editoriterationprofiler-master"
    You can of course also do the local reference using the Package Manager UI.
     
    miniwolf_unity, Jun 10, 2020
    #3
    wlwl2 and Rarepops like this.

  4. sebas77

    sebas77

    Joined:
    Nov 4, 2011
    Posts:
    1,388
    I am confused, is this available in the package manager? If not (as I don't think it is), how else can be used outside the Asset Folder without changing the manifest? I am not aware of other ways.
     
    sebas77, Jun 10, 2020
    #4

  5. miniwolf_unity

    miniwolf_unity

    Unity Technologies

    Joined:
    Apr 10, 2018
    Posts:
    104
    miniwolf_unity, Jun 10, 2020
    #5
    phobos2077 and sebas77 like this.

  6. JesseSTG

    JesseSTG

    Joined:
    Jan 10, 2019
    Posts:
    193
    I added it with the GitHub repo link, like so:

    Code (csharp):
    1. "com.unity.editoriterationprofiler": "https://github.com/Unity-Technologies/com.unity.editoriterationprofiler.git"
    2.  
    Works like a charm; installs exactly as it should.
     
    JesseSTG, Jun 10, 2020
    #6
    stonstad, phobos2077, Rarepops and 4 others like this.

  7. Thygrrr

    Thygrrr

    Joined:
    Sep 23, 2013
    Posts:
    297
    I'm using this both privately and in a 13 person studio team.

    It's a godsent, especially when trying to discern what part of the time spent is in the domain reload etc, and what time is actually some loading of the game itself. (profiling profane wait states of async calls is always a bit of a pain)
     
    Thygrrr, Jun 11, 2020
    #7
    Rarepops and lukaszunity like this.

  8. JesseSTG

    JesseSTG

    Joined:
    Jan 10, 2019
    Posts:
    193
    On the latest commit (fdfcf97) on Unity 2019.4.0f1 on Ubuntu 19.10, the "AssemblyReload" seems to always report a duration of zero.
     
    JesseSTG, Jun 17, 2020
    #8
    phobos2077 likes this.

  9. Rarepops

    Rarepops

    Unity Technologies

    Joined:
    Sep 5, 2019
    Posts:
    40
    I am not aware of this, sounds like a bug I don't know of. Mind sharing more info?

    There is a bug mentioned under Known Issues where the frame responsible for Assembly Reload gets reparented to AssetImport (see image below, red) when the tree is rebuilt.

    upload_2020-6-17_8-47-18.png
     
    Rarepops, Jun 17, 2020
    #9

  10. JesseSTG

    JesseSTG

    Joined:
    Jan 10, 2019
    Posts:
    193
    Sure, what info would help? I don't know what to look for.
     
    JesseSTG, Jun 18, 2020
    #10

  11. Rarepops

    Rarepops

    Unity Technologies

    Joined:
    Sep 5, 2019
    Posts:
    40
    How often it reproduces? Is it a Script Compilation event? If it's often what are the steps? Do you have Deep Profiling enabled?

    Can you try going to Window -> Analysis -> Editor Iteration Profiler -> Purge Caches and then Clear in the EIP Window? What about restarting the Editor?
     
    Rarepops, Jun 18, 2020
    #11

  12. OwlchemyDawson

    OwlchemyDawson

    Joined:
    Aug 28, 2018
    Posts:
    21
    It seems that the package isn't actually compatible with 2019.2. After embedding the package into my project, I see the following errors:

    In checking the Unity C# reference source, functionality like EditorUtility.RequestScriptReload and EditorUtility.enterPlayModeOptionsEnabled are only available in 2019.3+.

    Was the 2019.2 reference in the description a typo or did I miss something?
     
    OwlchemyDawson, Jun 22, 2020
    #12

  13. Rarepops

    Rarepops

    Unity Technologies

    Joined:
    Sep 5, 2019
    Posts:
    40
    My bad, changed it to 2019.3+

    The issue is simply that those API's aren't available in 2019.2.
     
    Rarepops, Jun 23, 2020
    #13

  14. Bryan-Legend

    Bryan-Legend

    Joined:
    Sep 8, 2012
    Posts:
    71
    I'm getting NUnit missing compile errors. Maybe put some #ifdefs around the using NUnit.Framework; and the asserts?
     
    Bryan-Legend, Jul 6, 2020
    #14
    Rarepops likes this.

  15. Rarepops

    Rarepops

    Unity Technologies

    Joined:
    Sep 5, 2019
    Posts:
    40
    Thanks for the heads up! I replaced them with UnityEngine.Assertions :)
     
    Rarepops, Jul 6, 2020
    #15

  16. NikoBay

    NikoBay

    Joined:
    Aug 15, 2018
    Posts:
    35
    Hi guys, I run into this bug. At first install, everything works fine. Then I duplicate my project (in afraid of messing s.t up) and open duplicated project's Iteration Editor Window show no texts at all, just like attachment. Then I remove duplicated project and open original project. Now Iteration Editor Window also show no texts. Removing and reinstalling, even reseting computer does not fix it. Any ideas what I should do?
    Also, other functions like Print to console still works and texts in console show fine.
     

    Attached Files:

    NikoBay, Jul 12, 2020
    #16

  17. OmegaNemesis28

    OmegaNemesis28

    Joined:
    Dec 1, 2012
    Posts:
    111
    I tried to run it while doing a project export, and it worked - kind of. It captured all the script compilation iteration events which is what I wanted. But at the end of the build, it started to spam these errors temporarily before coming back to life. Then I could look inside the profiler details. Not sure if these are important.

    Code (CSharp):
    1. NullReferenceException: Object reference not set to an instance of an object
    2. UnityEditor.EditorIterationProfiler.DataCollector.EditorEvent (UnityEditor.EditorIterationProfiler.UnityEditorEvents+Event evt, System.String data) (at Packages/com.unity.editoriterationprofiler/Editor/DataCollector.cs:70)
    3. UnityEditor.EditorIterationProfiler.UnityEditorEvents.AssemblyCompilationStarted (System.String assembly) (at Packages/com.unity.editoriterationprofiler/Editor/UnityEditorEvents.cs:64)
    4. UnityEditor.Compilation.CompilationPipeline+<>c.<SubscribeToEvents>b__16_2 (System.String assemblyPath) (at <0a2a5ea3c8ab4e3394576dd407a984f6>:0)
    5. UnityEditor.BuildPipeline:BuildPlayer(String[], String, BuildTarget, BuildOptions)
    6. BuildTools:BuildPlayer(BuildSettings, String, String, String) (at Assets/Scripts/Build/Editor/BuildTools.cs:144)
    7. BuildWindow:DoBuild(StartInfo, Boolean, Boolean, Boolean, Boolean, Boolean) (at Assets/Scripts/Build/Editor/BuildWindow_BuildTools.cs:319)
    8. BuildWindow:DrawBuildTools() (at Assets/Scripts/Build/Editor/BuildWindow_BuildTools.cs:182)
    9. BuildWindow:OnGUI() (at Assets/Scripts/Build/Editor/BuildWindow.cs:169)
    10. UnityEngine.GUIUtility:ProcessEvent(Int32, IntPtr)
    11.  
    Looks like you're already aware that sorting the columns doesn't work which is unfortunate. But also, how about sorting them on export? The HTML report is thankfully nice enough to have a % breakdown on each level (god send), but would be cool if it auto descending or ascending.
     
    OmegaNemesis28, Jul 13, 2020
    #17

  18. Rarepops

    Rarepops

    Unity Technologies

    Joined:
    Sep 5, 2019
    Posts:
    40
    Looks like you are running on OSX? Can you tell me which version of Unity and OSX you are running? There are a few bugs in OSX apparently that I am becoming aware of because I developed this tool on Windows mostly. It might be a bug with IMGUI potentially
     
    Rarepops, Jul 13, 2020
    #18

  19. Rarepops

    Rarepops

    Unity Technologies

    Joined:
    Sep 5, 2019
    Posts:
    40
    Hi, thanks for the feedback!

    The errors you are seeing are probably because the Editor Iteration Profiler is looking for Domain Reloads (they happen while Building), but then it tries to add it to a root which is not there, as it's created in another code path. I will try to fix this if it's quick but I also have some time planned to also add the ability for the EIP to capture information about building the Players, so awareness EIP might have about Domain Reloads during Building Players might be the right thing to do instead of going around it :).

    I am aware the sorting is broken and was suggested I should sort before exporting as well. The idea is if I implement sorting for the UI I can also do sorting when exporting. I do have a few days set aside for this quarter for EIP improvements, I think I will focus on this as it is an important feature :)

    Stay tuned!
     
    Last edited: Jul 14, 2020
    Rarepops, Jul 13, 2020
    #19
    OmegaNemesis28 likes this.

  20. NikoBay

    NikoBay

    Joined:
    Aug 15, 2018
    Posts:
    35
    hi @Rarepops , glad you're taking care of this. I even tried to create new project but except the first time, I've never managed to make the text appears again.
    I'm running macOS Catalina 10.15.5 and Unity 2019.4.3f1
     
    NikoBay, Jul 13, 2020
    #20

  21. Rarepops

    Rarepops

    Unity Technologies

    Joined:
    Sep 5, 2019
    Posts:
    40
    I will try it out on 2019.4, haven't seen this issue otherwise. It's also curious that there is no header for the columns either... and no errors are thrown anywhere? (picture is from Windows) upload_2020-7-14_12-5-33.png
     
    Rarepops, Jul 14, 2020
    #21

  22. NikoBay

    NikoBay

    Joined:
    Aug 15, 2018
    Posts:
    35
    nope, just checked. Still no texts no headers nor errors anywhere. Though Print to Console returns normal it seems. So I guess problem is the text display only.
     
    NikoBay, Jul 14, 2020
    #22
    Rarepops likes this.

  23. TJHeuvel-net

    TJHeuvel-net

    Joined:
    Jul 31, 2012
    Posts:
    622
    Can we report excessive startup costs as bugs?

    upload_2020-7-16_14-36-23.png

    upload_2020-7-16_14-36-40.png
    I'm sure the terrain team, and burst team would like to know about this. We dont even use Burst, there is nothing to burst compile.
     
    TJHeuvel-net, Jul 16, 2020
    #23

  24. Rarepops

    Rarepops

    Unity Technologies

    Joined:
    Sep 5, 2019
    Posts:
    40
    Thanks for this, I've let them know!
     
    Rarepops, Jul 21, 2020
    #24
    phobos2077 and TJHeuvel-net like this.

  25. TJHeuvel-net

    TJHeuvel-net

    Joined:
    Jul 31, 2012
    Posts:
    622
    It probably has to do with the many, many scripts we have. That is one thing the editor struggles to scale with, a lot of assemblies and scripts.
     
    TJHeuvel-net, Jul 21, 2020
    #25
    Rarepops likes this.

  26. xoofx

    xoofx

    Unity Technologies

    Joined:
    Nov 5, 2016
    Posts:
    347
    Indeed, the Burst initialization code you are seeing in the profiling is happening once per domain reload and it is basically gathering the list of assemblies used for Burst. As you have lots of assemblies it seems that it is a direct effect from that. Not sure there is a workaround for that unfortunately. Disabling Burst in the menu won't help, because it is only for disabling compilation, we don't support disabling dynamically Burst entirely from the editor as it would complicate too much the state of kick-starting Burst in the middle of a running editor. But you can disable Burst entirely from the Unity command line by passing 
    --burst-disable-compilation
     
    xoofx, Jul 24, 2020
    #26
    phobos2077 and TJHeuvel-net like this.

  27. SugoiDev

    SugoiDev

    Joined:
    Mar 27, 2013
    Posts:
    376
    I hope there is a workaround, since Unity not scaling well in larger projects is a common performance issue. In particular linear scaling with the number of types in a solution.

    Extracting metadata (like attributes) and in general scanning the entire assembly should be done with the help of the unmanaged side to speed things up. Too many performance issues come from this.
     
    SugoiDev, Jul 24, 2020
    #27
    Alic likes this.

  28. MartinTilo

    MartinTilo

    Unity Technologies

    Joined:
    Aug 16, 2017
    Posts:
    1,557
    Yep, we have a type cache for that.
     
    MartinTilo, Jul 24, 2020
    #28
    futurlab_xbox likes this.

  29. SugoiDev

    SugoiDev

    Joined:
    Mar 27, 2013
    Posts:
    376
    Yeah, the TypeCache is an awesome step in the right direction. I've been closely following the development of all things editor-iteration-performance for a while now, and after testing 2020.2, I think there's been some substancial improvements.

    I've been wary of actually using Burst because of increased iteration times, but I'm hopeful that this will be dealt with eventually.
     
    SugoiDev, Jul 24, 2020
    #29
    futurlab_xbox likes this.

  30. TJHeuvel-net

    TJHeuvel-net

    Joined:
    Jul 31, 2012
    Posts:
    622
    Thanks for the in depth response!
     
    TJHeuvel-net, Jul 27, 2020
    #30
    futurlab_xbox likes this.

  31. phobos2077

    phobos2077

    Joined:
    Feb 10, 2018
    Posts:
    328
    Doesn't work in 2019.4.3f1. AssemblyReload is always shown as 0...

    upload_2020-8-15_0-52-10.png

    Trying to use "Deep profile" just results in Unity hanging forever and eating all available 10Gb of RAM. Seems like this tool is broken.
     
    Last edited: Aug 14, 2020
    phobos2077, Aug 14, 2020
    #31

  32. Rarepops

    Rarepops

    Unity Technologies

    Joined:
    Sep 5, 2019
    Posts:
    40
    Hi, does the AssemblyReload showing as 0 happen only with Deep Profile on? I've had 30GB of RAM easily used up when Deep Profile was on.

    As a quick workaround, you could try closing the EIP and Profiler window as the GUI won't have to rebuild the hierarchy trees and draw them (you don't need to have those windows open for EIP to work, you can check what it recorded after the fact).
     
    Rarepops, Aug 17, 2020
    #32

  33. phobos2077

    phobos2077

    Joined:
    Feb 10, 2018
    Posts:
    328
    With Deep Profile on - Unity just eats up all ram and hangs, with no hope of recovering. So I've only seen the results w/o deep profile, which are always 0 for me. I've tried closing the window and reloading, reloading several times over - the same result. I use Rider and just change one line of code, then alt-tab to Unity to trigger recompile/reload.
     
    phobos2077, Aug 17, 2020
    #33

  34. Rarepops

    Rarepops

    Unity Technologies

    Joined:
    Sep 5, 2019
    Posts:
    40
    I will look into that, sounds like a bug :)
     
    Rarepops, Aug 18, 2020
    #34
    firstuser and phobos2077 like this.

  35. fherbst

    fherbst

    Joined:
    Jun 24, 2012
    Posts:
    778
    Thanks for creating this, this is tremendously useful. I recently put together a Compilation Visualizer (on OpenUPM) and will look into extending it to contain the type of data you're capturing here.

    That being said, 2020.2 seems crazy broken in terms of compilation times, I'm seeing 10x regressions compared to 2019.4, especially when adding/removing packages (in contrast to "just" triggering a full recompile in Unity). This is for projects with only Unity packages, NO USER CODE AT ALL.

    Full recompile on 2020.2 (triggered through CompilationPipeline.RequestScriptCompilation) is > 100s:

    20200823-021309_Unity.png

    Changing a single package in the manifest takes > 560s (that's more than 9 minutes) - some of that time seems missing from the Iteration Profiler as AssemblyReload is shown as 0s on that operation, in contrast to the correct reading for a recompile:

    upload_2020-8-23_2-29-27.png

    Both of these operations take ~35s on 2019.3 + 4.

    Reported as Case 1272396
     
    Last edited: Aug 23, 2020
    fherbst, Aug 23, 2020
    #35
    futurlab_xbox, Rarepops and phobos2077 like this.

  36. Rarepops

    Rarepops

    Unity Technologies

    Joined:
    Sep 5, 2019
    Posts:
    40
    We are aware of these issues and there are efforts to focus on these issues in the near future. There are some bugs with EIP, it's used more as a concept to help us determine the usefulness of these types of tools for developers. I don't think I can say too many details about it but you should see some interesting features coming to the profiler in the future :)
     
    Rarepops, Aug 27, 2020
    #36

  37. fherbst

    fherbst

    Joined:
    Jun 24, 2012
    Posts:
    778
    Just to clarify, when you say
    are you referring to
    ?

    If yes, could you please
    • post the Issue Tracker link here
    • elaborate a bit more on what the issue actually is, people are trying to do work with these versions, and it would be great to know more about what's going on
    • add this issue to the "Known Issues" for 2020.1 / 2020.2 release notes?

    Thank you!
     
    Last edited: Aug 27, 2020
    fherbst, Aug 27, 2020
    #37
    futurlab_xbox, firstuser and phobos2077 like this.

  38. Kamyker

    Kamyker

    Joined:
    May 14, 2013
    Posts:
    719
    Recently my Unity started taking 10-20% CPU (i9 9900k) even while when it's minimized. It turned out that this tool works in the background even when window (Windows -> Analysis -> Editor Iteration Profiler -> Show Window) is closed :/
     
    Kamyker, Nov 12, 2020
    #38
    futurlab_xbox likes this.

  39. Rarepops

    Rarepops

    Unity Technologies

    Joined:
    Sep 5, 2019
    Posts:
    40
    Yes, it's working as intended. What you need to do is Disable it first, and it will stay disabled.

    I can see however that having a way to see if it's enabled or not without the window being open would be useful :)
     
    Last edited: Nov 13, 2020
    Rarepops, Nov 13, 2020
    #39

  40. Baste

    Baste

    Joined:
    Jan 24, 2013
    Posts:
    5,580
    Gave this a quick test.

    Adding and removing a single space in my code editor and then alt-tabbing back to Unity gives me these result:
    upload_2020-11-13_14-46-31.png

    But the actual time it takes before the editor is responsive is ~4 seconds. So a lot of the actual time spent is missing.

    Note that "AssetImport" and "AssemblyReload" claims that they take 0 seconds. That's probably wrong, since a) I'm compiling scripts, which means that at least one assembly should be reloading and b) Unity throws up the "AssetDatabase.Refresh" window:

    upload_2020-11-13_14-49-14.png

    If I turn on "Deep Profile", I seem to get actual results:

    upload_2020-11-13_14-51-18.png

    Although Deep Profile also adds a ton to the iteration time.

    Is that intentional, or a bug? I'd like to find out if it's the asset import stage or the assembly reload stage I need to look into, but for that to work I'd love to get how long they take without deep profiling.
     
    Baste, Nov 13, 2020
    #40
    futurlab_xbox and wlwl2 like this.

  41. Baste

    Baste

    Joined:
    Jan 24, 2013
    Posts:
    5,580
    Also, I occasionally get exceptions during script reloads when profiling, I think it only happens when the window is closed, but set to "enable":

    Code (csharp):
    1.  
    2. NullReferenceException: Object reference not set to an instance of an object
    3. UnityEditor.EditorIterationProfiler.IterationEventRoot.SetParent (UnityEditor.EditorIterationProfiler.EventData child, UnityEditor.EditorIterationProfiler.EventData parent) (at Packages/com.unity.editoriterationprofiler-0.1.1-preview/Editor/IterationEventRoot.cs:126)
    4. UnityEditor.EditorIterationProfiler.IterationEventRoot.AddChildEvent (System.String identifier, System.String metadata, System.Double startTime, System.Double finishTime, UnityEditor.EditorIterationProfiler.EventData parentEvent, UnityEditor.EditorIterationProfiler.EventDataFlags flags) (at Packages/com.unity.editoriterationprofiler-0.1.1-preview/Editor/IterationEventRoot.cs:108)
    5. UnityEditor.EditorIterationProfiler.ProfilerDataCollector.ReadProfilingData (UnityEditor.EditorIterationProfiler.IterationEventRoot iterationEventRoot, UnityEditor.EditorIterationProfiler.EventData parentEventData, UnityEditor.Profiling.HierarchyFrameDataView frameData, System.Int32 sampleId, UnityEditor.EditorIterationProfiler.EventDataFlags flags, System.Boolean parentHasSingleChild) (at Packages/com.unity.editoriterationprofiler-0.1.1-preview/Editor/ProfilerDataCollector.cs:272)
    6. UnityEditor.EditorIterationProfiler.ProfilerDataCollector.ProfilerNewFrame (System.Int32 connectionId, System.Int32 newFrameIndex) (at Packages/com.unity.editoriterationprofiler-0.1.1-preview/Editor/ProfilerDataCollector.cs:220)
    7. UnityEditorInternal.ProfilerDriver.InvokeNewProfilerFrameRecorded (System.Int32 connectionId, System.Int32 newFrameIndex) (at <d1bec46880064709a5e713ad543e6d96>:0)
    8.  
     
    Baste, Nov 13, 2020
    #41

  42. Baste

    Baste

    Joined:
    Jan 24, 2013
    Posts:
    5,580
    Hmm, seems like I get duplicate entried for "Main Thread" under "Asset Import" when deep profiling:

    upload_2020-11-13_14-57-46.png
     
    Baste, Nov 13, 2020
    #42

  43. Kleptine

    Kleptine

    Joined:
    Dec 23, 2013
    Posts:
    167
    Can confirm, I saw the same issue of 0's being logged, and duplications. I gave up and just went back to the normal profiler.
     
    Kleptine, Nov 13, 2020
    #43
    phobos2077 likes this.

  44. Kamyker

    Kamyker

    Joined:
    May 14, 2013
    Posts:
    719
    What's the point of running the tool if it's closed?
     
    Kamyker, Nov 14, 2020
    #44

  45. Baste

    Baste

    Joined:
    Jan 24, 2013
    Posts:
    5,580
    Because of:

     
    Baste, Nov 14, 2020
    #45
    firstuser and fherbst like this.

  46. Tortuap

    Tortuap

    Joined:
    Dec 4, 2013
    Posts:
    102
    The point is to avoid the overhead of the tool's UI refresh in the profiling, which pollutes it.
     
    Tortuap, Nov 22, 2020
    #46

  47. Rarepops

    Rarepops

    Unity Technologies

    Joined:
    Sep 5, 2019
    Posts:
    40
    Interesting, can you tell me which Unity version are you using? Maybe I could look into this, although nowadays our focus is more on general bugfixes so I don't have much time to look into fixing the tool :(


    I will create an issue on GitHub, thanks!

    It's not only the tool itself, but potentially any window that is open. If you don't care about UI code polluting the data, I would strongly recommend closing as many windows as possible. It's just the way IMGUI works and a lot of the windows in Unity are still on IMGUI.
     
    Rarepops, Nov 24, 2020
    #47
    phobos2077 likes this.

  48. Baste

    Baste

    Joined:
    Jan 24, 2013
    Posts:
    5,580
    Unity version 2020.1.13f1 (ie. latest tech)
     
    Baste, Nov 24, 2020
    #48
    Rarepops likes this.

  49. online_frog

    online_frog

    Joined:
    Dec 27, 2012
    Posts:
    7
    Same result as phobos. I only have 16gb of ram, so I quickly run out of memory and unity hangs during a deep profile, even when I close the profiler window before compiling. Non-deep profile doesn't say much more than "the csharp assemblies were compiled" so I have no use for it. 2020.2.0b13

    I'm looking forward to being able to use this eventually cuz I'm pretty sure I have lots of old nasty editor code that's bogging down the editor that I'd love to track down. Thanks for the tool.

    Update (Jan 7):

    I upgraded my PC to 40gb of ram lol, so I can finally use this now.
    It's great. I immediately found some editor code I wrote years ago that's absurdly more expensive than I thought it'd be. Removing it brought my EnterPlayMode time from 30 seconds to 15.

    It's a great tool, but it uses an insane amount of memory. The Unity process after running it got up to about 22gb, running it a second time for some reason got it up to 32gb. If this could somehow be reduced that would make it usable for many more people.
     
    Last edited: Jan 8, 2021
    online_frog, Dec 2, 2020
    #49
    Alic, NikoBay, Ghat-Smith and 2 others like this.

  50. Hannibal_Leo

    Hannibal_Leo

    Joined:
    Nov 5, 2012
    Posts:
    352
    Sitting here with my (physical) Stopwatch, I get totally different times.
    My test is changing one code-line, then focusing Unity, and scrolling the Mouse Scroll Wheel while hovering over the hierarchy until Unity responds.

    "Editor Iteration Profiler" says "18,362 ms" -> ~18 sec
    My physical Stopwatch says "33,19 ms" -> ~33 sec

    That's a huge difference. Any idea why?
     
    Hannibal_Leo, Apr 30, 2021
    #50
Page 1 of 2
unityunity