Paste #23526: Denizen Debug Logs From Dekara - A Vanilla Server

Date: 2015/12/06 16:23:52 UTC-08:00
Type: Server Log

View Raw Paste Download This Paste
Copy Link


Java Version: 1.7.0_72
Up-time: 7d 2h
CraftBukkit Version: git-Spigot-5f38d38-12698ea (MC: 1.8.8)
Denizen Version: Core: 1.10 (Build Unknown), CraftBukkit: 0.9.7-SNAPSHOT (build 419)
Active Plugins (12): Citizens: 2.0.16-SNAPSHOT (build 1267), EasyPM: 1.4, ColorName: 1.2.0, WorldEdit: 6.1;no_git_id, 
PermissionsEx: 1.23.3, Multiverse-Core: 2.4-b527, Denizen: 0.9.7-SNAPSHOT (build 419), 
Backpacks: 0.1.3, Multiverse-Portals: 2.4-b548, BedHome: 2.25, WorldGuard: 6.1, 
RealMail: 0.3.2
Loaded Worlds (4): Dekara, Dekara_nether, Dekara_the_end, Hell
Online Players (1): Berufeng(Berufeng)
Offline Players: 12
Mode: online

18:23:49 [INFO] +> Executing 'Event': Type='on player right clicks ITEM_FRAME 
                   in blacksmithshop'  Container='ENCHANTINGMACHINE(WORLD)'  
                   player=p@BerufengContext='{cuboids=li@cu@blacksmithshop, 
                   location=l@979.5,68.5,911.03125,Dekara, item=i@air, 
                   entity=e@f5c243d6-22e2-4474-8b77-87d9a9b31918, 
                   itemframe=i@iron_ingot}' 
18:23:49 [INFO] +- Building event 'ON PLAYER RIGHT CLICKS ITEM_FRAME IN 
                   BLACKSMITHSHOP' for ENCHANTINGMACHINE ---------+ 
18:23:49 [INFO]  Starting InstantQueue 
                   'ENCHANTINGMACHINE_OperateObserverLafayette'... 
18:23:49 [INFO]  Queue 'ENCHANTINGMACHINE_OperateObserverLafayette' Executing: 
                   DETERMINE "passively" "CANCELLED" 
18:23:49 [INFO] +- Executing dCommand: DETERMINE/p@Berufeng ---------+ 
18:23:49 [INFO] +> Executing 'DETERMINE': outcome='CANCELLED'  
                   passively='true' 
18:23:49 [INFO]  Queue 'ENCHANTINGMACHINE_OperateObserverLafayette' Executing: 
                   IF "<context.location.simple.is[==].to[979,68,911,Dekara]>" 
                   "{" "-" "if" "<server.flag[enchantingitem]>" ">=" "6" "{" "-" 
                   "flag" "server" "enchantingitem:1" "}" "else" "{" "-" "flag" 
                   "server" "enchantingitem:++" "}" "-" "inject" "locally" 
                   "NameFlags" "-" "inject" "locally" "SignRefresh" "}" 
18:23:49 [INFO] +- Executing dCommand: IF/p@Berufeng ---------+ 
18:23:49 [INFO] +> Executing 'IF': use_braces='true' 
18:23:49 [INFO]  Filled tag 
                   <context.location.simple.is[==].to[979,68,911,Dekara]> with 
                   'true'. 
18:23:49 [INFO]  Queue 'ENCHANTINGMACHINE_OperateObserverLafayette' Executing: 
                   IF "<server.flag[enchantingitem]>" ">=" "6" "{" "-" "flag" 
                   "server" "enchantingitem:1" "}" "else" "{" "-" "flag" "server" 
                   "enchantingitem:++" "}" 
18:23:49 [INFO] +- Executing dCommand: IF/p@Berufeng ---------+ 
18:23:49 [INFO] +> Executing 'IF': use_braces='true' 
18:23:49 [INFO]  Filled tag <server.flag[enchantingitem]> with '4.0'. 
18:23:49 [INFO]  Comparable='Decimal(4.0)', Operator='OR_MORE', 
                   ComparedTo='Decimal(6.0)' --> OUTCOME='false' 
18:23:49 [INFO]  Queue 'ENCHANTINGMACHINE_OperateObserverLafayette' Executing: 
                   FLAG "server" "enchantingitem:++" 
18:23:49 [INFO] +- Executing dCommand: FLAG/p@Berufeng ---------+ 
18:23:49 [INFO] +> Executing 'FLAG': flag_name='ENCHANTINGITEM'  
                   Action/Value='INCREASE(1)'  flag_target='server' 
18:23:49 [INFO] +> Executing 'Event': Type='on server flag changed'  
                   Container='BUILDAHORSE(WORLD)'  Context='{old_value=4.0, 
                   name=ENCHANTINGITEM, owner=SERVER, type=server}' 
18:23:49 [INFO] +- Building event 'ON SERVER FLAG CHANGED' for BUILDAHORSE 
                   ---------+ 
18:23:49 [INFO]  Starting InstantQueue 
                   'BUILDAHORSE_CorrectionHazardsLifestyle'... 
18:23:49 [INFO]  Queue 'BUILDAHORSE_CorrectionHazardsLifestyle' Executing: IF 
                   "<context.name.starts_with[buildahorse].not||false>" "queue" 
                   "clear" 
18:23:49 [INFO] +- Executing dCommand: IF ---------+ 
18:23:49 [INFO] +> Executing 'IF': use_braces='false' 
18:23:49 [INFO]  Filled tag <context.name.starts_with[buildahorse].not||false> 
                   with 'true'. 
18:23:49 [INFO]  Queue 'BUILDAHORSE_CorrectionHazardsLifestyle' Executing: 
                   QUEUE "clear" 
18:23:49 [INFO] +- Executing dCommand: QUEUE ---------+ 
18:23:49 [INFO] +> Executing 'QUEUE': 
                   queue='q@BUILDAHORSE_CorrectionHazardsLifestyle'  
                   Action='CLEAR' 
18:23:49 [INFO]  Completing queue 'BUILDAHORSE_CorrectionHazardsLifestyle' in 
                   1ms. 
18:23:49 [INFO]  Queue 'ENCHANTINGMACHINE_OperateObserverLafayette' Executing: 
                   INJECT "locally" "NameFlags" 
18:23:49 [INFO] +- Executing dCommand: INJECT/p@Berufeng ---------+ 
18:23:49 [INFO] +> Executing 'INJECT': Container='ENCHANTINGMACHINE(WORLD)'  
                   path='NameFlags'  local='true' 
18:23:49 [INFO]  Queue 'ENCHANTINGMACHINE_OperateObserverLafayette' Executing: 
                   CHOOSE "<server.flag[enchantingitem].as_int>" 
18:23:49 [INFO] +- Executing dCommand: CHOOSE/p@Berufeng ---------+ 
18:23:49 [INFO]  Filled tag <server.flag[enchantingitem].as_int> with '5'. 
18:23:49 [INFO] +> Executing 'CHOOSE': choice='5' 
18:23:49 [INFO]  Queue 'ENCHANTINGMACHINE_OperateObserverLafayette' Executing: 
                   FLAG "server" "enchantingitem_name:Leggings" 
18:23:49 [INFO] +- Executing dCommand: FLAG/p@Berufeng ---------+ 
18:23:49 [INFO] +> Executing 'FLAG': flag_name='ENCHANTINGITEM_NAME'  
                   Action/Value='SET_VALUE(Leggings)'  flag_target='server' 
18:23:49 [INFO] +> Executing 'Event': Type='on server flag changed'  
                   Container='BUILDAHORSE(WORLD)'  
                   Context='{old_value=Chestplate, name=ENCHANTINGITEM_NAME, 
                   owner=SERVER, type=server}' 
18:23:49 [INFO] +- Building event 'ON SERVER FLAG CHANGED' for BUILDAHORSE 
                   ---------+ 
18:23:49 [INFO]  Starting InstantQueue 'BUILDAHORSE_HhSecuredToe'... 
18:23:49 [INFO]  Queue 'BUILDAHORSE_HhSecuredToe' Executing: IF 
                   "<context.name.starts_with[buildahorse].not||false>" "queue" 
                   "clear" 
18:23:49 [INFO] +- Executing dCommand: IF ---------+ 
18:23:49 [INFO] +> Executing 'IF': use_braces='false' 
18:23:49 [INFO]  Filled tag <context.name.starts_with[buildahorse].not||false> 
                   with 'true'. 
18:23:49 [INFO]  Queue 'BUILDAHORSE_HhSecuredToe' Executing: QUEUE "clear" 
18:23:49 [INFO] +- Executing dCommand: QUEUE ---------+ 
18:23:49 [INFO] +> Executing 'QUEUE': queue='q@BUILDAHORSE_HhSecuredToe'  
                   Action='CLEAR' 
18:23:49 [INFO]  Completing queue 'BUILDAHORSE_HhSecuredToe' in 1ms. 
18:23:49 [INFO]  Queue 'ENCHANTINGMACHINE_OperateObserverLafayette' Executing: 
                   CHOOSE "<server.flag[enchantingmaterial].as_int>" 
18:23:49 [INFO] +- Executing dCommand: CHOOSE/p@Berufeng ---------+ 
18:23:49 [INFO]  Filled tag <server.flag[enchantingmaterial].as_int> with '4'. 
18:23:49 [INFO] +> Executing 'CHOOSE': choice='4' 
18:23:49 [INFO]  Queue 'ENCHANTINGMACHINE_OperateObserverLafayette' Executing: 
                   FLAG "server" "enchantingmaterial_name:Diamond" 
18:23:49 [INFO] +- Executing dCommand: FLAG/p@Berufeng ---------+ 
18:23:49 [INFO] +> Executing 'FLAG': flag_name='ENCHANTINGMATERIAL_NAME'  
                   Action/Value='SET_VALUE(Diamond)'  flag_target='server' 
18:23:49 [INFO] +> Executing 'Event': Type='on server flag changed'  
                   Container='BUILDAHORSE(WORLD)'  Context='{old_value=Diamond, 
                   name=ENCHANTINGMATERIAL_NAME, owner=SERVER, type=server}' 
18:23:49 [INFO] +- Building event 'ON SERVER FLAG CHANGED' for BUILDAHORSE 
                   ---------+ 
18:23:49 [INFO]  Starting InstantQueue 'BUILDAHORSE_FaxChoicesWn'... 
18:23:49 [INFO]  Queue 'BUILDAHORSE_FaxChoicesWn' Executing: IF 
                   "<context.name.starts_with[buildahorse].not||false>" "queue" 
                   "clear" 
18:23:49 [INFO] +- Executing dCommand: IF ---------+ 
18:23:49 [INFO] +> Executing 'IF': use_braces='false' 
18:23:49 [INFO]  Filled tag <context.name.starts_with[buildahorse].not||false> 
                   with 'true'. 
18:23:49 [INFO]  Queue 'BUILDAHORSE_FaxChoicesWn' Executing: QUEUE "clear" 
18:23:49 [INFO] +- Executing dCommand: QUEUE ---------+ 
18:23:49 [INFO] +> Executing 'QUEUE': queue='q@BUILDAHORSE_FaxChoicesWn'  
                   Action='CLEAR' 
18:23:49 [INFO]  Completing queue 'BUILDAHORSE_FaxChoicesWn' in 1ms. 
18:23:49 [INFO]  Queue 'ENCHANTINGMACHINE_OperateObserverLafayette' Executing: 
                   DEFINE "itemframeitem" "i@diamond_leggings" 
18:23:49 [INFO] +- Executing dCommand: DEFINE/p@Berufeng ---------+ 
18:23:49 [INFO] +> Executing 'DEFINE': 
                   queue='ENCHANTINGMACHINE_OperateObserverLafayette'  
                   definition='itemframeitem'  value='i@diamond_leggings' 
18:23:49 [INFO]  Queue 'ENCHANTINGMACHINE_OperateObserverLafayette' Executing: 
                   DEFINE "itemframematerial" "i@diamond" 
18:23:49 [INFO] +- Executing dCommand: DEFINE/p@Berufeng ---------+ 
18:23:49 [INFO] +> Executing 'DEFINE': 
                   queue='ENCHANTINGMACHINE_OperateObserverLafayette'  
                   definition='itemframematerial'  value='i@diamond' 
18:23:49 [INFO]  Queue 'ENCHANTINGMACHINE_OperateObserverLafayette' Executing: 
                   INJECT "locally" "SignRefresh" 
18:23:49 [INFO] +- Executing dCommand: INJECT/p@Berufeng ---------+ 
18:23:49 [INFO] +> Executing 'INJECT': Container='ENCHANTINGMACHINE(WORLD)'  
                   path='SignRefresh'  local='true' 
18:23:49 [INFO]  Queue 'ENCHANTINGMACHINE_OperateObserverLafayette' Executing: 
                   CHOOSE "<server.flag[enchantingitem].as_int>" 
18:23:49 [INFO] +- Executing dCommand: CHOOSE/p@Berufeng ---------+ 
18:23:49 [INFO]  Filled tag <server.flag[enchantingitem].as_int> with '5'. 
18:23:49 [INFO] +> Executing 'CHOOSE': choice='5' 
18:23:49 [INFO]  Queue 'ENCHANTINGMACHINE_OperateObserverLafayette' Executing: 
                   SIGN "wall_sign" 
                   "<&l>Material|<&b><server.flag[enchantingmaterial_name]>|<&sp>|(<server.flag[enchantingmaterial].as_int>/4)" 
                   "l@980,69,911,Dekara" "direction:s" 
18:23:49 [INFO] +- Executing dCommand: SIGN/p@Berufeng ---------+ 
18:23:49 [INFO]  Filled tag <&l> with ''. 
18:23:49 [INFO]  Filled tag <&b> with ''. 
18:23:49 [INFO]  Filled tag <server.flag[enchantingmaterial_name]> with 
                   'Diamond'. 
18:23:49 [INFO]  Filled tag <&sp> with ' '. 
18:23:49 [INFO]  Filled tag <server.flag[enchantingmaterial].as_int> with '4'. 
18:23:49 [INFO] +> Executing 'SIGN': type='wall_sign'  
                   location='l@980.0,69.0,911.0,Dekara'  
                   text='li@Material|Diamond| |(4/4)' 
18:23:49 [INFO]  Queue 'ENCHANTINGMACHINE_OperateObserverLafayette' Executing: 
                   SIGN "wall_sign" "<&l>Item 
                   Type|<&b><server.flag[enchantingitem_name]>|<&sp>|(<server.flag[enchantingitem].as_int>/6)" 
                   "l@979,69,911,Dekara" "direction:s" 
18:23:49 [INFO] +- Executing dCommand: SIGN/p@Berufeng ---------+ 
18:23:49 [INFO]  Filled tag <&l> with ''. 
18:23:49 [INFO]  Filled tag <&b> with ''. 
18:23:49 [INFO]  Filled tag <server.flag[enchantingitem_name]> with 
                   'Leggings'. 
18:23:49 [INFO]  Filled tag <&sp> with ' '. 
18:23:49 [INFO]  Filled tag <server.flag[enchantingitem].as_int> with '5'. 
18:23:49 [INFO] +> Executing 'SIGN': type='wall_sign'  
                   location='l@979.0,69.0,911.0,Dekara'  text='li@Item 
                   Type|Leggings| |(5/6)' 
18:23:49 [INFO]  Queue 'ENCHANTINGMACHINE_OperateObserverLafayette' Executing: 
                   ADJUST 
                   "<l@979,68,911,Dekara.find.entities[item_frame].within[0.5]>" 
                   "framed:<def[itemframeitem]>" 
18:23:49 [INFO] +- Executing dCommand: ADJUST/p@Berufeng ---------+ 
18:23:49 [INFO]  Filled tag 
                   <l@979,68,911,Dekara.find.entities[item_frame].within[0.5]> 
                   with 'li@'. 
18:23:49 [INFO]  Filled tag <def[itemframeitem]> with 'i@diamond_leggings'. 
18:23:49 [INFO] +> Executing 'ADJUST': object='li@'  mechanism='framed'  
                   mechanism_value='i@diamond_leggings' 
18:23:49 [INFO]  Queue 'ENCHANTINGMACHINE_OperateObserverLafayette' Executing: 
                   ADJUST 
                   "<l@980,68,911,Dekara.find.entities[item_frame].within[0.5]>" 
                   "framed:<def[itemframematerial]>" 
18:23:49 [INFO] +- Executing dCommand: ADJUST/p@Berufeng ---------+ 
18:23:49 [INFO]  Filled tag 
                   <l@980,68,911,Dekara.find.entities[item_frame].within[0.5]> 
                   with 'li@'. 
18:23:49 [INFO]  Filled tag <def[itemframematerial]> with 'i@diamond'. 
18:23:49 [INFO] +> Executing 'ADJUST': object='li@'  mechanism='framed'  
                   mechanism_value='i@diamond' 
18:23:49 [INFO]  Queue 'ENCHANTINGMACHINE_OperateObserverLafayette' Executing: 
                   IF "<context.location.simple.is[==].to[980,68,911,Dekara]>" 
                   "{" "-" "inject" "locally" "ItemMaterialTask" "-" "inject" 
                   "locally" "NameFlags" "-" "inject" "locally" "SignRefresh" "}" 
18:23:49 [INFO] +- Executing dCommand: IF/p@Berufeng ---------+ 
18:23:49 [INFO] +> Executing 'IF': use_braces='true' 
18:23:49 [INFO]  Filled tag 
                   <context.location.simple.is[==].to[980,68,911,Dekara]> with 
                   'false'. 
18:23:49 [INFO]  Completing queue 'ENCHANTINGMACHINE_OperateObserverLafayette' 
                   in 25ms.