New post
0

How to speed up Nuke launch time

Avatar
Donat Van Bellinghen
None
Follow

Hi,

Since we've started using Shotgun Nuke's launching time has increased from 15sec without Shotgun to 50sec with Shotgun.

I did a check using this command line ;

\\VSERVER01\shotgun\shell_helix_P42334\tank" Shot EV118 launch_nuke --debug

 

Here's the ouptut

C:\Program Files (x86)\Console2>"\\VSERVER01\shotgun\shell_helix_P42334\tank" Shot EV118 launch_nuke --debug
DEBUG [00:28:21 497.99990654]:
DEBUG [00:28:21 500.999927521]: Running with debug output enabled.
DEBUG [00:28:21 500.999927521]:
DEBUG [00:28:21 502.00009346]: Full command line passed: ['\\\\VSERVER01\\shotgun\\shotgun\\install\\core\\scripts\\tank_cmd.py', '\\\\VSERVER01\\shotgun\\shotgun\\', 'Shot', 'EV118', 'launch_nuke', '-- debug', '--pc=\\\\VSERVER01\\shotgun\\shell_helix_P42334\\']
DEBUG [00:28:21 502.00009346]:
DEBUG [00:28:21 503.000020981]:
DEBUG [00:28:21 503.000020981]: Code install root: \\VSERVER01\shotgun\shotgun\
DEBUG [00:28:21 503.000020981]: Pipeline Config Root: \\VSERVER01\shotgun\shell_helix_P42334\
DEBUG [00:28:21 503.999948502]:
DEBUG [00:28:21 503.999948502]:
DEBUG [00:28:21 505.000114441]:
DEBUG [00:28:21 505.000114441]: Context items: ['Shot', 'EV118']
DEBUG [00:28:21 506.000041962]: Command: launch_nuke
DEBUG [00:28:21 506.000041962]: Command Arguments: []
DEBUG [00:28:21 506.000041962]: Sgtk Pipeline Config Location: \\VSERVER01\shotgun\shell_helix_P42334\
DEBUG [00:28:21 506.999969482]: Location of this script (__file__): \\VSERVER01\shotgun\shotgun\install\core\scripts\tank_cmd.py

Welcome to the Shotgun Pipeline Toolkit!
For documentation, see https://toolkit.shotgunsoftware.com
You are running a tank command associated with Shotgun Project 'Shell Helix'.
Only items associated with this project will be considered.
- Found Shot EV118 (Project 'Shell Helix')
DEBUG [00:28:25 539.000034332]: Sgtk API and Context resolve complete.
DEBUG [00:28:25 540.999889374]: Sgtk API: Sgtk Core v0.14.48, config \\VSERVER01\shotgun\shell_helix_P42334
DEBUG [00:28:26 957.000017166]: Context: Shot EV118
- Using configuration 'Primary' and Core v0.14.48
- Setting the Context to Shot EV118.
DEBUG [00:28:27 928.999900818]: Probing for a shell engine. ctx 'Shot EV118' --> environment 'Environment shot_and_asset.yml'
DEBUG [00:28:27 930.000066757]: Looks like the environment has a tk-shell engine. Trying to start it.
DEBUG [00:28:28 253.999948502]: Engine init: Instantiating <Sgtk Engine 0x034dbeb8: tk-shell, env: shot_and_asset>
DEBUG [00:28:28 255.000114441]: Engine init: Current Context: Shot EV118
DEBUG [00:28:30 519.000053406]: Successfully initialized PySide 1.2.1 located in \\VSERVER01\shotgun\Python27_x64\lib\site-packages\PySide\__init__.pyc.
DEBUG [00:28:30 555.000066757]: App init: Instantiating <Sgtk App 0x04bdd978: tk-multi-screeningroom, engine: <Sgtk Engine 0x034dbeb8: tk-shell, env: shot_and_asset>>
DEBUG [00:28:30 618.000030518]: App init: Instantiating <Sgtk App 0x04be1898: tk-multi-launchapp, engine: <Sgtk Engine 0x034dbeb8: tk-shell, env: shot_and_asset>>
DEBUG [00:28:30 668.999910355]: App init: Instantiating <Sgtk App 0x04bdd710: tk-multi-launchapp, engine: <Sgtk Engine 0x034dbeb8: tk-shell, env: shot_and_asset>>
DEBUG [00:28:30 684.000015259]: Init complete: <Sgtk Engine 0x034dbeb8: tk-shell, env: shot_and_asset>
DEBUG [00:28:30 684.99994278]: Started engine <Sgtk Engine 0x034dbeb8: tk-shell, env: shot_and_asset>
- Started Shell Engine version v0.3.5
- Environment:
\\VSERVER01\shotgun\shell_helix_P42334\config\env\shot_and_asset.yml.
- Running command launch_nuke...


----------------------------------------------------------------------
Command: Launch nuke
----------------------------------------------------------------------

DEBUG [00:28:30 691.999912262]: Importing python modules in \\VSERVER01\shotgun\shotgun\install\engines\app_store\tk-shell\v0.3.5\python...
DEBUG [00:28:30 858.000040054]: Creating folders for Shot 2144, tk-nuke
DEBUG [00:29:09 801.000118256]: Setting TANK_CONTEXT to '<Sgtk Context: Project: {'type': 'Project', 'id': 152, 'name': 'Shell Helix'} Entity: {'type': 'Shot', 'id': 2144, 'name': 'EV118'} Step: None Task: None
User: {'type': 'HumanUser', 'id': 51, 'name': 'Donat Van Bellinghen'}
Shotgun URL: https://nozon.shotgunstudio.com/detail/Shot/2144 Additional
Entities: []>'
DEBUG [00:29:09 802.999973297]: Running before launch hook...
DEBUG [00:29:09 811.000108719]: Launching executable 'C:\Program
Files\Nuke8.0v4\Nuke8.0.exe' with args ''
DEBUG [00:29:09 834.000110626]: Hook tried to launch 'start /B "App"
"C:\Program Files\Nuke8.0v4\Nuke8.0.exe" '
Nuke 8.0v4, 64 bit, built Apr 3 2014.
Copyright (c) 2014 The Foundry Visionmongers Ltd. All Rights Reserved.
DEBUG [00:29:10 341.000080109]: Exiting with exit code None

C:\Program Files (x86)\Console2>We are running tank
[ 0:29.19] ERROR: Shotgun Error: App configuration Error for tk-nuke-writenode.
It will not be loaded: Context Shot EV118 can not determine value for fields ['Step'] needed by template <Sgtk TemplatePath nuke_shot_work: Compositing/Comp/Nuke/{Shot}/{Step}/work/{Shot}[_{name}]_v{version}.nk>
Disk cache C:/Users/nozon/AppData/Local/Temp/nuke/??: 3294MB (22% of 15360MB) used in 732 files.


So there's 9 seconds for initializing stuff, then the folder creation takes 39 seconds, then Nuke is started. I'm testing this at midnight so no one is accessing the network.

When I do a preview_folders in a shell I see that the toolkit is processing 3773 folders.

Our 3D TD has copied a lot of plugins/modules/custom tools for Maya inside the schema. The idea being that if we need to go back to an old project the tools for Maya will be the old tools, so there will be no backward compatibility problem at all. Those files are contained in a 'config' folder in the schema. So I added a config.yml file containing this :

# type of content
type: "static"
# only create this folder for maya
defer_creation: "tk-maya"

(I did that on a cloned pipeline 'dev' to avoid problems). So I redid the test :

C:\Program Files (x86)\Console2>"\\VSERVER01\shotgun\shell_helix_P42334_dev\tank" Shot EV118 launch_nuke --debug
DEBUG [00:55:04 654.99997139]:
DEBUG [00:55:04 657.999992371]: Running with debug output enabled.
DEBUG [00:55:04 658.999919891]:
DEBUG [00:55:04 661.999940872]: Found file
\\VSERVER01\shotgun\shell_helix_P42334_dev\config\core\templates.yml - means we have a localized core!
DEBUG [00:55:04 663.000106812]: Full command line passed: ['\\\\VSERVER01\\shotgun\\shell_helix_P42334_dev\\install\\core\\scripts\\tank_cmd.py','\\\\VSERVER01\\shotgun\\shell_helix_P42334_dev\\', 'Shot', 'EV118',
'launch_nuke', '--debug']
DEBUG [00:55:04 664.000034332]:
DEBUG [00:55:04 664.999961853]:
DEBUG [00:55:04 665.999889374]: Code install root:\\VSERVER01\shotgun\shell_helix_P42334_dev\
DEBUG [00:55:04 665.999889374]: Pipeline Config Root:\\VSERVER01\shotgun\shell_helix_P42334_dev\
DEBUG [00:55:04 667.000055313]:
DEBUG [00:55:04 667.000055313]:
DEBUG [00:55:04 667.999982834]:
DEBUG [00:55:04 667.999982834]: Context items: ['Shot', 'EV118']
DEBUG [00:55:04 668.999910355]: Command: launch_nuke
DEBUG [00:55:04 668.999910355]: Command Arguments: []
DEBUG [00:55:04 671.999931335]: Sgtk Pipeline Config Location:\\VSERVER01\shotgun\shell_helix_P42334_dev\
DEBUG [00:55:04 671.999931335]: Location of this script (__file__):\\VSERVER01\shotgun\shell_helix_P42334_dev\install\core\scripts\tank_cmd.py

Welcome to the Shotgun Pipeline Toolkit!
For documentation, see https://toolkit.shotgunsoftware.com
You are running a tank command associated with Shotgun Project 'Shell Helix'.
Only items associated with this project will be considered.
- Found Shot EV118 (Project 'Shell Helix')
DEBUG [00:55:06 522.000074387]: Sgtk API and Context resolve complete.
DEBUG [00:55:06 525.000095367]: Sgtk API: Sgtk Core v0.14.48, config\\VSERVER01\shotgun\shell_helix_P42334_dev
DEBUG [00:55:06 959.000110626]: Context: Shot EV118
- Using configuration 'dev' and Core v0.14.48
- Setting the Context to Shot EV118.
DEBUG [00:55:07 290.999889374]: Probing for a shell engine. ctx 'Shot EV118'--> environment 'Environment shot_and_asset.yml'
DEBUG [00:55:07 292.000055313]: Looks like the environment has a tk-shellengine. Trying to start it.
DEBUG [00:55:07 608.999967575]: Engine init: Instantiating <Sgtk Engine0x03404f60: tk-shell, env: shot_and_asset>
DEBUG [00:55:07 609.999895096]: Engine init: Current Context: Shot EV118
DEBUG [00:55:09 838.999986649]: Successfully initialized PySide 1.2.1 located in \\VSERVER01\shotgun\Python27_x64\lib\site-packages\PySide\__init__.pyc.
DEBUG [00:55:09 874.000072479]: App init: Instantiating <Sgtk App 0x04bbbac8: tk-multi-screeningroom, engine: <Sgtk Engine 0x03404f60: tk-shell, env:
shot_and_asset>>
DEBUG [00:55:09 933.000087738]: App init: Instantiating <Sgtk App 0x04bc0908:tk-multi-launchapp, engine: <Sgtk Engine 0x03404f60: tk-shell, env:
shot_and_asset>>
DEBUG [00:55:10 82.9999446869]: App init: Instantiating <Sgtk App 0x04bc68d0:tk-multi-launchapp, engine: <Sgtk Engine 0x03404f60: tk-shell, env:
shot_and_asset>>
DEBUG [00:55:10 200.000047684]: Init complete: <Sgtk Engine 0x03404f60: tk-shell, env: shot_and_asset>
DEBUG [00:55:10 200.000047684]: Started engine <Sgtk Engine 0x03404f60: tk-shell, env: shot_and_asset>
- Started Shell Engine version v0.3.5
- Environment:
\\VSERVER01\shotgun\shell_helix_P42334_dev\config\env\shot_and_asset.yml.
- Running command launch_nuke...


----------------------------------------------------------------------
Command: Launch nuke
----------------------------------------------------------------------

DEBUG [00:55:10 207.999944687]: Importing python modules in\\VSERVER01\shotgun\shell_helix_P42334_dev\install\engines\app_store\tk-shell\v0.3.5\python...
DEBUG [00:55:10 365.000009537]: Creating folders for Shot 2144, tk-nuke
DEBUG [00:55:29 668.999910355]: Setting TANK_CONTEXT to '<Sgtk Context:Project: {'type': 'Project', 'id': 152, 'name': 'Shell Helix'} Entity:{'type': 'Shot', 'id': 2144, 'name': 'EV118'} Step: None Task: None
User: {'type': 'HumanUser', 'id': 51, 'name': 'Donat Van Bellinghen'}
Shotgun URL: https://nozon.shotgunstudio.com/detail/Shot/2144 AdditionalEntities: []>'
DEBUG [00:55:29 670.000076294]: Running before launch hook...
DEBUG [00:55:29 677.000045776]: Launching executable 'C:\Program Files\Nuke8.0v4\Nuke8.0.exe' with args ''
DEBUG [00:55:29 700.999975204]: Hook tried to launch 'start /B "App" "C:\Program Files\Nuke8.0v4\Nuke8.0.exe" 'Nuke 8.0v4, 64 bit, built Apr 3 2014.Copyright (c) 2014 The Foundry Visionmongers Ltd. All Rights Reserved.
DEBUG [00:55:29 970.999956131]: Exiting with exit code None

C:\Program Files (x86)\Console2>We are running tank
Disk cache C:/Users/nozon/AppData/Local/Temp/nuke/??: 3294MB (22% of 15360MB) used in 732 files.


Now there's 6 seconds for the init, then 19 seconds for the folder creation, then Nuke starts. This is much better but still quite slow I think. If I do a preview_folders test in this dev pipeline is see that 'only' 344 folders were processed. Could I still improve this ? Could I somehow configure toolkit to only process folders related to the compositing step when I launch Nuke ?

In our case we have a multi-root setup, the primary root is for the 3D stuff, the secondary is for the compositing/editorial/grading/production stuff. Could I completely eliminate the primary root when launching Nuke ?


Any help would be greatly appreciated.

Regards

Donat Van Bellinghen
www.nozon.com

Date Votes

5 comments

  • 0
    Avatar
    Donat Van Bellinghen


    I just tried something. I added a defer-creation on both the primary and secondary root, so that when I do a preview_folders no folders are processed at all.

    Here's the log:

    C:\Program Files (x86)\Console2>"\\VSERVER01\shotgun\shell_helix_P42334_dev\tank" Shot EV118 preview_folders --debug
    DEBUG [10:30:07 461.999893188]:
    DEBUG [10:30:07 464.999914169]: Running with debug output enabled.
    DEBUG [10:30:07 466.000080109]:
    DEBUG [10:30:07 467.99993515]: Found file
    \\VSERVER01\shotgun\shell_helix_P42334_dev\config\core\templates.yml - means
    we have a localized core!
    DEBUG [10:30:07 467.99993515]: Full command line passed: ['\\\\VSERVER01\\shot
    gun\\shell_helix_P42334_dev\\install\\core\\scripts\\tank_cmd.py',
    '\\\\VSERVER01\\shotgun\\shell_helix_P42334_dev\\', 'Shot', 'EV118',
    'preview_folders', '--debug']
    DEBUG [10:30:07 469.000101089]:
    DEBUG [10:30:07 469.000101089]:
    DEBUG [10:30:07 469.000101089]: Code install root:
    \\VSERVER01\shotgun\shell_helix_P42334_dev\
    DEBUG [10:30:07 470.00002861]: Pipeline Config Root:
    \\VSERVER01\shotgun\shell_helix_P42334_dev\
    DEBUG [10:30:07 470.999956131]:
    DEBUG [10:30:07 470.999956131]:
    DEBUG [10:30:07 471.999883652]:
    DEBUG [10:30:07 471.999883652]: Context items: ['Shot', 'EV118']
    DEBUG [10:30:07 473.000049591]: Command: preview_folders
    DEBUG [10:30:07 473.000049591]: Command Arguments: []
    DEBUG [10:30:07 473.999977112]: Sgtk Pipeline Config Location:
    \\VSERVER01\shotgun\shell_helix_P42334_dev\
    DEBUG [10:30:07 473.999977112]: Location of this script (__file__):
    \\VSERVER01\shotgun\shell_helix_P42334_dev\install\core\scripts\tank_cmd.py

Welcome to the Shotgun Pipeline Toolkit!
    For documentation, see https://toolkit.shotgunsoftware.com
    You are running a tank command associated with Shotgun Project 'Shell Helix'.
    Only items associated with this project will be considered.
    - Found Shot EV118 (Project 'Shell Helix')
    DEBUG [10:30:09 358.000040054]: Sgtk API and Context resolve complete.
    DEBUG [10:30:09 359.999895096]: Sgtk API: Sgtk Core v0.14.48, config
    \\VSERVER01\shotgun\shell_helix_P42334_dev
    DEBUG [10:30:09 846.999883652]: Context: Shot EV118
    - Using configuration 'dev' and Core v0.14.48
    - Setting the Context to Shot EV118.
    DEBUG [10:30:09 857.000112534]: No need to load up the engine for this
    command.
    - Running command preview_folders...


    ----------------------------------------------------------------------
    Command: Preview folders
    ----------------------------------------------------------------------

Previewing folder creation, stand by...
The following items were processed:
In total, 0 folders were processed.
    Note - this was a preview and no actual folders were created.
    DEBUG [10:30:23 483.999967575]: Exiting with exit code None

    So the preview folders command takes 12 seconds to process 0 folders, could this be optimized ?

  • 0
    Avatar
    Donat Van Bellinghen

     

    Are there other options like the defer_creation available ?

    In particular, is there an option that would kind of be the opposite of 'defer-creation', where I could tell toolkit to ignore a folder when a particular engine (nuke in this scenario) is used ? Something like :

    # do not create this folder for nuke
ignore_creation: 'tk-nuke'
  • 0
    Avatar
    KP

    Hey Donat,

    You've uncovered an area of our code that could use some significant optimization. Even when you preview the folder creation with everything deferred, the code still walks through the folder schema to figure out what folders it would create. There's an opportunity for us to optimize the code here so we'll work up a ticket for that.

    On top of that, Windows network file shares are notoriously slow and all of the I/O processes that the folder creation requires exacerbates the issue quite a bit. I think if you ran the same command on the same config but on linux for example, you'd see a dramatic performance improvement. That's not an excuse though! Just an explanation. We can still optimize on our end to make this better. Do you have a mac or linux setup you could do a similar test on as well? It would be interesting to see the difference in speed.

    We don't have an option for ignoring the folder creation as you've requested. Even if the folders are already created on disk, when you launch Nuke, Toolkit needs to check and make sure that the folders are in fact there and if you've modified your schema since they were created. So that will always take some time. But again, this can certainly be sped up on our end and made more intelligent (perhaps by only ensuring the Nuke Step folders are there as you suggest).  But I think what you've done so far with deferring folder creation for Maya is the right direction. We'll see what we can do on our end to speed things up as well.

  • 0
    Avatar
    Donat Van Bellinghen

    Hi KP,

    We don't use linux, so I cannot test this. I will see if I can test this on MacOS though. But like you I'd bet it would be faster on those OSes.

    About the "defer_creation" property, would it be possible to add the ability to defer the creation of folders for anything but Nuke ? Like for example:

    defer_creation : NOT 'tk-nuke'

    I can optimize the folder creation as I already have by deferring the creation to the maya egine, but what if some (sub)folders contain stuff needed for some other software, like Houdini for example ? I'm afraid I  will run  into problems using this method.

     

     

     

  • 0
    Avatar
    Deepak Mathur

    Hi Donat/KP,

    The initialization takes about 17 secs for me. 

    The command used : tank editor --debug (editor is a shotgun app on windows). Is there anything that could be done to reduce the init time ? Any sort of help would be great. Here's the output.

    "tank.bat called"
    DEBUG [13:31:46 548.000097275]: Debug logging enabled. To permanently enable it, set the TK_DEBUG environment variable.
    DEBUG [13:31:46 562.99996376]: Setting TK_DEBUG in the environment for this session. This ensures that subprocesses spawned from this process will inherit the global debug logging setting from this process.
    DEBUG [13:31:46 562.99996376]:
    DEBUG [13:31:46 562.99996376]: A log file can be found in C:\Users\deepak.mathur\AppData\Roaming\Shotgun\Logs
    DEBUG [13:31:46 562.99996376]:
    DEBUG [13:31:46 562.99996376]: Full command line passed: ['\\\\hal\\WIP\\DEPARTMENTS\\DEV\\deepakm\\studio\\install\\core\\scripts\\tank_cmd.py', '\\\\hal\\WIP\\DEPARTMENTS\\DEV\\deepakm\\studio', '--debug', 'pe', '--pc=W:\\DEPARTMENTS\\DEV\\deepakm\\bot']
    DEBUG [13:31:46 562.99996376]:
    DEBUG [13:31:46 562.99996376]:
    DEBUG [13:31:46 562.99996376]: Code install root: \\hal\WIP\DEPARTMENTS\DEV\deepakm\studio
    DEBUG [13:31:46 562.99996376]: Pipeline Config Root: W:\DEPARTMENTS\DEV\deepakm\bot
    DEBUG [13:31:46 562.99996376]:
    DEBUG [13:31:46 562.99996376]:
    DEBUG [13:31:46 562.99996376]: Reading user settings from C:\Users\deepak.mathur\AppData\Roaming\Shotgun\Preferences\toolkit.ini
    DEBUG [13:31:46 562.99996376]: Default site: <missing>
    DEBUG [13:31:46 562.99996376]: Default login: <missing>
    DEBUG [13:31:46 562.99996376]: Shotgun proxy: <missing>
    DEBUG [13:31:46 562.99996376]: App Store proxy: <missing>
    DEBUG [13:31:46 562.99996376]: System proxy: <missing>
    DEBUG [13:31:46 588.000059128]: Loading 'C:\Users\deepak.mathur\AppData\Roaming\Shotgun\locksmith.shotgunstudio.com\authentication.yml'
    DEBUG [13:31:46 589.999914169]: Current user is 'deepak.mathur'
    DEBUG [13:31:46 595.00002861]: Loading 'C:\Users\deepak.mathur\AppData\Roaming\Shotgun\locksmith.shotgunstudio.com\authentication.yml'
    DEBUG [13:31:46 595.999956131]: Current user is 'deepak.mathur'
    DEBUG [13:31:46 595.999956131]: Loading 'C:\Users\deepak.mathur\AppData\Roaming\Shotgun\locksmith.shotgunstudio.com\authentication.yml'
    DEBUG [13:31:46 601.000070572]: Checking if we need to update cached session data for site 'https://locksmith.shotgunstudio.com' and user 'deepak.mathur' in C:\Users\deepak.mathur\AppData\Roaming\Shotgun\locksmith.shotgunstudio.com\authentication.yml...
    DEBUG [13:31:46 601.000070572]: Loading 'C:\Users\deepak.mathur\AppData\Roaming\Shotgun\locksmith.shotgunstudio.com\authentication.yml'
    DEBUG [13:31:46 601.000070572]: Session data was already up to date.
    DEBUG [13:31:46 601.000070572]:
    DEBUG [13:31:46 601.000070572]: Context items: ['W:\\DEPARTMENTS\\DEV\\deepakm\\bot']
    DEBUG [13:31:46 601.000070572]: Command: pe
    DEBUG [13:31:46 601.000070572]: Command Arguments: []
    DEBUG [13:31:46 601.000070572]: Sgtk Pipeline Config Location: W:\DEPARTMENTS\DEV\deepakm\bot
    DEBUG [13:31:46 601.000070572]: Location of this script (__file__): \\hal\WIP\DEPARTMENTS\DEV\deepakm\studio\install\core\scripts\tank_cmd.py

    Welcome to the Shotgun Pipeline Toolkit!
    For documentation, see https://support.shotgunsoftware.com
    Starting Toolkit for your current path 'W:\DEPARTMENTS\DEV\deepakm\bot'
    DEBUG [13:31:46 601.000070572]: Executing sgtk.from_path factory for 'W:\DEPARTMENTS\DEV\deepakm\bot'
    DEBUG [13:31:46 617.000102997]: The path W:\DEPARTMENTS\DEV\deepakm\bot points at a pipeline configuration.
    DEBUG [13:31:46 617.000102997]: Resolved the official path registered in Shotgun to be \\HAL\WIP\DEPARTMENTS\DEV\deepakm\bot.
    DEBUG [13:31:46 898.000001907]: Creating StorageRoots instance from config: \\HAL\WIP\DEPARTMENTS\DEV\deepakm\bot\config
    DEBUG [13:31:46 914.000034332]: Initializing storage roots object. Supplied config folder: \\HAL\WIP\DEPARTMENTS\DEV\deepakm\bot\config
    DEBUG [13:31:46 914.000034332]: Storage roots file defined in the config: \\HAL\WIP\DEPARTMENTS\DEV\deepakm\bot\config\core\roots.yml
    DEBUG [13:31:46 914.000034332]: Reading storage roots file form disk: \\HAL\WIP\DEPARTMENTS\DEV\deepakm\bot\config\core\roots.yml
    DEBUG [13:31:46 914.000034332]: Read metadata: {'primary': {'mac_path': '/Volumes/data/shotgun/projects', 'windows_path': '\\\\HAL\\data\\shotgun\\projects', 'linux_path': '/data/shotgun/projects'}}
    DEBUG [13:31:46 914.000034332]: Storage roots metadata: {'primary': {'mac_path': '/Volumes/data/shotgun/projects', 'windows_path': '\\\\HAL\\data\\shotgun\\projects', 'linux_path': '/data/shotgun/projects'}}
    DEBUG [13:31:46 914.000034332]: Processing required storages defined by the config...
    DEBUG [13:31:46 914.000034332]: Processing storage: primary - {'mac_path': '/Volumes/data/shotgun/projects', 'windows_path': '\\\\HAL\\data\\shotgun\\projects', 'linux_path': '/data/shotgun/projects'}
    DEBUG [13:31:46 928.999900818]: No default storage explicitly defined...
    DEBUG [13:31:46 928.999900818]: Storage primary identified as the default root because it is the only root required by the configuration
    DEBUG [13:31:46 928.999900818]: Created: <StorageRoots folder:'\\HAL\WIP\DEPARTMENTS\DEV\deepakm\bot\config', roots:'primary'>
    DEBUG [13:31:46 976.000070572]: sgtk.from_path resolved 'W:\DEPARTMENTS\DEV\deepakm\bot' -> <Sgtk Configuration \\HAL\WIP\DEPARTMENTS\DEV\deepakm\bot>
    - The path is not associated with any Shotgun object.
    - Falling back on default project settings.
    DEBUG [13:31:47 210.999965668]: Sgtk API and Context resolve complete.
    DEBUG [13:31:47 210.999965668]: Sgtk API: Sgtk Core v0.18.159, config \\HAL\WIP\DEPARTMENTS\DEV\deepakm\bot
    DEBUG [13:31:47 210.999965668]: Context: Project BOT
    - Running as user 'deepak.mathur'
    - Using configuration 'Deepak Dev' and Core v0.18.159
    - Setting the Context to Project BOT.
    DEBUG [13:31:47 242.000102997]: Loading environment data from path: \\HAL\WIP\DEPARTMENTS\DEV\deepakm\bot\config\env\project.yml
    DEBUG [13:31:47 351.000070572]: Creating shotgun connection from <SessionUser deepak.mathur @ https://locksmith.shotgunstudio.com>...
    DEBUG [13:31:47 351.000070572]: create_sg_connection: 0.000000s
    DEBUG [13:31:49 790.999889374]: Probing for a shell engine. ctx 'Project BOT' --> environment 'Environment project.yml'
    DEBUG [13:31:49 790.999889374]: Looks like the environment has a tk-shell engine. Trying to start it.
    DEBUG [13:31:49 790.999889374]: Loading environment data from path: \\HAL\WIP\DEPARTMENTS\DEV\deepakm\bot\config\env\project.yml
    DEBUG [13:31:49 868.999958038]: Pre-core-0.18.120 download found at '\\hal\WIP\DEPARTMENTS\DEV\deepakm\studio\install\app_store\tk-shell\v0.6.0'. Assuming it is complete.
    DEBUG [13:31:49 868.999958038]: Pre-core-0.18.120 download found at '\\hal\WIP\DEPARTMENTS\DEV\deepakm\studio\install\app_store\tk-shell\v0.6.0'. Assuming it is complete.
    DEBUG [13:31:49 947.999954224]: Pre-core-0.18.120 download found at '\\hal\WIP\DEPARTMENTS\DEV\deepakm\studio\install\app_store\tk-shell\v0.6.0'. Assuming it is complete.
    DEBUG [13:31:49 947.999954224]: Pre-core-0.18.120 download found at '\\hal\WIP\DEPARTMENTS\DEV\deepakm\studio\install\app_store\tk-shell\v0.6.0'. Assuming it is complete.
    DEBUG [13:31:49 963.000059128]: Engine init: Instantiating <Sgtk Engine 0x0451f7f0: tk-shell, env: project>
    DEBUG [13:31:49 963.000059128]: Engine init: Current Context: Project BOT
    DEBUG [13:31:49 963.000059128]: Successfully initialized PySide '1.2.2' located in C:\Program Files\Shotgun\Python\lib\site-packages\PySide\__init__.py.
    DEBUG [13:31:49 963.000059128]: Requesting Qt5-like interface
    DEBUG [13:31:50 72.0000267029]: No Qt matching that interface was found.
    DEBUG [13:31:50 118.999958038]: App init: Instantiating <Sgtk App 0x04528048: scout_hub, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>
    DEBUG [13:31:50 118.999958038]: Importing python modules in \\hal\WIP\DEPARTMENTS\DEV\deepakm\studio\install\git\scout_hub.git\v1.0.2\python...
    DEBUG [13:31:50 197.000026703]: Registering command 'Scout Hub' with options:
    {'app': <Sgtk App 0x04528048: scout_hub, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>,
    'description': 'Hub for managing data out of a scout session.',
    'group': 'Console',
    'icon': '\\\\hal\\WIP\\DEPARTMENTS\\DEV\\deepakm\\studio\\install\\git\\scout_hub.git\\v1.0.2\\icon_256.png',
    'prefix': None,
    'short_name': 'sh'}
    DEBUG [13:31:50 229.000091553]: App init: Instantiating <Sgtk App 0x0452e668: edio, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>
    DEBUG [13:31:50 243.999958038]: Importing python modules in W:\DEPARTMENTS\DEV\deepakm\dev\shotgun_apps\edio\python...
    DEBUG [13:31:51 563.999891281]: Registering command 'edio' with options:
    {'app': <Sgtk App 0x0452e668: edio, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>,
    'description': 'App for publish editorial shot data',
    'icon': 'W:\\DEPARTMENTS\\DEV\\deepakm\\dev\\shotgun_apps\\edio\\icon_256.png',
    'prefix': None}
    DEBUG [13:31:51 618.000030518]: The 'default' value set for hook 'hook_app_launch'. Skipping validation.
    DEBUG [13:31:51 618.000030518]: The 'default' value set for hook 'hook_before_app_launch'. Skipping validation.
    DEBUG [13:31:51 648.999929428]: App init: Instantiating <Sgtk App 0x035774a8: tk-multi-launchapp, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>
    DEBUG [13:31:51 648.999929428]: Registering instance tk-framework-shotgunutils_v5.x.x as tk-framework-shotgunutils in <Sgtk App 0x035774a8: tk-multi-launchapp, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>
    DEBUG [13:31:51 680.000066757]: <Sgtk Framework 0x03577b38: tk-framework-shotgunutils, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>: Initializing...
    DEBUG [13:31:51 680.000066757]: Posting old cached data clean up...
    DEBUG [13:31:51 696.000099182]: Cleaning all files with a modification date older than 2019-01-19 13:31:51.696000 under locations C:\Users\deepak.mathur\AppData\Roaming\Shotgun\locksmith\site\fw-shotgunutils\sg, C:\Users\deepak.mathur\AppData\Roaming\Shotgun\locksmith\site\fw-shotgunutils\sg_nav, C:\Users\deepak.mathur\AppData\Roaming\Shotgun\locksmith\site\fw-shotgunutils\thumbs, C:\Users\deepak.mathur\AppData\Roaming\Shotgun\locksmith\site\fw-shotgunutils\multi_context, C:\Users\deepak.mathur\AppData\Roaming\Shotgun\locksmith\p158c122\fw-shotgunutils\sg, C:\Users\deepak.mathur\AppData\Roaming\Shotgun\locksmith\p158c122\fw-shotgunutils\sg_nav, C:\Users\deepak.mathur\AppData\Roaming\Shotgun\locksmith\p158c122\fw-shotgunutils\thumbs, C:\Users\deepak.mathur\AppData\Roaming\Shotgun\locksmith\p158c122\fw-shotgunutils\multi_context
    DEBUG [13:31:51 696.000099182]: Importing python modules in \\hal\WIP\DEPARTMENTS\DEV\deepakm\studio\install\app_store\tk-multi-launchapp\v0.10.0\python...
    DEBUG [13:31:51 882.999897003]: Loading environment data from path: \\HAL\WIP\DEPARTMENTS\DEV\deepakm\bot\config\env\project.yml
    DEBUG [13:31:51 961.999893188]: Registering command launch_photoshop to launch C:\Program Files\Adobe\Adobe Photoshop CC 2017\Photoshop.exe with args for engine tk-photoshopcc
    DEBUG [13:31:51 961.999893188]: Registering command 'launch_photoshop' with options:
    {'app': <Sgtk App 0x035774a8: tk-multi-launchapp, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>,
    'description': 'Launches and initializes an application environment.',
    'engine_name': 'tk-photoshopcc',
    'group': '',
    'group_default': False,
    'icon': '\\\\hal\\WIP\\DEPARTMENTS\\DEV\\deepakm\\studio\\install\\app_store\\tk-photoshopcc\\v1.6.2\\icon_256.png',
    'prefix': None,
    'short_name': 'launch_photoshop',
    'title': 'Launch Photoshop'}
    DEBUG [13:31:52 23.9999294281]: App init: Instantiating <Sgtk App 0x03569780: lsd, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>
    DEBUG [13:31:52 23.9999294281]: Registering instance tk-framework-shotgunutils_v5.x.x as tk-framework-shotgunutils in <Sgtk App 0x03569780: lsd, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>
    DEBUG [13:31:52 23.9999294281]: Registering instance tk-framework-qtwidgets_v2.x.x as tk-framework-qtwidgets in <Sgtk App 0x03569780: lsd, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>
    DEBUG [13:31:52 85.9999656677]: Registering instance tk-framework-shotgunutils_v5.x.x as tk-framework-shotgunutils in <Sgtk Framework 0x03586a20: tk-framework-qtwidgets, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>
    DEBUG [13:31:52 85.9999656677]: <Sgtk Framework 0x03586a20: tk-framework-qtwidgets, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>: Initializing...
    DEBUG [13:31:52 85.9999656677]: Importing python modules in W:\DEPARTMENTS\DEV\deepakm\dev\shotgun_apps\lsd\python...
    DEBUG [13:31:52 655.999898911]: Importing python modules in \\hal\WIP\DEPARTMENTS\DEV\deepakm\studio\install\app_store\tk-framework-qtwidgets\v2.8.2\python...
    DEBUG [13:31:53 155.999898911]: Importing python modules in \\hal\WIP\DEPARTMENTS\DEV\deepakm\studio\install\app_store\tk-framework-shotgunutils\v5.5.0\python...
    DEBUG [13:31:59 697.000026703]: Registering command 'lsd' with options:
    {'app': <Sgtk App 0x03569780: lsd, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>,
    'description': 'Launches the Locksmith Desktop',
    'icon': 'W:\\DEPARTMENTS\\DEV\\deepakm\\dev\\shotgun_apps\\lsd\\icon_256.png',
    'prefix': None}
    DEBUG [13:31:59 762.000083923]: The 'default' value set for hook 'hook_app_launch'. Skipping validation.
    DEBUG [13:31:59 762.000083923]: The 'default' value set for hook 'hook_before_app_launch'. Skipping validation.
    DEBUG [13:31:59 762.000083923]: App init: Instantiating <Sgtk App 0x05d37be0: tk-multi-launchapp, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>
    DEBUG [13:31:59 778.000116348]: Registering instance tk-framework-shotgunutils_v5.x.x as tk-framework-shotgunutils in <Sgtk App 0x05d37be0: tk-multi-launchapp, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>
    DEBUG [13:31:59 778.000116348]: Importing python modules in \\hal\WIP\DEPARTMENTS\DEV\deepakm\studio\install\app_store\tk-multi-launchapp\v0.10.0\python...
    DEBUG [13:31:59 825.000047684]: Loading environment data from path: \\HAL\WIP\DEPARTMENTS\DEV\deepakm\bot\config\env\project.yml
    DEBUG [13:31:59 950.000047684]: Unable to apply group '' group_default value to list of DCC versions : ['2018']. Setting group '' default to highest version '2018' instead.
    DEBUG [13:31:59 950.000047684]: Registering command launch_maya_2018 to launch C:\Program Files\Autodesk\Maya2018\bin\maya.exe with args for engine tk-maya
    DEBUG [13:31:59 950.000047684]: Registering command 'launch_maya_2018' with options:
    {'app': <Sgtk App 0x05d37be0: tk-multi-launchapp, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>,
    'description': 'Launches and initializes an application environment.',
    'engine_name': 'tk-maya',
    'group': '',
    'group_default': True,
    'icon': '\\\\hal\\WIP\\DEPARTMENTS\\DEV\\deepakm\\studio\\install\\app_store\\tk-maya\\v0.9.3\\icon_256.png',
    'prefix': None,
    'short_name': 'launch_maya_2018',
    'title': 'Launch Maya 2018'}
    DEBUG [13:32:00 12.0000839233]: App init: Instantiating <Sgtk App 0x05d4b550: tk-multi-publish2, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>
    DEBUG [13:32:00 28.0001163483]: Registering instance tk-framework-shotgunutils_v5.x.x as tk-framework-shotgunutils in <Sgtk App 0x05d4b550: tk-multi-publish2, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>
    DEBUG [13:32:00 28.0001163483]: Registering instance tk-framework-qtwidgets_v2.x.x as tk-framework-qtwidgets in <Sgtk App 0x05d4b550: tk-multi-publish2, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>
    DEBUG [13:32:00 28.0001163483]: Importing python modules in \\hal\WIP\DEPARTMENTS\DEV\deepakm\studio\install\app_store\tk-multi-publish2\v2.1.6\python...
    DEBUG [13:32:00 216.000080109]: Registering command 'Publish...' with options:
    {'app': <Sgtk App 0x05d4b550: tk-multi-publish2, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>,
    'description': 'Publishing of data to Shotgun',
    'icon': '\\\\hal\\WIP\\DEPARTMENTS\\DEV\\deepakm\\studio\\install\\app_store\\tk-multi-publish2\\v2.1.6\\icon_256.png',
    'icons': {'dark': {'png': '\\\\hal\\WIP\\DEPARTMENTS\\DEV\\deepakm\\studio\\install\\app_store\\tk-multi-publish2\\v2.1.6\\icon_256_dark.png'}},
    'prefix': None,
    'short_name': 'publish'}
    DEBUG [13:32:00 262.000083923]: App init: Instantiating <Sgtk App 0x0620c6d8: alembic_exporter, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>
    DEBUG [13:32:00 262.000083923]: Importing python modules in \\hal\WIP\DEPARTMENTS\DEV\deepakm\studio\install\git\alembic_exporter.git\v1.0.2\python...
    DEBUG [13:32:00 434.000015259]: Registering command 'alembic_exporter' with options:
    {'app': <Sgtk App 0x0620c6d8: alembic_exporter, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>,
    'description': 'Export maya scene as alembic file and save maya camera as separate file.',
    'icon': '\\\\hal\\WIP\\DEPARTMENTS\\DEV\\deepakm\\studio\\install\\git\\alembic_exporter.git\\v1.0.2\\icon_256.png',
    'prefix': None}
    DEBUG [13:32:00 480.999946594]: App init: Instantiating <Sgtk App 0x0620dc50: shotgun_stan, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>
    DEBUG [13:32:00 492.000102997]: Importing python modules in W:\DEPARTMENTS\DEV\deepakm\dev\shotgun_apps\shotgun_stan\python...
    DEBUG [13:32:00 538.000106812]: Registering command 'Stan...' with options:
    {'app': <Sgtk App 0x0620dc50: shotgun_stan, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>,
    'description': 'Stan - Standalone Publisher',
    'icon': 'W:\\DEPARTMENTS\\DEV\\deepakm\\dev\\shotgun_apps\\shotgun_stan\\icon_256.png',
    'icons': {'dark': {'png': 'W:\\DEPARTMENTS\\DEV\\deepakm\\dev\\shotgun_apps\\shotgun_stan\\resources\\LSD_logo_stan.png'}},
    'prefix': None,
    'short_name': 'stan'}
    DEBUG [13:32:00 553.999900818]: Pre-core-0.18.120 download found at '\\hal\WIP\DEPARTMENTS\DEV\deepakm\studio\install\app_store\tk-multi-screeningroom\v0.3.3'. Assuming it is complete.
    DEBUG [13:32:00 553.999900818]: Pre-core-0.18.120 download found at '\\hal\WIP\DEPARTMENTS\DEV\deepakm\studio\install\app_store\tk-multi-screeningroom\v0.3.3'. Assuming it is complete.
    DEBUG [13:32:00 553.999900818]: Pre-core-0.18.120 download found at '\\hal\WIP\DEPARTMENTS\DEV\deepakm\studio\install\app_store\tk-multi-screeningroom\v0.3.3'. Assuming it is complete.
    DEBUG [13:32:00 578.000068665]: Pre-core-0.18.120 download found at '\\hal\WIP\DEPARTMENTS\DEV\deepakm\studio\install\app_store\tk-multi-screeningroom\v0.3.3'. Assuming it is complete.
    DEBUG [13:32:00 578.999996185]: Pre-core-0.18.120 download found at '\\hal\WIP\DEPARTMENTS\DEV\deepakm\studio\install\app_store\tk-multi-screeningroom\v0.3.3'. Assuming it is complete.
    DEBUG [13:32:00 592.000007629]: App init: Instantiating <Sgtk App 0x0621a390: tk-multi-screeningroom, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>
    DEBUG [13:32:00 592.000007629]: Pre-core-0.18.120 download found at '\\hal\WIP\DEPARTMENTS\DEV\deepakm\studio\install\app_store\tk-multi-screeningroom\v0.3.3'. Assuming it is complete.
    DEBUG [13:32:00 592.000007629]: Registering command 'Jump to Screening Room in RV' with options:
    {'app': <Sgtk App 0x0621a390: tk-multi-screeningroom, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>,
    'description': 'Screening Room integration right inside your application.',
    'icon': '\\\\hal\\WIP\\DEPARTMENTS\\DEV\\deepakm\\studio\\install\\app_store\\tk-multi-screeningroom\\v0.3.3\\icon_256.png',
    'prefix': None,
    'short_name': 'screening_room_rv',
    'type': 'context_menu'}
    DEBUG [13:32:00 592.000007629]: Pre-core-0.18.120 download found at '\\hal\WIP\DEPARTMENTS\DEV\deepakm\studio\install\app_store\tk-multi-screeningroom\v0.3.3'. Assuming it is complete.
    DEBUG [13:32:00 592.000007629]: Registering command 'Jump to Screening Room Web Player' with options:
    {'app': <Sgtk App 0x0621a390: tk-multi-screeningroom, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>,
    'description': 'Screening Room integration right inside your application.',
    'icon': '\\\\hal\\WIP\\DEPARTMENTS\\DEV\\deepakm\\studio\\install\\app_store\\tk-multi-screeningroom\\v0.3.3\\icon_256.png',
    'prefix': None,
    'short_name': 'screening_room_web',
    'type': 'context_menu'}
    DEBUG [13:32:00 592.000007629]: Pre-core-0.18.120 download found at '\\hal\WIP\DEPARTMENTS\DEV\deepakm\studio\install\app_store\tk-multi-screeningroom\v0.3.3'. Assuming it is complete.
    DEBUG [13:32:00 638.999938965]: Validated setting 'hook_app_launch' hook path exists: \\HAL\WIP\DEPARTMENTS\DEV\deepakm\bot\config\hooks\tk-multi-launchapp\rez_app_launch.py
    DEBUG [13:32:00 638.999938965]: Validated setting 'hook_before_register_command' hook path exists: \\HAL\WIP\DEPARTMENTS\DEV\deepakm\bot\config\hooks\tk-multi-launchapp\before_register_command.py
    DEBUG [13:32:00 638.999938965]: App init: Instantiating <Sgtk App 0x0620df28: tk-multi-launchapp, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>
    DEBUG [13:32:00 638.999938965]: Registering instance tk-framework-shotgunutils_v5.x.x as tk-framework-shotgunutils in <Sgtk App 0x0620df28: tk-multi-launchapp, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>
    DEBUG [13:32:00 638.999938965]: Importing python modules in \\hal\WIP\DEPARTMENTS\DEV\deepakm\studio\install\app_store\tk-multi-launchapp\v0.10.0\python...
    DEBUG [13:32:00 671.000003815]: Searching for Software entities matching filters:
    [ ['sg_status_list', 'is', 'act'],
    { 'filter_operator': 'or',
    'filters': [ ['projects', 'is', None],
    [ 'projects',
    'in',
    { 'id': 158, 'name': 'BOT', 'type': 'Project'}]]},
    { 'filter_operator': 'or',
    'filters': [ ['user_restrictions', 'is', None],
    { 'filter_operator': 'or',
    'filters': [ [ 'user_restrictions',
    'in',
    { 'id': 383,
    'name': 'Deepak Mathur',
    'type': 'HumanUser'}],
    [ 'user_restrictions.Group.users',
    'in',
    { 'id': 383,
    'name': 'Deepak Mathur',
    'type': 'HumanUser'}]]}]}]
    DEBUG [13:32:00 858.000040054]: Got software data from Shotgun:
    [{'code': '3ds Max',
    'engine': 'tk-3dsmaxplus',
    'group_default': False,
    'group_name': None,
    'id': 1,
    'image': None,
    'linux_args': None,
    'linux_path': None,
    'mac_args': None,
    'mac_path': None,
    'products': None,
    'type': 'Software',
    'version_names': None,
    'windows_args': None,
    'windows_path': None},
    {'code': 'Houdini',
    'engine': 'tk-houdini',
    'group_default': False,
    'group_name': None,
    'id': 2,
    'image': None,
    'linux_args': None,
    'linux_path': None,
    'mac_args': None,
    'mac_path': None,
    'products': 'Houdini, Houdini FX, Houdini Core',
    'type': 'Software',
    'version_names': None,
    'windows_args': None,
    'windows_path': None},
    {'code': 'Maya',
    'engine': 'tk-maya',
    'group_default': False,
    'group_name': None,
    'id': 3,
    'image': None,
    'linux_args': None,
    'linux_path': None,
    'mac_args': None,
    'mac_path': None,
    'products': None,
    'type': 'Software',
    'version_names': '2018',
    'windows_args': None,
    'windows_path': None},
    {'code': 'Nuke',
    'engine': 'tk-nuke',
    'group_default': False,
    'group_name': None,
    'id': 4,
    'image': None,
    'linux_args': None,
    'linux_path': None,
    'mac_args': None,
    'mac_path': None,
    'products': None,
    'type': 'Software',
    'version_names': None,
    'windows_args': None,
    'windows_path': None},
    {'code': 'Photoshop',
    'engine': 'tk-photoshopcc',
    'group_default': False,
    'group_name': None,
    'id': 5,
    'image': None,
    'linux_args': None,
    'linux_path': None,
    'mac_args': None,
    'mac_path': None,
    'products': None,
    'type': 'Software',
    'version_names': None,
    'windows_args': None,
    'windows_path': None},
    {'code': 'Flame',
    'engine': 'tk-flame',
    'group_default': False,
    'group_name': None,
    'id': 6,
    'image': None,
    'linux_args': None,
    'linux_path': None,
    'mac_args': None,
    'mac_path': None,
    'products': None,
    'type': 'Software',
    'version_names': None,
    'windows_args': None,
    'windows_path': None}]
    DEBUG [13:32:00 858.000040054]: --------------------
    DEBUG [13:32:00 874.000072479]: Parsing Software entity for launch commands:
    { 'code': '3ds Max',
    'engine': 'tk-3dsmaxplus',
    'group_default': False,
    'group_name': None,
    'id': 1,
    'image': None,
    'linux_args': None,
    'linux_path': None,
    'mac_args': None,
    'mac_path': None,
    'products': None,
    'type': 'Software',
    'version_names': None,
    'windows_args': None,
    'windows_path': None}
    DEBUG [13:32:00 874.000072479]: All path fields are None. Automatic mode.
    DEBUG [13:32:00 874.000072479]: Attempting to auto discover software for tk-3dsmaxplus.
    DEBUG [13:32:00 874.000072479]: Initializing engine launcher for tk-3dsmaxplus.
    DEBUG [13:32:00 874.000072479]: Loading environment data from path: \\HAL\WIP\DEPARTMENTS\DEV\deepakm\bot\config\env\project.yml
    DEBUG [13:32:00 983.000040054]: Unable to construct engine launcher for tk-3dsmaxplus. Cannot determine corresponding DCC application information:
    Cannot find an engine instance tk-3dsmaxplus in Environment project.yml.
    DEBUG [13:32:00 983.000040054]: Scan detected 0 software versions
    DEBUG [13:32:00 983.000040054]: --------------------
    DEBUG [13:32:00 983.000040054]: Parsing Software entity for launch commands:
    { 'code': 'Houdini',
    'engine': 'tk-houdini',
    'group_default': False,
    'group_name': None,
    'id': 2,
    'image': None,
    'linux_args': None,
    'linux_path': None,
    'mac_args': None,
    'mac_path': None,
    'products': 'Houdini, Houdini FX, Houdini Core',
    'type': 'Software',
    'version_names': None,
    'windows_args': None,
    'windows_path': None}
    DEBUG [13:32:00 983.000040054]: All path fields are None. Automatic mode.
    DEBUG [13:32:00 983.000040054]: Attempting to auto discover software for tk-houdini.
    DEBUG [13:32:00 983.000040054]: Initializing engine launcher for tk-houdini.
    DEBUG [13:32:00 983.000040054]: Loading environment data from path: \\HAL\WIP\DEPARTMENTS\DEV\deepakm\bot\config\env\project.yml
    DEBUG [13:32:01 76.9999027252]: Unable to construct engine launcher for tk-houdini. Cannot determine corresponding DCC application information:
    Cannot find an engine instance tk-houdini in Environment project.yml.
    DEBUG [13:32:01 76.9999027252]: Scan detected 0 software versions
    DEBUG [13:32:01 76.9999027252]: --------------------
    DEBUG [13:32:01 76.9999027252]: Parsing Software entity for launch commands:
    { 'code': 'Maya',
    'engine': 'tk-maya',
    'group_default': False,
    'group_name': None,
    'id': 3,
    'image': None,
    'linux_args': None,
    'linux_path': None,
    'mac_args': None,
    'mac_path': None,
    'products': None,
    'type': 'Software',
    'version_names': '2018',
    'windows_args': None,
    'windows_path': None}
    DEBUG [13:32:01 76.9999027252]: All path fields are None. Automatic mode.
    DEBUG [13:32:01 88.9999866486]: Attempting to auto discover software for tk-maya.
    DEBUG [13:32:01 89.9999141693]: Initializing engine launcher for tk-maya.
    DEBUG [13:32:01 92.0000076294]: Loading environment data from path: \\HAL\WIP\DEPARTMENTS\DEV\deepakm\bot\config\env\project.yml
    DEBUG [13:32:01 183.000087738]: Loading SoftwareLauncher plugin '\\hal\WIP\DEPARTMENTS\DEV\deepakm\studio\install\app_store\tk-maya\v0.9.3\startup.py' ...
    DEBUG [13:32:01 213.999986649]: Created SoftwareLauncher instance: <93ed106f8f984104a1b59a58fa656f98.MayaLauncher object at 0x0000000006220FD0>
    DEBUG [13:32:01 213.999986649]: Scanning for Toolkit engine tk-maya local applications.
    DEBUG [13:32:01 213.999986649]: Scanning for Maya executables...
    DEBUG [13:32:01 213.999986649]: Processing template C:/Program Files/Autodesk/Maya{version}/bin/maya.exe.
    DEBUG [13:32:01 230.000019073]: Template was sanitized from 'C:/Program Files/Autodesk/Maya{version}/bin/maya.exe' to 'C:\Program Files\Autodesk\Maya{version}\bin\maya.exe'
    DEBUG [13:32:01 230.000019073]: Globbing for executable matching: C:\Program Files\Autodesk\Maya*\bin\maya.exe ...
    DEBUG [13:32:01 230.000019073]: Found 1 matches: ['C:\\Program Files\\Autodesk\\Maya2018\\bin\\maya.exe']
    DEBUG [13:32:01 230.000019073]: Now matching components with regex: ^C:\\Program Files\\Autodesk\\Maya(?P<version>[\d.]+)\\bin\\maya.exe$
    DEBUG [13:32:01 230.000019073]: Processing path: C:\Program Files\Autodesk\Maya2018\bin\maya.exe
    DEBUG [13:32:01 230.000019073]: Looking for Application icon for executable 'C:\Program Files\Autodesk\Maya2018\bin\maya.exe' ...
    DEBUG [13:32:01 230.000019073]: Resolved icon path 'C:\Program Files\Autodesk\Maya2018\icons\mayaico.png' from input executable 'C:\Program Files\Autodesk\Maya2018\bin\maya.exe'.
    DEBUG [13:32:01 230.000019073]: Scan detected 1 software versions
    DEBUG [13:32:01 230.000019073]: Running before register command hook...
    DEBUG [13:32:01 240.999937057]: <Sgtk App 0x0620df28: tk-multi-launchapp, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>: Resolved hook expression (associated with setting 'hook_before_register_command'): '{config}/tk-multi-launchapp/before_register_command.py' -> ['\\\\hal\\WIP\\DEPARTMENTS\\DEV\\deepakm\\studio\\install\\app_store\\tk-multi-launchapp\\v0.10.0\\hooks\\before_register_command.py', '\\\\HAL\\WIP\\DEPARTMENTS\\DEV\\deepakm\\bot\\config\\hooks\\tk-multi-launchapp\\before_register_command.py']
    DEBUG [13:32:01 259.999990463]: Registering command maya_2018 to launch C:\Program Files\Autodesk\Maya2018\bin\maya.exe with args for engine tk-maya
    DEBUG [13:32:01 259.999990463]: Registering command 'maya_2018' with options:
    {'app': <Sgtk App 0x0620df28: tk-multi-launchapp, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>,
    'description': 'Launches and initializes an application environment.',
    'engine_name': 'tk-maya',
    'group': 'Maya',
    'group_default': False,
    'icon': 'C:\\Program Files\\Autodesk\\Maya2018\\icons\\mayaico.png',
    'prefix': None,
    'short_name': 'maya_2018',
    'title': 'Maya 2018'}
    DEBUG [13:32:01 259.999990463]: --------------------
    DEBUG [13:32:01 259.999990463]: Parsing Software entity for launch commands:
    { 'code': 'Nuke',
    'engine': 'tk-nuke',
    'group_default': False,
    'group_name': None,
    'id': 4,
    'image': None,
    'linux_args': None,
    'linux_path': None,
    'mac_args': None,
    'mac_path': None,
    'products': None,
    'type': 'Software',
    'version_names': None,
    'windows_args': None,
    'windows_path': None}
    DEBUG [13:32:01 259.999990463]: All path fields are None. Automatic mode.
    DEBUG [13:32:01 259.999990463]: Attempting to auto discover software for tk-nuke.
    DEBUG [13:32:01 259.999990463]: Initializing engine launcher for tk-nuke.
    DEBUG [13:32:01 275.000095367]: Loading environment data from path: \\HAL\WIP\DEPARTMENTS\DEV\deepakm\bot\config\env\project.yml
    DEBUG [13:32:01 368.999958038]: Unable to construct engine launcher for tk-nuke. Cannot determine corresponding DCC application information:
    Cannot find an engine instance tk-nuke in Environment project.yml.
    DEBUG [13:32:01 368.999958038]: Scan detected 0 software versions
    DEBUG [13:32:01 368.999958038]: --------------------
    DEBUG [13:32:01 368.999958038]: Parsing Software entity for launch commands:
    { 'code': 'Photoshop',
    'engine': 'tk-photoshopcc',
    'group_default': False,
    'group_name': None,
    'id': 5,
    'image': None,
    'linux_args': None,
    'linux_path': None,
    'mac_args': None,
    'mac_path': None,
    'products': None,
    'type': 'Software',
    'version_names': None,
    'windows_args': None,
    'windows_path': None}
    DEBUG [13:32:01 368.999958038]: All path fields are None. Automatic mode.
    DEBUG [13:32:01 368.999958038]: Attempting to auto discover software for tk-photoshopcc.
    DEBUG [13:32:01 368.999958038]: Initializing engine launcher for tk-photoshopcc.
    DEBUG [13:32:01 368.999958038]: Loading environment data from path: \\HAL\WIP\DEPARTMENTS\DEV\deepakm\bot\config\env\project.yml
    DEBUG [13:32:01 463.000059128]: Loading SoftwareLauncher plugin '\\hal\WIP\DEPARTMENTS\DEV\deepakm\studio\install\app_store\tk-photoshopcc\v1.6.2\startup.py' ...
    DEBUG [13:32:01 493.999958038]: Created SoftwareLauncher instance: <95227becfe154f8c8520198f48d2710a.PhotoshopLauncher object at 0x00000000062294A8>
    DEBUG [13:32:01 493.999958038]: Scanning for Toolkit engine tk-photoshopcc local applications.
    DEBUG [13:32:01 493.999958038]: Scanning for photoshop executables...
    DEBUG [13:32:01 493.999958038]: Using icon path: \\hal\WIP\DEPARTMENTS\DEV\deepakm\studio\install\app_store\tk-photoshopcc\v1.6.2\icon_256.png
    DEBUG [13:32:01 493.999958038]: Template was sanitized from 'C:/Program Files/Adobe/Adobe Photoshop CC {version}/Photoshop.exe' to 'C:\Program Files\Adobe\Adobe Photoshop CC {version}\Photoshop.exe'
    DEBUG [13:32:01 509.999990463]: Globbing for executable matching: C:\Program Files\Adobe\Adobe Photoshop CC *\Photoshop.exe ...
    DEBUG [13:32:01 509.999990463]: No matches were found.
    DEBUG [13:32:01 509.999990463]: Scan detected 0 software versions
    DEBUG [13:32:01 509.999990463]: --------------------
    DEBUG [13:32:01 509.999990463]: Parsing Software entity for launch commands:
    { 'code': 'Flame',
    'engine': 'tk-flame',
    'group_default': False,
    'group_name': None,
    'id': 6,
    'image': None,
    'linux_args': None,
    'linux_path': None,
    'mac_args': None,
    'mac_path': None,
    'products': None,
    'type': 'Software',
    'version_names': None,
    'windows_args': None,
    'windows_path': None}
    DEBUG [13:32:01 509.999990463]: All path fields are None. Automatic mode.
    DEBUG [13:32:01 509.999990463]: Attempting to auto discover software for tk-flame.
    DEBUG [13:32:01 509.999990463]: Initializing engine launcher for tk-flame.
    DEBUG [13:32:01 509.999990463]: Loading environment data from path: \\HAL\WIP\DEPARTMENTS\DEV\deepakm\bot\config\env\project.yml
    DEBUG [13:32:01 609.999895096]: Unable to construct engine launcher for tk-flame. Cannot determine corresponding DCC application information:
    Cannot find an engine instance tk-flame in Environment project.yml.
    DEBUG [13:32:01 609.999895096]: Scan detected 0 software versions
    DEBUG [13:32:01 641.000032425]: App init: Instantiating <Sgtk App 0x0621ab70: playblast_editor, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>
    DEBUG [13:32:01 641.000032425]: Importing python modules in W:\DEPARTMENTS\DEV\deepakm\dev\shotgun_apps\playblast_editor\python...
    DEBUG [13:32:03 348.999977112]: Registering command 'Playblast Editor' with options:
    {'app': <Sgtk App 0x0621ab70: playblast_editor, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>>,
    'description': 'Add FX to existing Playblasts.',
    'group': 'Console',
    'icon': 'W:\\DEPARTMENTS\\DEV\\deepakm\\dev\\shotgun_apps\\playblast_editor\\icon_256.png',
    'prefix': None,
    'short_name': 'pe'}
    DEBUG [13:32:03 348.999977112]: Registering command 'Open Log Folder' with options:
    {'description': 'Opens the folder where log files are being stored.',
    'icon': '\\\\hal\\WIP\\DEPARTMENTS\\DEV\\deepakm\\studio\\install\\core\\python\\tank\\platform\\qt\\folder_256.png',
    'prefix': None,
    'short_name': 'open_log_folder',
    'type': 'context_menu'}
    DEBUG [13:32:03 348.999977112]: App <Sgtk App 0x03569780: lsd, engine: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>> is registered via a dev descriptor. Will add a reload button to the actions listings.
    DEBUG [13:32:03 348.999977112]: Registering command 'Reload and Restart' with options:
    {'icon': '\\\\hal\\WIP\\DEPARTMENTS\\DEV\\deepakm\\studio\\install\\core\\python\\tank\\platform\\qt\\reload_256.png',
    'prefix': None,
    'short_name': 'restart',
    'type': 'context_menu'}
    DEBUG [13:32:03 364.000082016]: Starting metrics dispatcher...
    DEBUG [13:32:03 364.000082016]: Added worker thread: <MetricsDispatchWorkerThread(Thread-1, started daemon 10016)>
    DEBUG [13:32:03 364.000082016]: Creating shotgun connection from <SessionUser deepak.mathur @ https://locksmith.shotgunstudio.com>...
    DEBUG [13:32:03 364.000082016]: Metrics dispatcher started.
    DEBUG [13:32:03 364.000082016]: create_sg_connection: 0.000000s
    DEBUG [13:32:03 364.000082016]: Init complete: <Sgtk Engine 0x0451f7f0: tk-shell, env: project>
    DEBUG [13:32:03 380.000114441]: Started engine <Sgtk Engine 0x0451f7f0: tk-shell, env: project>
    - Started Shell Engine version v0.6.0
    - Environment: \\HAL\WIP\DEPARTMENTS\DEV\deepakm\bot\config\env\project.yml.
    - Running command pe...


    ----------------------------------------------------------------------
    Command: Pe
    ----------------------------------------------------------------------

    DEBUG [13:32:03 380.000114441]: Importing python modules in \\hal\WIP\DEPARTMENTS\DEV\deepakm\studio\install\app_store\tk-shell\v0.6.0\python...
    DEBUG [13:32:03 473.999977112]: Pre-core-0.18.120 download found at '\\hal\WIP\DEPARTMENTS\DEV\deepakm\studio\install\app_store\tk-shell\v0.6.0'. Assuming it is complete.
    DEBUG [13:32:03 473.999977112]: Applying Qt4-specific styling...
    DEBUG [13:32:03 505.000114441]: Loaded font file: \\hal\WIP\DEPARTMENTS\DEV\deepakm\studio\install\core\python\tank\platform\qt\fonts\OpenSans\OpenSans-Regular.ttf
    DEBUG [13:32:03 520.999908447]: Loaded font file: \\hal\WIP\DEPARTMENTS\DEV\deepakm\studio\install\core\python\tank\platform\qt\fonts\OpenSans\OpenSans-Bold.ttf
    DEBUG [13:32:03 542.999982834]: Loaded font file: \\hal\WIP\DEPARTMENTS\DEV\deepakm\studio\install\core\python\tank\platform\qt\fonts\OpenSans\OpenSans-Light.ttf
    DEBUG [13:32:03 559.99994278]: Loaded font file: \\hal\WIP\DEPARTMENTS\DEV\deepakm\studio\install\core\python\tank\platform\qt\fonts\OpenSans\OpenSans-Italic.ttf
    DEBUG [13:32:03 581.000089645]: Loaded font file: \\hal\WIP\DEPARTMENTS\DEV\deepakm\studio\install\core\python\tank\platform\qt\fonts\OpenSans\OpenSans-CondLight.ttf

Please sign in to leave a comment.