Paste #19428: Denizen Debug Logs From

Date: 2015/08/15 08:02:38 UTC-07:00
Type: Server Log

View Raw Paste Download This Paste
Copy Link


Java Version: 1.8.0_05
Up-time: 1h 5m
CraftBukkit Version: git-Spigot-d97e08b-880a532 (MC: 1.8.8)
Denizen Version: Core: 1.10 (Build Unknown), CraftBukkit: 0.9.7-SNAPSHOT (build 345)
Active Plugins (33): CoreProtect: 2.10.0, CleanroomGenerator: 1.0.0, WorldEdit: 5.6.3, Questioner: 0.6, 
HealthBar: 1.8.2, Essentials: TeamCity, GroupManager: 2.1.31 (Phoenix), Votifier: 1.9, 
WorldGuard: 6.0.0-beta-05.1569-, Multiverse-Core: 2.4-b527, EssentialsProtect: TeamCity, 
EssentialsChat: TeamCity, HeadsLite: 1.2, EssentialsAntiBuild: TeamCity, mcMMO: 1.5.03-SNAPSHOT-b52, 
Multiverse-Portals: 2.4-b548, Vault: 1.5.3-b37, EssentialsSpawn: TeamCity, 
EnjinMinecraftPlugin: 2.7.2-bukkit, AutoAnnouncer: 1.7-03.23, BattleShops: 3.4.6.8, 
HolographicDisplays: 2.1.10, LWC: 4.5.0-SNAPSHOT, Citizens: 2.0.16-SNAPSHOT (build 1251), 
Auction: 1.3.1, ColoredTags: 2.1.1, ColorMe: 3.8.1, Denizen: 0.9.7-SNAPSHOT (build 345), 
CompatNoCheatPlus: 6.5.0-RC-sMD5NET-b68, Towny: 0.89.2.0, RandomTP: 2.3 - noID, 
NoCheatPlus: 3.11.1-RC-sMD5NET-b743, Depenizen: 0.2.2 (build 253)
Loaded Worlds (9): world, world_nether, world_the_end, Spawn, Mountain, finaladventureworld, ArenaWorld, 
Survival, SkyBlockSpawn
Online Players (2): [Guest] DarknessFalls229(DarknessFalls229), 
[Guest] sander758(sander758)
Offline Players: 14
Mode: offline

17:02:32 [INFO] +> Executing 'Event': Type='on HOME1 command'  
                   Container='LOADDATACOMMANDWORLD(WORLD)'  
                   player=p@sander758Context='{args=li@, cuboids=li@, 
                   server=false, parsed_args=li@, command=HOME1, raw_args=}' 
17:02:32 [INFO] +- Building event 'ON HOME1 COMMAND' for LOADDATACOMMANDWORLD 
                   ---------+ 
17:02:32 [INFO]  Starting InstantQueue 
                   'LOADDATACOMMANDWORLD_BlanketCraftPirates'... 
17:02:32 [INFO]  Queue 'LOADDATACOMMANDWORLD_BlanketCraftPirates' Executing: 
                   DETERMINE "passively" "FULFILLED" 
17:02:32 [INFO] +- Executing dCommand: DETERMINE/p@sander758 ---------+ 
17:02:32 [INFO] +> Executing 'DETERMINE': outcome='FULFILLED'  
                   passively='true' 
17:02:32 [INFO]  Queue 'LOADDATACOMMANDWORLD_BlanketCraftPirates' Executing: 
                   DEFINE "player" "<player.uuid.split[-].separated_by[]>" 
17:02:32 [INFO] +- Executing dCommand: DEFINE/p@sander758 ---------+ 
17:02:32 [INFO]  Filled tag <player.uuid.split[-].separated_by[]> with 
                   'c2c3567b34b84ae3aae8dd1d30d87a52'. 
17:02:32 [INFO] +> Executing 'DEFINE': 
                   queue='LOADDATACOMMANDWORLD_BlanketCraftPirates'  
                   definition='player'  value='c2c3567b34b84ae3aae8dd1d30d87a52' 
17:02:32 [INFO]  Queue 'LOADDATACOMMANDWORLD_BlanketCraftPirates' Executing: 
                   SQL "id:savedata" "query:SELECT homeLocation FROM 
                   <player.name> WHERE existID=1;" "save:home1" 
17:02:32 [INFO] +- Executing dCommand: SQL/p@sander758 ---------+ 
17:02:32 [INFO]  ...remembering this script entry as 'home1'! 
17:02:32 [INFO]  Filled tag <player.name> with 'sander758'. 
17:02:32 [INFO] +> Executing 'SQL': sqlid='savedata'  action='QUERY'  
                   query='SELECT homeLocation FROM sander758 WHERE existID=1;' 
17:02:32 [INFO]  Running query SELECT homeLocation FROM sander758 WHERE 
                   existID=1; 
17:02:32 [INFO]  Got a query result of 1 columns 
17:02:32 [INFO]  Got a query result of 1 rows 
17:02:32 [INFO]  Queue 'LOADDATACOMMANDWORLD_BlanketCraftPirates' Executing: 
                   DEFINE "loclist" 
                   "<entry[home1].result.get[1].split[/].split[&dot0].split[l&at].split[,]>" 
17:02:32 [INFO] +- Executing dCommand: DEFINE/p@sander758 ---------+ 
17:02:32 [INFO]  Filled tag 
                   <entry[home1].result.get[1].split[/].split[&dot0].split[l&at].split[,]> 
                   with 'li@li@li@li@|-1178||126||-230||finaladventureworld'. 
17:02:32 [INFO] +> Executing 'DEFINE': 
                   queue='LOADDATACOMMANDWORLD_BlanketCraftPirates'  
                   definition='loclist'  
                   value='li@li@li@li@|-1178||126||-230||finaladventureworld' 
17:02:32 [INFO]  Queue 'LOADDATACOMMANDWORLD_BlanketCraftPirates' Executing: 
                   DEFINE "xloc" "<def[loclist].get[2]>" 
17:02:32 [INFO] +- Executing dCommand: DEFINE/p@sander758 ---------+ 
17:02:32 [INFO]  Filled tag <def[loclist].get[2]> with '-1178'. 
17:02:32 [INFO] +> Executing 'DEFINE': 
                   queue='LOADDATACOMMANDWORLD_BlanketCraftPirates'  
                   definition='xloc'  value='-1178' 
17:02:32 [INFO]  Queue 'LOADDATACOMMANDWORLD_BlanketCraftPirates' Executing: 
                   DEFINE "yloc" "<def[loclist].get[4]>" 
17:02:32 [INFO] +- Executing dCommand: DEFINE/p@sander758 ---------+ 
17:02:32 [INFO]  Filled tag <def[loclist].get[4]> with '126'. 
17:02:32 [INFO] +> Executing 'DEFINE': 
                   queue='LOADDATACOMMANDWORLD_BlanketCraftPirates'  
                   definition='yloc'  value='126' 
17:02:32 [INFO]  Queue 'LOADDATACOMMANDWORLD_BlanketCraftPirates' Executing: 
                   DEFINE "zloc" "<def[loclist].get[6]>" 
17:02:32 [INFO] +- Executing dCommand: DEFINE/p@sander758 ---------+ 
17:02:32 [INFO]  Filled tag <def[loclist].get[6]> with '-230'. 
17:02:32 [INFO] +> Executing 'DEFINE': 
                   queue='LOADDATACOMMANDWORLD_BlanketCraftPirates'  
                   definition='zloc'  value='-230' 
17:02:32 [INFO]  Queue 'LOADDATACOMMANDWORLD_BlanketCraftPirates' Executing: 
                   DEFINE "world" "<def[loclist].get[8]>" 
17:02:32 [INFO] +- Executing dCommand: DEFINE/p@sander758 ---------+ 
17:02:32 [INFO]  Filled tag <def[loclist].get[8]> with 'finaladventureworld'. 
17:02:32 [INFO] +> Executing 'DEFINE': 
                   queue='LOADDATACOMMANDWORLD_BlanketCraftPirates'  
                   definition='world'  value='finaladventureworld' 
17:02:32 [INFO]  Queue 'LOADDATACOMMANDWORLD_BlanketCraftPirates' Executing: 
                   DEFINE "location" "%xloc%,%yloc%,%zloc%,%world%" 
17:02:32 [INFO] +- Executing dCommand: DEFINE/p@sander758 ---------+ 
17:02:32 [INFO]  Filled definition %xloc% with '-1178'. 
17:02:32 [INFO]  Filled definition %yloc% with '126'. 
17:02:32 [INFO]  Filled definition %zloc% with '-230'. 
17:02:32 [INFO]  Filled definition %world% with 'finaladventureworld'. 
17:02:32 [INFO] +> Executing 'DEFINE': 
                   queue='LOADDATACOMMANDWORLD_BlanketCraftPirates'  
                   definition='location'  
                   value='-1178,126,-230,finaladventureworld' 
17:02:32 [INFO]  Queue 'LOADDATACOMMANDWORLD_BlanketCraftPirates' Executing: 
                   NARRATE "%loclist%" 
17:02:32 [INFO] +- Executing dCommand: NARRATE/p@sander758 ---------+ 
17:02:32 [INFO]  Filled definition %loclist% with 
                   'li@li@li@li@|-1178||126||-230||finaladventureworld'. 
17:02:32 [INFO] +> Executing 'NARRATE': 
                   Narrating='li@li@li@li@|-1178||126||-230||finaladventureworld' 
                    Targets='[p@sander758]' 
17:02:32 [INFO]  Queue 'LOADDATACOMMANDWORLD_BlanketCraftPirates' Executing: 
                   NARRATE "%xloc%" 
17:02:32 [INFO] +- Executing dCommand: NARRATE/p@sander758 ---------+ 
17:02:32 [INFO]  Filled definition %xloc% with '-1178'. 
17:02:32 [INFO] +> Executing 'NARRATE': Narrating='-1178'  
                   Targets='[p@sander758]' 
17:02:32 [INFO]  Queue 'LOADDATACOMMANDWORLD_BlanketCraftPirates' Executing: 
                   NARRATE "%yloc%" 
17:02:32 [INFO] +- Executing dCommand: NARRATE/p@sander758 ---------+ 
17:02:32 [INFO]  Filled definition %yloc% with '126'. 
17:02:32 [INFO] +> Executing 'NARRATE': Narrating='126'  
                   Targets='[p@sander758]' 
17:02:32 [INFO]  Queue 'LOADDATACOMMANDWORLD_BlanketCraftPirates' Executing: 
                   NARRATE "%zloc%" 
17:02:32 [INFO] +- Executing dCommand: NARRATE/p@sander758 ---------+ 
17:02:32 [INFO]  Filled definition %zloc% with '-230'. 
17:02:32 [INFO] +> Executing 'NARRATE': Narrating='-230'  
                   Targets='[p@sander758]' 
17:02:32 [INFO]  Queue 'LOADDATACOMMANDWORLD_BlanketCraftPirates' Executing: 
                   NARRATE "%world%" 
17:02:32 [INFO] +- Executing dCommand: NARRATE/p@sander758 ---------+ 
17:02:32 [INFO]  Filled definition %world% with 'finaladventureworld'. 
17:02:32 [INFO] +> Executing 'NARRATE': Narrating='finaladventureworld'  
                   Targets='[p@sander758]' 
17:02:32 [INFO]  Queue 'LOADDATACOMMANDWORLD_BlanketCraftPirates' Executing: 
                   NARRATE "%location%" 
17:02:32 [INFO] +- Executing dCommand: NARRATE/p@sander758 ---------+ 
17:02:32 [INFO]  Filled definition %location% with 
                   '-1178,126,-230,finaladventureworld'. 
17:02:32 [INFO] +> Executing 'NARRATE': 
                   Narrating='-1178,126,-230,finaladventureworld'  
                   Targets='[p@sander758]' 
17:02:32 [INFO]  Queue 'LOADDATACOMMANDWORLD_BlanketCraftPirates' Executing: 
                   TELEPORT "player" "l@%location%" 
17:02:32 [INFO] +- Executing dCommand: TELEPORT/p@sander758 ---------+ 
17:02:32 [INFO]  Filled definition %location% with 
                   '-1178,126,-230,finaladventureworld'. 
17:02:32 [INFO] +> Executing 'TELEPORT': 
                   location='l@-1178.0,126.0,-230.0,finaladventureworld'  
                   entities='[e@player]' 
17:02:32 [INFO]  ERROR in script 'LOADDATACOMMANDWORLD'! Woah!! An exception 
                   has been called with this command! 
17:02:32 [INFO]  ERROR in script 'LOADDATACOMMANDWORLD'! Internal exception 
                   was thrown! 
17:02:32 [SEVERE] java.lang.NullPointerException: name cannot be null
17:02:32 [SEVERE] com.google.common.base.Preconditions.checkNotNull(Preconditions.java:229)
17:02:32 [SEVERE] net.citizensnpcs.npc.CitizensNPCRegistry.createNPC(CitizensNPCRegistry.java:45)
17:02:32 [SEVERE] net.citizensnpcs.npc.CitizensNPCRegistry.createNPC(CitizensNPCRegistry.java:40)
17:02:32 [SEVERE] net.aufdemrand.denizen.objects.dEntity.spawnAt(dEntity.java:815)
17:02:32 [SEVERE] net.aufdemrand.denizen.scripts.commands.entity.TeleportCommand.execute(TeleportCommand.java:73)
17:02:32 [SEVERE] net.aufdemrand.denizencore.scripts.commands.CommandExecuter.execute(CommandExecuter.java:236)
17:02:32 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptEngine.revolve(ScriptEngine.java:52)
17:02:32 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptQueue.revolve(ScriptQueue.java:632)
17:02:32 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.InstantQueue.onStart(InstantQueue.java:53)
17:02:32 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptQueue.start(ScriptQueue.java:491)
17:02:32 [SEVERE] net.aufdemrand.denizencore.events.OldEventManager.doEvents(OldEventManager.java:231)
17:02:32 [SEVERE] net.aufdemrand.denizen.scripts.containers.core.BukkitWorldScriptHelper.doEvents(BukkitWorldScriptHelper.java:53)
17:02:32 [SEVERE] net.aufdemrand.denizen.scripts.containers.core.BukkitWorldScriptHelper.doEvents(BukkitWorldScriptHelper.java:44)
17:02:32 [SEVERE] net.aufdemrand.denizen.events.core.CommandSmartEvent.playerCommandPreprocess(CommandSmartEvent.java:220)
17:02:32 [SEVERE] sun.reflect.GeneratedMethodAccessor344.invoke(Unknown Source)
17:02:32 [SEVERE] sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
17:02:32 [SEVERE] java.lang.reflect.Method.invoke(Method.java:483)
17:02:32 [SEVERE] org.bukkit.plugin.java.JavaPluginLoader$1.execute(JavaPluginLoader.java:306)
17:02:32 [SEVERE] org.bukkit.plugin.RegisteredListener.callEvent(RegisteredListener.java:62)
17:02:32 [SEVERE] org.bukkit.plugin.SimplePluginManager.fireEvent(SimplePluginManager.java:502)
17:02:32 [SEVERE] org.bukkit.plugin.SimplePluginManager.callEvent(SimplePluginManager.java:487)
17:02:32 [SEVERE] net.minecraft.server.v1_8_R3.PlayerConnection.handleCommand(PlayerConnection.java:1154)
17:02:32 [SEVERE] net.minecraft.server.v1_8_R3.PlayerConnection.a(PlayerConnection.java:997)
17:02:32 [SEVERE] net.aufdemrand.denizen.utilities.packets.intercept.AbstractListenerPlayIn.a(AbstractListenerPlayIn.java:87)
17:02:32 [SEVERE] net.minecraft.server.v1_8_R3.PacketPlayInChat.a(PacketPlayInChat.java:45)
17:02:32 [SEVERE] net.minecraft.server.v1_8_R3.PacketPlayInChat.a(PacketPlayInChat.java:1)
17:02:32 [SEVERE] net.minecraft.server.v1_8_R3.PlayerConnectionUtils$1.run(SourceFile:13)
17:02:32 [SEVERE] java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
17:02:32 [SEVERE] java.util.concurrent.FutureTask.run(FutureTask.java:266)
17:02:32 [SEVERE] net.minecraft.server.v1_8_R3.SystemUtils.a(SourceFile:44)
17:02:32 [SEVERE] net.minecraft.server.v1_8_R3.MinecraftServer.B(MinecraftServer.java:714)
17:02:32 [SEVERE] net.minecraft.server.v1_8_R3.DedicatedServer.B(DedicatedServer.java:374)
17:02:32 [SEVERE] net.minecraft.server.v1_8_R3.MinecraftServer.A(MinecraftServer.java:653)
17:02:32 [SEVERE] net.minecraft.server.v1_8_R3.MinecraftServer.run(MinecraftServer.java:556)
17:02:32 [SEVERE] java.lang.Thread.run(Thread.java:745)
17:02:32 [INFO] +> [Denizen] (Attempted: TELEPORT "player" "l@%location%") 
17:02:32 [INFO] +---------------------+ 
17:02:32 [INFO]  Queue 'LOADDATACOMMANDWORLD_BlanketCraftPirates' Executing: 
                   NARRATE "<gold>Teleporting to home 1" 
17:02:32 [INFO] +- Executing dCommand: NARRATE/p@sander758 ---------+ 
17:02:32 [INFO]  Filled tag <gold> with ''. 
17:02:32 [INFO] +> Executing 'NARRATE': Narrating='Teleporting to home 1'  
                   Targets='[p@sander758]' 
17:02:32 [INFO]  Completing queue 'LOADDATACOMMANDWORLD_BlanketCraftPirates' 
                   in 8ms.