Paste #38186: Denizen Debug Logs From A Minecraft Server

Date: 2016/12/06 20:31:57 UTC-08:00
Type: Server Log

View Raw Paste Download This Paste
Copy Link


Java Version: 1.7.0_80
Up-time: 23m
CraftBukkit Version: git-Spigot-db6de12-07c3001 (MC: 1.8.8)
Denizen Version: Core: 1.15 (Build 77), CraftBukkit: 1.0.1-SNAPSHOT (build 1630)
Active Plugins (14): WorldEdit: 6.1.1-SNAPSHOT;3394-9a65bdb7, CorpseReborn: 2.7, Vault: 1.5.6-b49, 
Multiverse-Core: 2.5-b641, PermissionsEx: 1.23.4, ProtocolLib: 3.6.4, WorldGuard: 6.1, 
Citizens: 2.0.16-SNAPSHOT (build 1267), Denizen: 1.0.1-SNAPSHOT (build 1630), 
LibsDisguises: 8.6.5, ArmorStandTools: 2.1.1, MythicMobs: 2.3.0, Depenizen: 0.2.2 (build 304), 
Webizen: 0.2.0
Loaded Worlds (4): world, world_nether, world_the_end, erpg
Online Players (1): BloodEko(BloodEko)
Offline Players: 0
Mode: offline

05:31:28 [INFO]  Starting InstantQueue 'EXCOMMAND_TeeStrangeFishing'... 
05:31:28 [INFO]  Queue 'EXCOMMAND_TeeStrangeFishing' Executing: ADJUST 
                   "<player>" "hide_entity:n@627" 
05:31:28 [INFO] +- Executing dCommand: ADJUST/p@BloodEko ---------+ 
05:31:28 [INFO]  Filled tag <player> with 
                   'p@ccea9a7f-f296-3762-8450-5f7f0d214912'. 
05:31:28 [INFO] +> Executing 'ADJUST': 
                   object='p@ccea9a7f-f296-3762-8450-5f7f0d214912'  
                   mechanism='hide_entity'  mechanism_value='n@627' 
05:31:28 [INFO]  Completing queue 'EXCOMMAND_TeeStrangeFishing' in 4ms. 
05:31:31 [INFO]  Running script event 'PlayerClosesInv', event='player closes 
                   inventory' for script 'SP_INVCLOSEHANDLER' 
05:31:31 [INFO]  Starting InstantQueue 
                   'SP_INVCLOSEHANDLER_BosniaIndicatorSeveral'... 
05:31:31 [INFO]  Queue 'SP_INVCLOSEHANDLER_BosniaIndicatorSeveral' Executing: 
                   CHOOSE "<context.inventory>" 
05:31:31 [INFO] +- Executing dCommand: CHOOSE/p@BloodEko ---------+ 
05:31:31 [INFO]  Filled tag <context.inventory> with 
                   'in@player[holder=p@ccea9a7f-f296-3762-8450-5f7f0d214912]'. 
05:31:31 [INFO] +> Executing 'CHOOSE': 
                   choice='in@player[holder=p@ccea9a7f-f296-3762-8450-5f7f0d214912]' 
05:31:31 [INFO]  No result! 
05:31:31 [INFO]  Completing queue 'SP_INVCLOSEHANDLER_BosniaIndicatorSeveral' 
                   in 2ms. 
05:31:31 [INFO]  Running script event 'PlayerClosesInv', event='player closes 
                   inventory' for script 'LC_CHESTHANDLER' 
05:31:31 [INFO]  Starting InstantQueue 'LC_CHESTHANDLER_SingleMxAudio'... 
05:31:31 [INFO]  Queue 'LC_CHESTHANDLER_SingleMxAudio' Executing: IF 
                   "<context.inventory>" "==" "in@pl_inv_small" "||" 
                   "<context.inventory>" "==" "in@pl_inv_big" "{" "-" "playsound" 
                   "<pl.location>" "sound:CHEST_CLOSE" "-" "yaml" 
                   "id:lt_<player>" "set" 
                   "inv.id.<player.flag[lc_lastchestid]>:!" "-" "yaml" 
                   "id:lt_<player>" "set" 
                   "inv.id.<player.flag[lc_lastchestid]>.items:|:<context.inventory.list_contents>" 
                   "}" 
05:31:31 [INFO] +- Executing dCommand: IF/p@BloodEko ---------+ 
05:31:31 [INFO] +> Executing 'IF': use_braces='true' 
05:31:31 [INFO]  Filled tag <context.inventory> with 
                   'in@player[holder=p@ccea9a7f-f296-3762-8450-5f7f0d214912]'. 
05:31:31 [INFO]  
                   Comparable='Element(in@player[holder=p@ccea9a7f-f296-3762-8450-5f7f0d214912])', 
                   Operator='EQUALS', ComparedTo='Element(in@pl_inv_small)' --> 
                   OUTCOME='false' 
05:31:31 [INFO]  Filled tag <context.inventory> with 
                   'in@player[holder=p@ccea9a7f-f296-3762-8450-5f7f0d214912]'. 
05:31:31 [INFO]  
                   Comparable='Element(in@player[holder=p@ccea9a7f-f296-3762-8450-5f7f0d214912])', 
                   Operator='EQUALS', ComparedTo='Element(in@pl_inv_big)' --> 
                   OUTCOME='false' 
05:31:31 [INFO]  Completing queue 'LC_CHESTHANDLER_SingleMxAudio' in 5ms. 
05:31:31 [INFO]  Running script event 'PlayerClosesInv', event='player closes 
                   inventory' for script 'ENV_PLAYER_CLOSES_INV' 
05:31:31 [INFO]  Starting InstantQueue 
                   'ENV_PLAYER_CLOSES_INV_SoilJunkComplicated'... 
05:31:31 [INFO]  Queue 'ENV_PLAYER_CLOSES_INV_SoilJunkComplicated' Executing: 
                   CHOOSE "<context.inventory>" 
05:31:31 [INFO] +- Executing dCommand: CHOOSE/p@BloodEko ---------+ 
05:31:31 [INFO]  Filled tag <context.inventory> with 
                   'in@player[holder=p@ccea9a7f-f296-3762-8450-5f7f0d214912]'. 
05:31:31 [INFO] +> Executing 'CHOOSE': 
                   choice='in@player[holder=p@ccea9a7f-f296-3762-8450-5f7f0d214912]' 
05:31:31 [INFO]  No result! 
05:31:31 [INFO]  Completing queue 'ENV_PLAYER_CLOSES_INV_SoilJunkComplicated' 
                   in 3ms. 
05:31:31 [INFO]  Running script event 'PlayerQuits', event='player quit' for 
                   script 'USE_LOGIN_LOGOUT_HANDLER' 
05:31:31 [INFO]  Starting InstantQueue 
                   'USE_LOGIN_LOGOUT_HANDLER_DrBioStudents'... 
05:31:31 [INFO]  Queue 'USE_LOGIN_LOGOUT_HANDLER_DrBioStudents' Executing: IF 
                   "!<player.has_flag[erpg_region]>" "{" "-" "queue" "clear" "}" 
05:31:31 [INFO] +- Executing dCommand: IF/p@BloodEko ---------+ 
05:31:31 [INFO] +> Executing 'IF': use_braces='true' 
05:31:31 [INFO]  Filled tag <player.has_flag[erpg_region]> with 'true'. 
05:31:31 [INFO]  Queue 'USE_LOGIN_LOGOUT_HANDLER_DrBioStudents' Executing: 
                   YAML "id:lt_<player>" "set" "inv.inv:!" 
05:31:31 [INFO] +- Executing dCommand: YAML/p@BloodEko ---------+ 
05:31:31 [INFO]  Filled tag <player> with 
                   'p@ccea9a7f-f296-3762-8450-5f7f0d214912'. 
05:31:31 [INFO] +> Executing 'YAML': 
                   id='lt_p@ccea9a7f-f296-3762-8450-5f7f0d214912'  action='SET'  
                   yaml_action='DELETE'  key='inv.inv'  value='false'  
                   fix_formatting='false' 
05:31:31 [INFO]  Queue 'USE_LOGIN_LOGOUT_HANDLER_DrBioStudents' Executing: 
                   YAML "id:lt_<player>" "set" 
                   "inv.inv:|:<player.inventory.list_contents>" 
05:31:31 [INFO] +- Executing dCommand: YAML/p@BloodEko ---------+ 
05:31:31 [INFO]  Filled tag <player> with 
                   'p@ccea9a7f-f296-3762-8450-5f7f0d214912'. 
05:31:31 [INFO]  Filled tag <player.inventory.list_contents> with 
                   'li@i@magenta_dye[display_name=LK &fs&fsmove-shift 10 RK 
                   move-shift 1]|i@lime_dye[display_name=LK &fs&fswalls 80 RK 
                   &fs&fsexpand 1]|i@pink_dye[display_name=LK &fs&fsexpand 50 u 
                   RK &fs&fscontract 1]|i@glowstone_dust[display_name=LK 
                   &fs&fspaste RK &fs&fscut]|i@sugar[display_name=RK 
                   &fsnull]|i@diamond_axe[display_name=LK &fs&fshpos1 RK 
                   &fs&fshpos2]|i@diamond_spade[display_name=LK &fs&fspos1 RK 
                   &fs&fspos2]|i@compass'. 
05:31:31 [INFO] +> Executing 'YAML': 
                   id='lt_p@ccea9a7f-f296-3762-8450-5f7f0d214912'  action='SET'  
                   yaml_action='SPLIT'  key='inv.inv'  
                   value='li@i@magenta_dye[display_name=LK &fs&fsmove-shift 10 RK 
                   move-shift 1]|i@lime_dye[display_name=LK &fs&fswalls 80 RK 
                   &fs&fsexpand 1]|i@pink_dye[display_name=LK &fs&fsexpand 50 u 
                   RK &fs&fscontract 1]|i@glowstone_dust[display_name=LK 
                   &fs&fspaste RK &fs&fscut]|i@sugar[display_name=RK 
                   &fsnull]|i@diamond_axe[display_name=LK &fs&fshpos1 RK 
                   &fs&fshpos2]|i@diamond_spade[display_name=... * snip! * 
05:31:31 [INFO]  Queue 'USE_LOGIN_LOGOUT_HANDLER_DrBioStudents' Executing: 
                   YAML "id:lt_<player>" "set" "tp.loc:<player.location>" 
05:31:31 [INFO] +- Executing dCommand: YAML/p@BloodEko ---------+ 
05:31:31 [INFO]  Filled tag <player> with 
                   'p@ccea9a7f-f296-3762-8450-5f7f0d214912'. 
05:31:31 [INFO]  Filled tag <player.location> with 
                   'l@13.115433776474019,100.0,477.33826905168087,16.499794,306.29932,erpg'. 
05:31:31 [INFO] +> Executing 'YAML': 
                   id='lt_p@ccea9a7f-f296-3762-8450-5f7f0d214912'  action='SET'  
                   yaml_action='SET_VALUE'  key='tp.loc'  
                   value='l@13.115433776474019,100.0,477.33826905168087,16.499794,306.29932,erpg' 
                    fix_formatting='false' 
05:31:31 [INFO]  Queue 'USE_LOGIN_LOGOUT_HANDLER_DrBioStudents' Executing: 
                   FLAG "player" "last_login:<server.current_time_millis>" 
05:31:31 [INFO] +- Executing dCommand: FLAG/p@BloodEko ---------+ 
05:31:31 [INFO]  Filled tag <server.current_time_millis> with '1481085091653'. 
05:31:31 [INFO] +> Executing 'FLAG': flag_name='LAST_LOGIN'  
                   Action/Value='SET_VALUE(1481085091653)'  
                   flag_target='p@BloodEko' 
05:31:31 [INFO]  Queue 'USE_LOGIN_LOGOUT_HANDLER_DrBioStudents' Executing: 
                   FOREACH "<pl.flag[quit_channel]||li@>" "{" "-" "inject" 
                   "locally" "<def[value]>" "}" 
05:31:31 [INFO] +- Executing dCommand: FOREACH/p@BloodEko ---------+ 
05:31:31 [INFO]  Filled tag <pl.flag[quit_channel]||li@> with 
                   'erpg_remove_bert'. 
05:31:31 [INFO] +> Executing 'FOREACH': list='li@erpg_remove_bert' 
05:31:31 [INFO]  Queue 'USE_LOGIN_LOGOUT_HANDLER_DrBioStudents' Executing: 
                   INJECT "locally" "<def[value]>" 
05:31:31 [INFO] +- Executing dCommand: INJECT/p@BloodEko ---------+ 
05:31:31 [INFO]  Filled tag <def[value]> with 'erpg_remove_bert'. 
05:31:31 [INFO] +> Executing 'INJECT': 
                   Container='USE_LOGIN_LOGOUT_HANDLER(WORLD)'  
                   path='erpg_remove_bert'  local='true' 
05:31:31 [INFO]  Queue 'USE_LOGIN_LOGOUT_HANDLER_DrBioStudents' Executing: 
                   FLAG "player" "quit_channel:<-:erpg_remove_bert" 
05:31:31 [INFO] +- Executing dCommand: FLAG/p@BloodEko ---------+ 
05:31:31 [INFO] +> Executing 'FLAG': flag_name='QUIT_CHANNEL'  
                   Action/Value='REMOVE(erpg_remove_bert)'  
                   flag_target='p@BloodEko' 
05:31:31 [INFO]  Queue 'USE_LOGIN_LOGOUT_HANDLER_DrBioStudents' Executing: 
                   FLAG "<pl.flag[start_find_bert].as_npc>" "following:!" 
05:31:31 [INFO] +- Executing dCommand: FLAG/p@BloodEko ---------+ 
05:31:31 [INFO]  ERROR! 'true' is an invalid dNPC! 
05:31:31 [INFO]  Unfilled attributes '[as_npc]' for tag 
                   <pl.flag[start_find_bert].as_npc>! 
05:31:31 [INFO]  Filled tag <pl.flag[start_find_bert].as_npc> with 'null'. 
05:31:31 [INFO]  ERROR in script 'USE_LOGIN_LOGOUT_HANDLER'! Tag 
                   <pl.flag[start_find_bert].as_npc> is invalid! 
05:31:31 [INFO] +> [Denizen] valueOf dEntity returning null: null 
05:31:31 [INFO]  ERROR in script 'USE_LOGIN_LOGOUT_HANDLER'! Woah! Invalid 
                   arguments were specified! 
05:31:31 [INFO] +> [Denizen] +> MESSAGE follows: 'Invalid Entity target.' 
05:31:31 [INFO] +> [Denizen] Usage: flag ({player}/npc/server/<entity>) 
                   [<name>([<#>])](:<action>)[:<value>] (duration:<value>) 
05:31:31 [INFO] +> [Denizen] (Attempted: FLAG 
                   "<pl.flag[start_find_bert].as_npc>" "following:!") 
05:31:31 [INFO] +---------------------+ 
05:31:31 [INFO]  Queue 'USE_LOGIN_LOGOUT_HANDLER_DrBioStudents' Executing: 
                   REMOVE "<pl.flag[start_find_bert].as_npc>" 
05:31:31 [INFO] +- Executing dCommand: REMOVE/p@BloodEko ---------+ 
05:31:31 [INFO]  ERROR! 'true' is an invalid dNPC! 
05:31:31 [INFO]  Unfilled attributes '[as_npc]' for tag 
                   <pl.flag[start_find_bert].as_npc>! 
05:31:31 [INFO]  Filled tag <pl.flag[start_find_bert].as_npc> with 'null'. 
05:31:31 [INFO]  ERROR in script 'USE_LOGIN_LOGOUT_HANDLER'! Tag 
                   <pl.flag[start_find_bert].as_npc> is invalid! 
05:31:31 [INFO]  ERROR! 'null' is an unknown argument! 
05:31:31 [INFO]  ERROR in script 'USE_LOGIN_LOGOUT_HANDLER'! Woah! Invalid 
                   arguments were specified! 
05:31:31 [INFO] +> [Denizen] +> MESSAGE follows: 'Must specify 
                   entity/entities!' 
05:31:31 [INFO] +> [Denizen] Usage: remove [<entity>|...] (<world>) 
05:31:31 [INFO] +> [Denizen] (Attempted: REMOVE 
                   "<pl.flag[start_find_bert].as_npc>") 
05:31:31 [INFO] +---------------------+ 
05:31:31 [INFO]  Queue 'USE_LOGIN_LOGOUT_HANDLER_DrBioStudents' Executing: 
                   FLAG "player" "start_find_bert:true" 
05:31:31 [INFO] +- Executing dCommand: FLAG/p@BloodEko ---------+ 
05:31:31 [INFO] +> Executing 'FLAG': flag_name='START_FIND_BERT'  
                   Action/Value='SET_VALUE(true)'  flag_target='p@BloodEko' 
05:31:31 [INFO]  Queue 'USE_LOGIN_LOGOUT_HANDLER_DrBioStudents' Executing: 
                   FOREACH " CALLBACK" 
05:31:31 [INFO]  Completing queue 'USE_LOGIN_LOGOUT_HANDLER_DrBioStudents' in 
                   56ms. 
05:31:34 [INFO]  Running script event 'PlayerJoins', event='player joins' for 
                   script 'USE_LOGIN_LOGOUT_HANDLER' 
05:31:34 [INFO]  Starting InstantQueue 
                   'USE_LOGIN_LOGOUT_HANDLER_ReasonablyRegionalForwarding'... 
05:31:34 [INFO]  Queue 'USE_LOGIN_LOGOUT_HANDLER_ReasonablyRegionalForwarding' 
                   Executing: IF "!<player.has_flag[erpg_region]>" "{" "-" 
                   "queue" "clear" "}" 
05:31:34 [INFO] +- Executing dCommand: IF/p@BloodEko ---------+ 
05:31:34 [INFO] +> Executing 'IF': use_braces='true' 
05:31:34 [INFO]  Filled tag <player.has_flag[erpg_region]> with 'true'. 
05:31:34 [INFO]  Queue 'USE_LOGIN_LOGOUT_HANDLER_ReasonablyRegionalForwarding' 
                   Executing: IF "!<yaml.list.contains[lt_<player>]>" "{" "-" 
                   "yaml" "load:/loot/playerdata/<player>.yml" "id:lt_<player>" 
                   "}" 
05:31:34 [INFO] +- Executing dCommand: IF/p@BloodEko ---------+ 
05:31:34 [INFO] +> Executing 'IF': use_braces='true' 
05:31:34 [INFO]  Filled tag <player> with 
                   'p@ccea9a7f-f296-3762-8450-5f7f0d214912'. 
05:31:34 [INFO]  Filled tag 
                   <yaml.list.contains[lt_p@ccea9a7f-f296-3762-8450-5f7f0d214912]> 
                   with 'true'. 
05:31:34 [INFO]  Queue 'USE_LOGIN_LOGOUT_HANDLER_ReasonablyRegionalForwarding' 
                   Executing: INVENTORY "clear" 
05:31:34 [INFO] +- Executing dCommand: INVENTORY/p@BloodEko ---------+ 
05:31:34 [INFO] +> Executing 'INVENTORY': actions='[clear]'  
                   Inventory='in@player[holder=p@ccea9a7f-f296-3762-8450-5f7f0d214912]' 
                    slot='1' 
05:31:34 [INFO]  Queue 'USE_LOGIN_LOGOUT_HANDLER_ReasonablyRegionalForwarding' 
                   Executing: INVENTORY "set" "d:<player.inventory>" 
                   "o:<yaml[lt_<player>].read[inv.inv]>" 
05:31:34 [INFO] +- Executing dCommand: INVENTORY/p@BloodEko ---------+ 
05:31:34 [INFO]  Filled tag <player.inventory> with 
                   'in@player[holder=p@ccea9a7f-f296-3762-8450-5f7f0d214912]'. 
05:31:34 [INFO]  Filled tag <player> with 
                   'p@ccea9a7f-f296-3762-8450-5f7f0d214912'. 
05:31:34 [INFO]  Filled tag 
                   <yaml[lt_p@ccea9a7f-f296-3762-8450-5f7f0d214912].read[inv.inv]> 
                   with 'li@i@magenta_dye[display_name=LK &fs&fsmove-shift 10 RK 
                   move-shift 1]|i@lime_dye[display_name=LK &fs&fswalls 80 RK 
                   &fs&fsexpand 1]|i@pink_dye[display_name=LK &fs&fsexpand 50 u 
                   RK &fs&fscontract 1]|i@glowstone_dust[display_name=LK 
                   &fs&fspaste RK &fs&fscut]|i@sugar[display_name=RK 
                   &fsnull]|i@diamond_axe[display_name=LK &fs&fshpos1 RK 
                   &fs&fshpos2]|i@diamond_spade[display_name=LK &fs&fspos1 RK 
                   &fs&fspos2]|i@compass'. 
05:31:34 [INFO] +> Executing 'INVENTORY': actions='[set]'  
                   Inventory='in@player[holder=p@ccea9a7f-f296-3762-8450-5f7f0d214912]' 
                    
                   Inventory='in@generic[size=54;contents=li@i@magenta_dye[display_name=LK 
                   &fs&fsmove-shift 10 RK move-shift 
                   1]|i@lime_dye[display_name=LK &fs&fswalls 80 RK &fs&fsexpand 
                   1]|i@pink_dye[display_name=LK &fs&fsexpand 50 u RK 
                   &fs&fscontract 1]|i@glowstone_dust[display_name=LK &fs&fspaste 
                   RK &fs&fscut]|i@sugar[display_name=RK 
                   &fsnull]|i@diamond_axe[display_name=LK &fs&fshpos1 RK 
                   &fs&fshpos2]|i@diamond_spad... * snip! * 
05:31:34 [INFO]  Queue 'USE_LOGIN_LOGOUT_HANDLER_ReasonablyRegionalForwarding' 
                   Executing: IF 
                   "!<server.flag[lt_savecycle].contains[<player>]||false>" "{" 
                   "-" "flag" "server" "lt_savecycle:->:<player>" "}" 
05:31:34 [INFO] +- Executing dCommand: IF/p@BloodEko ---------+ 
05:31:34 [INFO] +> Executing 'IF': use_braces='true' 
05:31:34 [INFO]  Filled tag <player> with 
                   'p@ccea9a7f-f296-3762-8450-5f7f0d214912'. 
05:31:34 [INFO]  Filled tag 
                   <server.flag[lt_savecycle].contains[p@ccea9a7f-f296-3762-8450-5f7f0d214912]||false> 
                   with 'true'. 
05:31:34 [INFO]  Queue 'USE_LOGIN_LOGOUT_HANDLER_ReasonablyRegionalForwarding' 
                   Executing: TELEPORT "<player>" 
                   "<yaml[lt_<player>].read[tp.loc]||<player.location>>" 
05:31:34 [INFO] +- Executing dCommand: TELEPORT/p@BloodEko ---------+ 
05:31:34 [INFO]  Filled tag <player> with 
                   'p@ccea9a7f-f296-3762-8450-5f7f0d214912'. 
05:31:34 [INFO]  Filled tag <player> with 
                   'p@ccea9a7f-f296-3762-8450-5f7f0d214912'. 
05:31:34 [INFO]  Filled tag 
                   <yaml[lt_p@ccea9a7f-f296-3762-8450-5f7f0d214912].read[tp.loc]||<player.location>> 
                   with 
                   'l@13.115433776474019,100.0,477.33826905168087,16.499794,306.29932,erpg'. 
05:31:34 [INFO] +> Executing 'TELEPORT': 
                   location='l@13.115433776474019,100.0,477.33826905168087,16.499794,306.29932,erpg' 
                    entities='[p@ccea9a7f-f296-3762-8450-5f7f0d214912]' 
05:31:34 [INFO]  Queue 'USE_LOGIN_LOGOUT_HANDLER_ReasonablyRegionalForwarding' 
                   Executing: FOREACH "<pl.flag[join_channel]||li@>" "{" "-" 
                   "inject" "locally" "<def[value]>" "}" 
05:31:34 [INFO] +- Executing dCommand: FOREACH/p@BloodEko ---------+ 
05:31:34 [INFO]  Filled tag <pl.flag[join_channel]||li@> with 'li@'. 
05:31:34 [INFO] +> Executing 'FOREACH': list='li@' 
05:31:34 [INFO]  Empty list, not looping... 
05:31:34 [INFO]  Completing queue 
                   'USE_LOGIN_LOGOUT_HANDLER_ReasonablyRegionalForwarding' in 
                   22ms. 
05:31:50 [INFO]  Starting InstantQueue 'EXCOMMAND_BeingMatchedCtrl'... 
05:31:50 [INFO]  Queue 'EXCOMMAND_BeingMatchedCtrl' Executing: ADJUST 
                   "<player>" "show_entity:n@627" 
05:31:50 [INFO] +- Executing dCommand: ADJUST/p@BloodEko ---------+ 
05:31:50 [INFO]  Filled tag <player> with 
                   'p@ccea9a7f-f296-3762-8450-5f7f0d214912'. 
05:31:50 [INFO] +> Executing 'ADJUST': 
                   object='p@ccea9a7f-f296-3762-8450-5f7f0d214912'  
                   mechanism='show_entity'  mechanism_value='n@627' 
05:31:50 [INFO]  Completing queue 'EXCOMMAND_BeingMatchedCtrl' in 2ms.