Paste #29576: Denizen Debug Logs From Heroes Testing Server

Date: 2016/02/03 02:28:58 UTC-08:00
Type: Server Log

View Raw Paste Download This Paste
Copy Link


Java Version: 1.7.0_71
Up-time: 2d 8h
CraftBukkit Version: git-Spigot-fdc1440-53fac9f (MC: 1.8.8)
Denizen Version: Core: 1.10 (Build Unknown), CraftBukkit: 0.9.7-SNAPSHOT (build 456)
Active Plugins (45): WorldBorder: 1.8.1, HideStream: 3.7, AsyncWorldEditInjector: 2.1.3, WorldEdit: 6.1;no_git_id, 
VoxelSniper: 5.170.0-SNAPSHOT-jnks317-gitfcb8fe1, Buycraft: 6.8, Vault: 1.5.6-b49, 
PermissionsEx: 1.22.7-SNAPSHOT, SimpleHelpTickets: 1.3.5, Multiverse-Core: 2.5-b699, 
LogBlock: 1.94, Questioner: 0.6, dsTitle: 1.4.0, WorldGuard: 6.0.0-SNAPSHOT.1507-, 
SimpleWarnings: 1.0, PhatLoots: 4.1.0, Event: 1.0, DisconnectFix: 1.0, iConomy: 7.0, 
ClientPermissions: 1.0.0, SimpleAutoMessage: 1.2.3, TitleOnJoin: 1.0, Modifyworld: 1.19.7, 
ProtocolLib: 3.6.3-SNAPSHOT-b129, HolographicDisplays: 2.1.10, Heroes: 1.5.5.6-SNAPSHOT-b78, 
Essentials: TeamCity, Citizens: 2.0.16-SNAPSHOT (build 1247), QuickShop: 0.0.4, 
AsyncWorldEdit: 2.1.5, Towny: 0.89.2.0, LibsDisguises: 8.6.2, EssentialsSpawn: TeamCity, 
Multiverse-Portals: 2.5-b725, AntiCombatLog: 0.1, EchoPet: 2.8.0-b52, Denizen: 0.9.7-SNAPSHOT (build 456), 
OfflinePlayer: 2.0, MythicMobs: 2.1.9, CraftBook: 3.9-SNAPSHOT, HeroesAddon: 2.0, 
EssentialsChat: 2.13.1, AtherysExtra: 1.0, TownyChat: 0.42, BetonQuest: 1.8-dev,
Loaded Worlds (4): world, world_nether, world_the_end, PVE
Online Players (2): Barnie_(Barnie_), Rascall_(Rascall_)
Offline Players: 1044
Mode: online

03:28:49 [INFO] +> Executing 'Event': Type='on player right clicks with 
                   nether_star'  Container='RUNECLICK(WORLD)'  
                   player=p@Barnie_Context='{item=i@RUNEITEM[display_name=&ss3Transmutable 
                   Rune;lore=&ss4 Click once only&dot You have been 
                   warned;quantity=31], click_type=RIGHT_CLICK_AIR}' 
03:28:49 [INFO] +- Building event 'ON PLAYER RIGHT CLICKS WITH NETHER_STAR' 
                   for RUNECLICK ---------+ 
03:28:49 [INFO]  Starting InstantQueue 'RUNECLICK_SkipAboutIndexed'... 
03:28:49 [INFO]  Queue 'RUNECLICK_SkipAboutIndexed' Executing: IF 
                   "<context.item.display_name.contains_any_text[transmutable|rune]>" 
                   "{" "-" "determine" "passively" "cancelled" "-" "inventory" 
                   "open" "d:in@LootCrate_Inventory" "-" "take" "<context.item>" 
                   "qty:1" "}" 
03:28:49 [INFO] +- Executing dCommand: IF/p@Barnie_ ---------+ 
03:28:49 [INFO] +> Executing 'IF': use_braces='true' 
03:28:49 [INFO]  Filled tag 
                   <context.item.display_name.contains_any_text[transmutable|rune]> 
                   with 'true'. 
03:28:49 [INFO]  Queue 'RUNECLICK_SkipAboutIndexed' Executing: DETERMINE 
                   "passively" "cancelled" 
03:28:49 [INFO] +- Executing dCommand: DETERMINE/p@Barnie_ ---------+ 
03:28:49 [INFO] +> Executing 'DETERMINE': outcome='cancelled'  
                   passively='true' 
03:28:49 [INFO]  Queue 'RUNECLICK_SkipAboutIndexed' Executing: INVENTORY 
                   "open" "d:in@LootCrate_Inventory" 
03:28:49 [INFO] +- Executing dCommand: INVENTORY/p@Barnie_ ---------+ 
03:28:49 [INFO]  Filled tag <&3> with ''. 
03:28:49 [INFO]  Filled tag <&3> with ''. 
03:28:49 [INFO]  Filled tag <&3> with ''. 
03:28:49 [INFO]  Filled tag <&3> with ''. 
03:28:49 [INFO]  Filled tag <&3> with ''. 
03:28:49 [INFO]  Filled tag <&3> with ''. 
03:28:49 [INFO] +> Executing 'INVENTORY': actions='[open]'  
                   destination='in@LOOTCRATE_INVENTORY'  slot='1' 
03:28:49 [INFO]  Queue 'RUNECLICK_SkipAboutIndexed' Executing: TAKE 
                   "<context.item>" "qty:1" 
03:28:49 [INFO] +- Executing dCommand: TAKE/p@Barnie_ ---------+ 
03:28:49 [INFO]  Filled tag <context.item> with 
                   'i@RUNEITEM[display_name=&ss3Transmutable Rune;lore=&ss4 Click 
                   once only&dot You have been warned;quantity=31]'. 
03:28:49 [INFO]  Filled tag <&3> with ''. 
03:28:49 [INFO]  Filled tag <&4> with ''. 
03:28:49 [INFO] +> Executing 'TAKE': Type='ITEM'  qty='1'  
                   inventory='in@player[holder=p@8787200e-a2cb-4def-9ffb-5ec44a9b709f]' 
                    Items='[i@RUNEITEM[display_name=&ss3Transmutable 
                   Rune;lore=&ss4 Click once only&dot You have been 
                   warned;quantity=31]]' 
03:28:49 [INFO]  Filled tag <&3> with ''. 
03:28:49 [INFO]  Filled tag <&4> with ''. 
03:28:49 [INFO]  Completing queue 'RUNECLICK_SkipAboutIndexed' in 10ms. 
03:28:51 [INFO]  Starting InstantQueue 
                   'LOOTRANDOMUNIQUEBLOCK_DigestAttendingZip'... 
03:28:51 [INFO]  Queue 'LOOTRANDOMUNIQUEBLOCK_DigestAttendingZip' Executing: 
                   DEFINE "bKey" 
                   "<yaml[LootBlocks].list_keys[Unique].random||null>" 
03:28:51 [INFO] +- Executing dCommand: DEFINE/p@Barnie_ ---------+ 
03:28:51 [INFO]  Filled tag <yaml[LootBlocks].list_keys[Unique].random||null> 
                   with 'HorseSpawnEggs'. 
03:28:51 [INFO] +> Executing 'DEFINE': 
                   queue='LOOTRANDOMUNIQUEBLOCK_DigestAttendingZip'  
                   definition='bkey'  value='HorseSpawnEggs' 
03:28:51 [INFO]  Queue 'LOOTRANDOMUNIQUEBLOCK_DigestAttendingZip' Executing: 
                   IF "<def[bKey]>" "==" "null" "{" "-" "queue" "clear" "}" 
03:28:51 [INFO] +- Executing dCommand: IF/p@Barnie_ ---------+ 
03:28:51 [INFO] +> Executing 'IF': use_braces='true' 
03:28:51 [INFO]  Filled tag <def[bKey]> with 'HorseSpawnEggs'. 
03:28:51 [INFO]  Comparable='Element(HorseSpawnEggs)', Operator='EQUALS', 
                   ComparedTo='Element(null)' --> OUTCOME='false' 
03:28:51 [INFO]  Queue 'LOOTRANDOMUNIQUEBLOCK_DigestAttendingZip' Executing: 
                   DEFINE "item" 
                   "<yaml[LootBlocks].read[Unique.<def[bKey]>.item].as_item>" 
03:28:51 [INFO] +- Executing dCommand: DEFINE/p@Barnie_ ---------+ 
03:28:51 [INFO]  Filled tag <def[bKey]> with 'HorseSpawnEggs'. 
03:28:51 [INFO] +> [dItem] Does not match a valid item ID or material: 
                   horseegg 
03:28:51 [INFO] +> [dItem] valueOf dItem returning null: horseegg 
03:28:51 [INFO]  ERROR! 'horseegg' is an invalid dItem! 
03:28:51 [INFO]  Unfilled attributes '[as_item]' for tag 
                   <yaml[LootBlocks].read[Unique.<def[bKey]>.item].as_item>! 
03:28:51 [INFO]  Filled tag 
                   <yaml[LootBlocks].read[Unique.HorseSpawnEggs.item].as_item> 
                   with 'null'. 
03:28:51 [INFO]  ERROR in script 'LOOTRANDOMUNIQUEBLOCK'! Tag 
                   <yaml[LootBlocks].read[Unique.HorseSpawnEggs.item].as_item> is 
                   invalid! 
03:28:51 [INFO] +> Executing 'DEFINE': 
                   queue='LOOTRANDOMUNIQUEBLOCK_DigestAttendingZip'  
                   definition='item'  value='null' 
03:28:51 [INFO]  Queue 'LOOTRANDOMUNIQUEBLOCK_DigestAttendingZip' Executing: 
                   DEFINE "qty" 
                   "<yaml[LootBlocks].read[Unique.<def[bKey]>.quantity]>" 
03:28:51 [INFO] +- Executing dCommand: DEFINE/p@Barnie_ ---------+ 
03:28:51 [INFO]  Filled tag <def[bKey]> with 'HorseSpawnEggs'. 
03:28:51 [INFO]  Filled tag 
                   <yaml[LootBlocks].read[Unique.HorseSpawnEggs.quantity]> with 
                   '13'. 
03:28:51 [INFO] +> Executing 'DEFINE': 
                   queue='LOOTRANDOMUNIQUEBLOCK_DigestAttendingZip'  
                   definition='qty'  value='13' 
03:28:51 [INFO]  Queue 'LOOTRANDOMUNIQUEBLOCK_DigestAttendingZip' Executing: 
                   GIVE "<def[item]>" "quantity:<def[qty]>" 
03:28:51 [INFO] +- Executing dCommand: GIVE/p@Barnie_ ---------+ 
03:28:51 [INFO]  Filled tag <def[item]> with 'null'. 
03:28:51 [INFO]  Filled tag <def[qty]> with '13'. 
03:28:51 [INFO] +> Executing 'GIVE': Type='ITEM'  
                   inventory='in@player[holder=p@8787200e-a2cb-4def-9ffb-5ec44a9b709f]' 
                    Quantity='13.0'  engrave='false'  unlimit_stack_size='false'  
                   Items='[]'  slot='1' 
03:28:51 [INFO]  Queue 'LOOTRANDOMUNIQUEBLOCK_DigestAttendingZip' Executing: 
                   ADJUST "<def[item]>" "quantity:<def[qty]>" "save:item" 
03:28:51 [INFO] +- Executing dCommand: ADJUST/p@Barnie_ ---------+ 
03:28:51 [INFO]  ...remembering this script entry as 'item'! 
03:28:51 [INFO]  Filled tag <def[item]> with 'null'. 
03:28:51 [INFO]  Filled tag <def[qty]> with '13'. 
03:28:51 [INFO] +> Executing 'ADJUST': object='null'  mechanism='quantity'  
                   mechanism_value='13' 
03:28:51 [INFO]  ERROR! Unfetchable object found 'null'! 
03:28:51 [INFO]  Queue 'LOOTRANDOMUNIQUEBLOCK_DigestAttendingZip' Executing: 
                   FIREWORK "<player.location>" "power:1" "type:star" 
                   "primary:RED|BLUE" "fade:WHITE|PURPLE" "flicker" "trail" 
03:28:51 [INFO] +- Executing dCommand: FIREWORK/p@Barnie_ ---------+ 
03:28:51 [INFO]  Filled tag <player.location> with 
                   'l@765.2912986435567,88.0,-701.7156147602417,-4.049993,86.788086,world'. 
03:28:51 [INFO] +> Executing 'FIREWORK': 
                   location='l@765.2912986435567,88.0,-701.7156147602417,-4.049993,86.788086,world' 
                    type='star'  power='1'  flicker='true'  trail='true'  primary 
                   colors='[co@RED, co@BLUE]'  fade colors='[co@WHITE, 
                   co@PURPLE]' 
03:28:51 [INFO]  Queue 'LOOTRANDOMUNIQUEBLOCK_DigestAttendingZip' Executing: 
                   PLAYEFFECT "ZOMBIE_DESTROY_DOOR" "<player.location>" 
03:28:51 [INFO] +- Executing dCommand: PLAYEFFECT/p@Barnie_ ---------+ 
03:28:51 [INFO]  Filled tag <player.location> with 
                   'l@765.2912986435567,88.0,-701.7156147602417,-4.049993,86.788086,world'. 
03:28:51 [INFO] +> Executing 'PLAYEFFECT': effect='ZOMBIE_DESTROY_DOOR'  
                   locations='[l@765.2912986435567,88.0,-701.7156147602417,-4.049993,86.788086,world]' 
                    radius='15'  data='0'  qty='1'  offset='l@0.5,0.5,0.5' 
03:28:51 [INFO]  Queue 'LOOTRANDOMUNIQUEBLOCK_DigestAttendingZip' Executing: 
                   IF "<def[qty]>" "==" "1" "{" "-" "actionbar" " <&3> You 
                   successfully transmutated the rune and gained 
                   <entry[item].result.formatted>! " "}" "else" "{" "-" 
                   "actionbar" " <&3> You successfully transmutated the rune and 
                   gained <def[qty]> <entry[item].result.formatted>! " "}" 
03:28:51 [INFO] +- Executing dCommand: IF/p@Barnie_ ---------+ 
03:28:51 [INFO] +> Executing 'IF': use_braces='true' 
03:28:51 [INFO]  Filled tag <def[qty]> with '13'. 
03:28:51 [INFO]  Comparable='Decimal(13.0)', Operator='EQUALS', 
                   ComparedTo='Decimal(1.0)' --> OUTCOME='false' 
03:28:51 [INFO]  Queue 'LOOTRANDOMUNIQUEBLOCK_DigestAttendingZip' Executing: 
                   ACTIONBAR " <&3> You successfully transmutated the rune and 
                   gained <def[qty]> <entry[item].result.formatted>! " 
03:28:51 [INFO] +- Executing dCommand: ACTIONBAR/p@Barnie_ ---------+ 
03:28:51 [INFO]  Filled tag <&3> with ''. 
03:28:51 [INFO]  Filled tag <def[qty]> with '13'. 
03:28:51 [INFO]  Missing saved entry object 'result' 
03:28:51 [INFO]  Filled tag <entry[item].result.formatted> with 
                   'entry[item].result.formatted'. 
03:28:51 [INFO]  ERROR in script 'LOOTRANDOMUNIQUEBLOCK'! Tag 
                   <entry[item].result.formatted> is invalid! 
03:28:51 [INFO] +> Executing 'ACTIONBAR': text='  You successfully 
                   transmutated the rune and gained 13 
                   entry[item].result.formatted! '  Targets='[p@Barnie_]' 
03:28:51 [INFO]  Completing queue 'LOOTRANDOMUNIQUEBLOCK_DigestAttendingZip' 
                   in 12ms.