Paste #17817: Denizen Debug Logs From A Test Server

Date: 2015/07/12 10:40:55 UTC-07:00
Type: Server Log

View Raw Paste Download This Paste
Copy Link


Java Version: 1.8.0_45
Up-time: 1h 41m
CraftBukkit Version: git-Spigot-3ccbe77-a6a57a9 (MC: 1.8.7)
Denizen Version: Core: 1.10 (Build Unknown), CraftBukkit: 0.9.7-SNAPSHOT (build 287)
Active Plugins (8): AsyncWorldEditInjector: 2.1.3, Citizens: 2.0.16-SNAPSHOT (build 1240), WorldEdit: 6.0.2-SNAPSHOT;3370-58aac973, 
AsyncWorldEdit: 2.1.5, Denizen: 0.9.7-SNAPSHOT (build 287), WorldGuard: 6.0.0-SNAPSHOT.1592-, 
Webizen: 0.2.0, Depenizen: 0.2.1 (build 250)
Loaded Worlds (5): world, world_nether, world_the_end, guildworld, dungeonworld
Online Players (1): TheBlackCoyote(TheBlackCoyote)
Offline Players: 35
Mode: online

11:40:50 [INFO]  Queue 'METEOR_RANDOM_DgWsHungary' Executing: PLAYEFFECT 
                   "effect:enchantment_table" "qty:10" "%location%" 
11:40:50 [INFO] +- Executing dCommand: PLAYEFFECT/p@TheBlackCoyote ---------+ 
11:40:50 [INFO]  Filled definition %location% with 'l@579.5,65.0,119.5,world'. 
11:40:50 [INFO] +> Executing 'PLAYEFFECT': special effect='ENCHANTMENT_TABLE'  
                   locations='[l@579.5,65.0,119.5,world]'  radius='15'  data='0'  
                   qty='10'  offset='0.5'  offset='0.5' 
11:40:50 [INFO]  Queue 'METEOR_RANDOM_DgWsHungary' Executing: WHILE 
                   " CALLBACK" 
11:40:50 [INFO]  Filled tag <def[location].as_location.simple> with 
                   '579,65,119,world'. 
11:40:50 [INFO]  Filled tag <server.has_flag[579,65,119,world_is_adamant]> 
                   with 'true'. 
11:40:50 [INFO] +- While loop 69 ---------+ 
11:40:50 [INFO]  Queue 'METEOR_RANDOM_DgWsHungary' Executing: WAIT "10t" 
11:40:50 [INFO] +- Executing dCommand: WAIT/p@TheBlackCoyote ---------+ 
11:40:50 [INFO] +> Executing 'WAIT': queue='METEOR_RANDOM_DgWsHungary'  
                   delay='d@10t' 
11:40:50 [INFO]  Queue 'METEOR_RANDOM_PresentationsRomeFriendship' Executing: 
                   PLAYEFFECT "effect:enchantment_table" "qty:10" "%location%" 
11:40:50 [INFO] +- Executing dCommand: PLAYEFFECT/p@TheBlackCoyote ---------+ 
11:40:50 [INFO]  Filled definition %location% with 'l@612.5,70.0,-24.5,world'. 
11:40:50 [INFO] +> Executing 'PLAYEFFECT': special effect='ENCHANTMENT_TABLE'  
                   locations='[l@612.5,70.0,-24.5,world]'  radius='15'  data='0'  
                   qty='10'  offset='0.5'  offset='0.5' 
11:40:50 [INFO]  Queue 'METEOR_RANDOM_PresentationsRomeFriendship' Executing: 
                   WHILE " CALLBACK" 
11:40:50 [INFO]  Filled tag <def[location].as_location.simple> with 
                   '612,70,-25,world'. 
11:40:50 [INFO]  Filled tag <server.has_flag[612,70,-25,world_is_adamant]> 
                   with 'true'. 
11:40:50 [INFO] +- While loop 16 ---------+ 
11:40:50 [INFO]  Queue 'METEOR_RANDOM_PresentationsRomeFriendship' Executing: 
                   WAIT "10t" 
11:40:50 [INFO] +- Executing dCommand: WAIT/p@TheBlackCoyote ---------+ 
11:40:50 [INFO] +> Executing 'WAIT': 
                   queue='METEOR_RANDOM_PresentationsRomeFriendship'  
                   delay='d@10t' 
11:40:50 [INFO]  Queue 'METEOR_RANDOM_DgWsHungary' Executing: PLAYEFFECT 
                   "effect:enchantment_table" "qty:10" "%location%" 
11:40:50 [INFO] +- Executing dCommand: PLAYEFFECT/p@TheBlackCoyote ---------+ 
11:40:50 [INFO]  Filled definition %location% with 'l@579.5,65.0,119.5,world'. 
11:40:50 [INFO] +> Executing 'PLAYEFFECT': special effect='ENCHANTMENT_TABLE'  
                   locations='[l@579.5,65.0,119.5,world]'  radius='15'  data='0'  
                   qty='10'  offset='0.5'  offset='0.5' 
11:40:50 [INFO]  Queue 'METEOR_RANDOM_DgWsHungary' Executing: WHILE 
                   " CALLBACK" 
11:40:50 [INFO]  Filled tag <def[location].as_location.simple> with 
                   '579,65,119,world'. 
11:40:50 [INFO]  Filled tag <server.has_flag[579,65,119,world_is_adamant]> 
                   with 'true'. 
11:40:50 [INFO] +- While loop 70 ---------+ 
11:40:50 [INFO]  Queue 'METEOR_RANDOM_DgWsHungary' Executing: WAIT "10t" 
11:40:50 [INFO] +- Executing dCommand: WAIT/p@TheBlackCoyote ---------+ 
11:40:50 [INFO] +> Executing 'WAIT': queue='METEOR_RANDOM_DgWsHungary'  
                   delay='d@10t' 
11:40:50 [INFO]  Queue 'METEOR_RANDOM_PresentationsRomeFriendship' Executing: 
                   PLAYEFFECT "effect:enchantment_table" "qty:10" "%location%" 
11:40:50 [INFO] +- Executing dCommand: PLAYEFFECT/p@TheBlackCoyote ---------+ 
11:40:50 [INFO]  Filled definition %location% with 'l@612.5,70.0,-24.5,world'. 
11:40:50 [INFO] +> Executing 'PLAYEFFECT': special effect='ENCHANTMENT_TABLE'  
                   locations='[l@612.5,70.0,-24.5,world]'  radius='15'  data='0'  
                   qty='10'  offset='0.5'  offset='0.5' 
11:40:50 [INFO]  Queue 'METEOR_RANDOM_PresentationsRomeFriendship' Executing: 
                   WHILE " CALLBACK" 
11:40:50 [INFO]  Filled tag <def[location].as_location.simple> with 
                   '612,70,-25,world'. 
11:40:50 [INFO]  Filled tag <server.has_flag[612,70,-25,world_is_adamant]> 
                   with 'true'. 
11:40:50 [INFO] +- While loop 17 ---------+ 
11:40:50 [INFO]  Queue 'METEOR_RANDOM_PresentationsRomeFriendship' Executing: 
                   WAIT "10t" 
11:40:50 [INFO] +- Executing dCommand: WAIT/p@TheBlackCoyote ---------+ 
11:40:50 [INFO] +> Executing 'WAIT': 
                   queue='METEOR_RANDOM_PresentationsRomeFriendship'  
                   delay='d@10t' 
11:40:51 [INFO]  Queue 'METEOR_RANDOM_DgWsHungary' Executing: PLAYEFFECT 
                   "effect:enchantment_table" "qty:10" "%location%" 
11:40:51 [INFO] +- Executing dCommand: PLAYEFFECT/p@TheBlackCoyote ---------+ 
11:40:51 [INFO]  Filled definition %location% with 'l@579.5,65.0,119.5,world'. 
11:40:51 [INFO] +> Executing 'PLAYEFFECT': special effect='ENCHANTMENT_TABLE'  
                   locations='[l@579.5,65.0,119.5,world]'  radius='15'  data='0'  
                   qty='10'  offset='0.5'  offset='0.5' 
11:40:51 [INFO]  Queue 'METEOR_RANDOM_DgWsHungary' Executing: WHILE 
                   " CALLBACK" 
11:40:51 [INFO]  Filled tag <def[location].as_location.simple> with 
                   '579,65,119,world'. 
11:40:51 [INFO]  Filled tag <server.has_flag[579,65,119,world_is_adamant]> 
                   with 'true'. 
11:40:51 [INFO] +- While loop 71 ---------+ 
11:40:51 [INFO]  Queue 'METEOR_RANDOM_DgWsHungary' Executing: WAIT "10t" 
11:40:51 [INFO] +- Executing dCommand: WAIT/p@TheBlackCoyote ---------+ 
11:40:51 [INFO] +> Executing 'WAIT': queue='METEOR_RANDOM_DgWsHungary'  
                   delay='d@10t' 
11:40:51 [INFO]  Running script event 'PlayerBreaksBlock', event='PLAYER 
                   BREAKS EMERALD_ORE' for script 'ADAMANT_BLOCK' 
11:40:51 [INFO]  Context 'cuboids' = 'li@' 
11:40:51 [INFO]  Context 'material' = 'm@emerald_ore' 
11:40:51 [INFO]  Context 'xp' = '0' 
11:40:51 [INFO]  Context 'cancelled' = 'false' 
11:40:51 [INFO]  Context 'location' = 'l@612.0,70.0,-25.0,world' 
11:40:51 [INFO]  Starting InstantQueue 
                   'ADAMANT_BLOCK_ThomsonGrowingDenizen'... 
11:40:51 [INFO]  Queue 'ADAMANT_BLOCK_ThomsonGrowingDenizen' Executing: IF 
                   "<server.has_flag[<context.location.simple>_is_adamant]>" "{" 
                   "-" "flag" "server" "<context.location.simple>_is_adamant:!" 
                   "-" "if" "<player.item_in_hand.simple>" "==" 
                   "i@diamond_pickaxe" "{" "-" "determine" "li@i@adamant" "}" "}" 
11:40:51 [INFO] +- Executing dCommand: IF/p@TheBlackCoyote ---------+ 
11:40:51 [INFO] +> Executing 'IF': use_braces='true' 
11:40:51 [INFO]  Filled tag <context.location.simple> with '612,70,-25,world'. 
11:40:51 [INFO]  Filled tag <server.has_flag[612,70,-25,world_is_adamant]> 
                   with 'true'. 
11:40:51 [INFO]  Queue 'ADAMANT_BLOCK_ThomsonGrowingDenizen' Executing: FLAG 
                   "server" "<context.location.simple>_is_adamant:!" 
11:40:51 [INFO] +- Executing dCommand: FLAG/p@TheBlackCoyote ---------+ 
11:40:51 [INFO]  Filled tag <context.location.simple> with '612,70,-25,world'. 
11:40:51 [INFO] +> Executing 'FLAG': flag_name='612,70,-25,WORLD_IS_ADAMANT'  
                   Action/Value='DELETE(false)'  flag_target='server' 
11:40:51 [INFO]  Queue 'ADAMANT_BLOCK_ThomsonGrowingDenizen' Executing: IF 
                   "<player.item_in_hand.simple>" "==" "i@diamond_pickaxe" "{" 
                   "-" "determine" "li@i@adamant" "}" 
11:40:51 [INFO] +- Executing dCommand: IF/p@TheBlackCoyote ---------+ 
11:40:51 [INFO] +> Executing 'IF': use_braces='true' 
11:40:51 [INFO]  Filled tag <player.item_in_hand.simple> with 
                   'i@diamond_pickaxe'. 
11:40:51 [INFO]  Comparable='Element(i@diamond_pickaxe)', Operator='EQUALS', 
                   ComparedTo='Element(i@diamond_pickaxe)' --> OUTCOME='true' 
11:40:51 [INFO]  Queue 'ADAMANT_BLOCK_ThomsonGrowingDenizen' Executing: 
                   DETERMINE "li@i@adamant" 
11:40:51 [INFO] +- Executing dCommand: DETERMINE/p@TheBlackCoyote ---------+ 
11:40:51 [INFO] +> Executing 'DETERMINE': outcome='li@i@adamant'  
                   passively='false' 
11:40:51 [INFO]  Completing queue 'ADAMANT_BLOCK_ThomsonGrowingDenizen' in 
                   2ms. 
11:40:51 [INFO]  Filled tag <&b> with ''. 
11:40:51 [INFO]  ERROR! Woah! An exception has been called with this item 
                   script! 
11:40:51 [INFO]  ERROR! Internal exception was thrown! 
11:40:51 [SEVERE] java.lang.NullPointerException
11:40:51 [SEVERE] net.aufdemrand.denizen.scripts.containers.core.ItemScriptContainer.getItemFrom(ItemScriptContainer.java:216)
11:40:51 [SEVERE] net.aufdemrand.denizen.objects.dItem.valueOf(dItem.java:118)
11:40:51 [SEVERE] net.aufdemrand.denizen.objects.dItem.valueOf(dItem.java:63)
11:40:51 [SEVERE] sun.reflect.GeneratedMethodAccessor36.invoke(Unknown Source)
11:40:51 [SEVERE] sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
11:40:51 [SEVERE] java.lang.reflect.Method.invoke(Unknown Source)
11:40:51 [SEVERE] net.aufdemrand.denizencore.objects.ObjectFetcher.getObjectFrom(ObjectFetcher.java:149)
11:40:51 [SEVERE] net.aufdemrand.denizencore.objects.dList.filter(dList.java:223)
11:40:51 [SEVERE] net.aufdemrand.denizencore.objects.dList.filter(dList.java:211)
11:40:51 [SEVERE] net.aufdemrand.denizen.events.player.PlayerBreaksBlockScriptEvent.applyDetermination(PlayerBreaksBlockScriptEvent.java:121)
11:40:51 [SEVERE] net.aufdemrand.denizencore.events.ScriptEvent.run(ScriptEvent.java:257)
11:40:51 [SEVERE] net.aufdemrand.denizencore.events.ScriptEvent.fire(ScriptEvent.java:227)
11:40:51 [SEVERE] net.aufdemrand.denizen.events.player.PlayerBreaksBlockScriptEvent.onPlayerBreaksBlock(PlayerBreaksBlockScriptEvent.java:161)
11:40:51 [SEVERE] sun.reflect.GeneratedMethodAccessor172.invoke(Unknown Source)
11:40:51 [SEVERE] sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
11:40:51 [SEVERE] java.lang.reflect.Method.invoke(Unknown Source)
11:40:51 [SEVERE] org.bukkit.plugin.java.JavaPluginLoader$1.execute(JavaPluginLoader.java:306)
11:40:51 [SEVERE] org.bukkit.plugin.RegisteredListener.callEvent(RegisteredListener.java:62)
11:40:51 [SEVERE] org.bukkit.plugin.SimplePluginManager.fireEvent(SimplePluginManager.java:502)
11:40:51 [SEVERE] org.bukkit.plugin.SimplePluginManager.callEvent(SimplePluginManager.java:487)
11:40:51 [SEVERE] net.minecraft.server.v1_8_R3.PlayerInteractManager.breakBlock(PlayerInteractManager.java:286)
11:40:51 [SEVERE] net.minecraft.server.v1_8_R3.PlayerInteractManager.a(PlayerInteractManager.java:121)
11:40:51 [SEVERE] net.minecraft.server.v1_8_R3.PlayerConnection.a(PlayerConnection.java:600)
11:40:51 [SEVERE] net.minecraft.server.v1_8_R3.PacketPlayInBlockDig.a(SourceFile:40)
11:40:51 [SEVERE] net.minecraft.server.v1_8_R3.PacketPlayInBlockDig.a(SourceFile:10)
11:40:51 [SEVERE] net.minecraft.server.v1_8_R3.PlayerConnectionUtils$1.run(SourceFile:13)
11:40:51 [SEVERE] java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source)
11:40:51 [SEVERE] java.util.concurrent.FutureTask.run(Unknown Source)
11:40:51 [SEVERE] net.minecraft.server.v1_8_R3.SystemUtils.a(SystemUtils.java:19)
11:40:51 [SEVERE] net.minecraft.server.v1_8_R3.MinecraftServer.B(MinecraftServer.java:718)
11:40:51 [SEVERE] net.minecraft.server.v1_8_R3.DedicatedServer.B(DedicatedServer.java:367)
11:40:51 [SEVERE] net.minecraft.server.v1_8_R3.MinecraftServer.A(MinecraftServer.java:657)
11:40:51 [SEVERE] net.minecraft.server.v1_8_R3.MinecraftServer.run(MinecraftServer.java:560)
11:40:51 [SEVERE] java.lang.Thread.run(Unknown Source)
11:40:51 [INFO] +> [dItem] Does not match a valid item ID or material: adamant 
11:40:51 [INFO] +> [dItem] valueOf dItem returning null: adamant 
11:40:51 [INFO]  Queue 'METEOR_RANDOM_PresentationsRomeFriendship' Executing: 
                   PLAYEFFECT "effect:enchantment_table" "qty:10" "%location%" 
11:40:51 [INFO] +- Executing dCommand: PLAYEFFECT/p@TheBlackCoyote ---------+ 
11:40:51 [INFO]  Filled definition %location% with 'l@612.5,70.0,-24.5,world'. 
11:40:51 [INFO] +> Executing 'PLAYEFFECT': special effect='ENCHANTMENT_TABLE'  
                   locations='[l@612.5,70.0,-24.5,world]'  radius='15'  data='0'  
                   qty='10'  offset='0.5'  offset='0.5' 
11:40:51 [INFO]  Queue 'METEOR_RANDOM_PresentationsRomeFriendship' Executing: 
                   WHILE " CALLBACK" 
11:40:51 [INFO]  Filled tag <def[location].as_location.simple> with 
                   '612,70,-25,world'. 
11:40:51 [INFO]  Filled tag <server.has_flag[612,70,-25,world_is_adamant]> 
                   with 'false'. 
11:40:51 [INFO]  Completing queue 'METEOR_RANDOM_PresentationsRomeFriendship' 
                   in 19422ms. 
11:40:51 [INFO]  Queue 'METEOR_RANDOM_DgWsHungary' Executing: PLAYEFFECT 
                   "effect:enchantment_table" "qty:10" "%location%" 
11:40:51 [INFO] +- Executing dCommand: PLAYEFFECT/p@TheBlackCoyote ---------+ 
11:40:51 [INFO]  Filled definition %location% with 'l@579.5,65.0,119.5,world'. 
11:40:51 [INFO] +> Executing 'PLAYEFFECT': special effect='ENCHANTMENT_TABLE'  
                   locations='[l@579.5,65.0,119.5,world]'  radius='15'  data='0'  
                   qty='10'  offset='0.5'  offset='0.5' 
11:40:51 [INFO]  Queue 'METEOR_RANDOM_DgWsHungary' Executing: WHILE 
                   " CALLBACK" 
11:40:51 [INFO]  Filled tag <def[location].as_location.simple> with 
                   '579,65,119,world'. 
11:40:51 [INFO]  Filled tag <server.has_flag[579,65,119,world_is_adamant]> 
                   with 'true'. 
11:40:51 [INFO] +- While loop 72 ---------+ 
11:40:51 [INFO]  Queue 'METEOR_RANDOM_DgWsHungary' Executing: WAIT "10t" 
11:40:51 [INFO] +- Executing dCommand: WAIT/p@TheBlackCoyote ---------+ 
11:40:51 [INFO] +> Executing 'WAIT': queue='METEOR_RANDOM_DgWsHungary'  
                   delay='d@10t' 
11:40:52 [INFO]  Queue 'METEOR_RANDOM_DgWsHungary' Executing: PLAYEFFECT 
                   "effect:enchantment_table" "qty:10" "%location%" 
11:40:52 [INFO] +- Executing dCommand: PLAYEFFECT/p@TheBlackCoyote ---------+ 
11:40:52 [INFO]  Filled definition %location% with 'l@579.5,65.0,119.5,world'. 
11:40:52 [INFO] +> Executing 'PLAYEFFECT': special effect='ENCHANTMENT_TABLE'  
                   locations='[l@579.5,65.0,119.5,world]'  radius='15'  data='0'  
                   qty='10'  offset='0.5'  offset='0.5' 
11:40:52 [INFO]  Queue 'METEOR_RANDOM_DgWsHungary' Executing: WHILE 
                   " CALLBACK" 
11:40:52 [INFO]  Filled tag <def[location].as_location.simple> with 
                   '579,65,119,world'. 
11:40:52 [INFO]  Filled tag <server.has_flag[579,65,119,world_is_adamant]> 
                   with 'true'. 
11:40:52 [INFO] +- While loop 73 ---------+ 
11:40:52 [INFO]  Queue 'METEOR_RANDOM_DgWsHungary' Executing: WAIT "10t" 
11:40:52 [INFO] +- Executing dCommand: WAIT/p@TheBlackCoyote ---------+ 
11:40:52 [INFO] +> Executing 'WAIT': queue='METEOR_RANDOM_DgWsHungary'  
                   delay='d@10t' 
11:40:52 [INFO]  Queue 'METEOR_RANDOM_DgWsHungary' Executing: PLAYEFFECT 
                   "effect:enchantment_table" "qty:10" "%location%" 
11:40:52 [INFO] +- Executing dCommand: PLAYEFFECT/p@TheBlackCoyote ---------+ 
11:40:52 [INFO]  Filled definition %location% with 'l@579.5,65.0,119.5,world'. 
11:40:52 [INFO] +> Executing 'PLAYEFFECT': special effect='ENCHANTMENT_TABLE'  
                   locations='[l@579.5,65.0,119.5,world]'  radius='15'  data='0'  
                   qty='10'  offset='0.5'  offset='0.5' 
11:40:52 [INFO]  Queue 'METEOR_RANDOM_DgWsHungary' Executing: WHILE 
                   " CALLBACK" 
11:40:52 [INFO]  Filled tag <def[location].as_location.simple> with 
                   '579,65,119,world'. 
11:40:52 [INFO]  Filled tag <server.has_flag[579,65,119,world_is_adamant]> 
                   with 'true'. 
11:40:52 [INFO] +- While loop 74 ---------+ 
11:40:52 [INFO]  Queue 'METEOR_RANDOM_DgWsHungary' Executing: WAIT "10t" 
11:40:52 [INFO] +- Executing dCommand: WAIT/p@TheBlackCoyote ---------+ 
11:40:52 [INFO] +> Executing 'WAIT': queue='METEOR_RANDOM_DgWsHungary'  
                   delay='d@10t' 
11:40:53 [INFO]  Queue 'METEOR_RANDOM_DgWsHungary' Executing: PLAYEFFECT 
                   "effect:enchantment_table" "qty:10" "%location%" 
11:40:53 [INFO] +- Executing dCommand: PLAYEFFECT/p@TheBlackCoyote ---------+ 
11:40:53 [INFO]  Filled definition %location% with 'l@579.5,65.0,119.5,world'. 
11:40:53 [INFO] +> Executing 'PLAYEFFECT': special effect='ENCHANTMENT_TABLE'  
                   locations='[l@579.5,65.0,119.5,world]'  radius='15'  data='0'  
                   qty='10'  offset='0.5'  offset='0.5' 
11:40:53 [INFO]  Queue 'METEOR_RANDOM_DgWsHungary' Executing: WHILE 
                   " CALLBACK" 
11:40:53 [INFO]  Filled tag <def[location].as_location.simple> with 
                   '579,65,119,world'. 
11:40:53 [INFO]  Filled tag <server.has_flag[579,65,119,world_is_adamant]> 
                   with 'true'. 
11:40:53 [INFO] +- While loop 75 ---------+ 
11:40:53 [INFO]  Queue 'METEOR_RANDOM_DgWsHungary' Executing: WAIT "10t" 
11:40:53 [INFO] +- Executing dCommand: WAIT/p@TheBlackCoyote ---------+ 
11:40:53 [INFO] +> Executing 'WAIT': queue='METEOR_RANDOM_DgWsHungary'  
                   delay='d@10t'