Java Version: 1.8.0_181
Up-time: 1m 30s
CraftBukkit Version: git-Paper-1582 (MC: 1.12.2)
Denizen Version: Core: 1.20 (Build 160), CraftBukkit: 1.0.3-SNAPSHOT (build 434)
Active Plugins (7): NoCheatPlus: 3.15.0-SNAPSHOT-sMD5NET-b1063, Citizens: 2.0.24-SNAPSHOT (build 1573),
Denizen: 1.0.3-SNAPSHOT (build 434), BlackBird: 1, Webizen: 0.2.0, Extendizen: 1,
Depenizen: 1.0.0 (build 417)
Loaded Worlds (2): world, storyworld
Online Players (1): BlackCoyote(BlackCoyote)
Offline Players: 0
Mode: offline
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "contains" "walk"
18:01:55 [INFO] +- Executing dCommand: IF ---------+
18:01:55 [INFO] +> Executing 'IF': use_braces='true'
18:01:55 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:55 [INFO] Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='true'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: ANIMATEMODEL "pause" "uuid:<def[phenex].uuid>"
"animation:walk"
18:01:55 [INFO] +- Executing dCommand: ANIMATEMODEL ---------+
18:01:55 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:55 [INFO] +> Executing 'ANIMATEMODEL': action='pause' animation='walk' uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WHILE " CALLBACK"
18:01:55 [INFO] Filled tag <def[target].location> with
'l@1067.713183005478,23.613451549029524,701.0389168990806,2.220636,141.49217,storyworld'.
18:01:55 [INFO] Filled tag <def[distance]> with '3'.
18:01:55 [INFO] Filled tag
<def[phenex].location.distance[l@1067.713183005478,23.613451549029524,701.0389168990806,2.220636,141.49217,storyworld].is[more].than[3]>
with 'true'.
18:01:55 [INFO] +- While loop 4 ---------+
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>"
18:01:55 [INFO] +- Executing dCommand: SPAWNEDMODEL ---------+
18:01:55 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:55 [INFO] Filled tag <def[target].location> with
'l@1067.713183005478,23.613451549029524,701.0389168990806,2.220636,141.49217,storyworld'.
18:01:55 [INFO] Filled tag
<def[phenex].location.face[l@1067.713183005478,23.613451549029524,701.0389168990806,2.220636,141.49217,storyworld].direction.vector.div[5]>
with 'l@0.13615965838928196,0.0417322156082915,0.14042424864579878,storyworld'.
18:01:55 [INFO] Filled tag <def[target].eye_location> with
'l@1067.713183005478,25.233451553797895,701.0389168990806,2.220636,141.49217,storyworld'.
18:01:55 [INFO] Filled tag
<def[phenex].location.add[l@0.13615965838928196,0.0417322156082915,0.14042424864579878,storyworld].face[l@1067.713183005478,25.233451553797895,701.0389168990806,2.220636,141.49217,storyworld]>
with 'l@1065.3133344363096,22.877910766465334,698.5639031008212,-34.343582,315.88336,storyworld'.
18:01:55 [INFO] +> Executing 'SPAWNEDMODEL': action='teleport'
location='l@1065.3133344363096,22.877910766465334,698.5639031008212,-34.343582,315.88336,storyworld'
uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:55 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Woah!! An exception has been called with this command (while executing it)!
18:01:55 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Internal exception was thrown!
18:01:55 [SEVERE] java.lang.NullPointerException
18:01:55 [SEVERE] net.wizardsmine.extendizen.models.SpawnedModel.teleport(SpawnedModel.java:142)
18:01:55 [SEVERE] net.wizardsmine.extendizen.commands.SpawnedModelCommand.execute(SpawnedModelCommand.java:205)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.commands.CommandExecuter.execute(CommandExecuter.java:168)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptEngine.revolve(ScriptEngine.java:70)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptQueue.revolve(ScriptQueue.java:670)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue.access$000(TimedQueue.java:12)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue$1.run(TimedQueue.java:164)
18:01:55 [SEVERE] net.aufdemrand.denizencore.utilities.scheduling.RepeatingSchedulable.tick(RepeatingSchedulable.java:20)
18:01:55 [SEVERE] net.aufdemrand.denizencore.DenizenCore.tick(DenizenCore.java:155)
18:01:55 [SEVERE] net.aufdemrand.denizen.Denizen$6.run(Denizen.java:924)
18:01:55 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftTask.run(CraftTask.java:63)
18:01:55 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftScheduler.mainThreadHeartbeat(CraftScheduler.java:423)
18:01:55 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.D(MinecraftServer.java:840)
18:01:55 [SEVERE] net.minecraft.server.v1_12_R1.DedicatedServer.D(DedicatedServer.java:423)
18:01:55 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.C(MinecraftServer.java:774)
18:01:55 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.run(MinecraftServer.java:666)
18:01:55 [SEVERE] java.lang.Thread.run(Thread.java:748)
18:01:55 [INFO] +> [Denizen] (Attempted: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>")
18:01:55 [INFO] +---------------------+
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "!contains"
"walk"
18:01:55 [INFO] +- Executing dCommand: IF ---------+
18:01:55 [INFO] +> Executing 'IF': use_braces='true'
18:01:55 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:55 [INFO] Logic='NEGATIVE', Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='false'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[loop_index]>" ">=" "<def[timeout]>"
18:01:55 [INFO] +- Executing dCommand: IF ---------+
18:01:55 [INFO] +> Executing 'IF': use_braces='true'
18:01:55 [INFO] Filled tag <def[loop_index]> with '4'.
18:01:55 [INFO] Filled tag <def[timeout]> with '100'.
18:01:55 [INFO] Comparable='Decimal(4.0)', Operator='OR_MORE', ComparedTo='Decimal(100.0)' --> OUTCOME='false'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WAIT "0.5t"
18:01:55 [INFO] +- Executing dCommand: WAIT ---------+
18:01:55 [INFO] +> Executing 'WAIT': queue='PHENEX_TRY_APPROACH_EscortFilteringOccasional' delay='d@0.025s'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "contains" "walk"
18:01:55 [INFO] +- Executing dCommand: IF ---------+
18:01:55 [INFO] +> Executing 'IF': use_braces='true'
18:01:55 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:55 [INFO] Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='true'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: ANIMATEMODEL "pause" "uuid:<def[phenex].uuid>"
"animation:walk"
18:01:55 [INFO] +- Executing dCommand: ANIMATEMODEL ---------+
18:01:55 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:55 [INFO] +> Executing 'ANIMATEMODEL': action='pause' animation='walk' uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WHILE " CALLBACK"
18:01:55 [INFO] Filled tag <def[target].location> with
'l@1068.2530077468425,23.684988805029526,701.595640501914,2.220636,141.49217,storyworld'.
18:01:55 [INFO] Filled tag <def[distance]> with '3'.
18:01:55 [INFO] Filled tag
<def[phenex].location.distance[l@1068.2530077468425,23.684988805029526,701.595640501914,2.220636,141.49217,storyworld].is[more].than[3]>
with 'true'.
18:01:55 [INFO] +- While loop 5 ---------+
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>"
18:01:55 [INFO] +- Executing dCommand: SPAWNEDMODEL ---------+
18:01:55 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:55 [INFO] Filled tag <def[target].location> with
'l@1068.2530077468425,23.684988805029526,701.595640501914,2.220636,141.49217,storyworld'.
18:01:55 [INFO] Filled tag
<def[phenex].location.face[l@1068.2530077468425,23.684988805029526,701.595640501914,2.220636,141.49217,storyworld].direction.vector.div[5]>
with 'l@0.13674934956766727,0.037544103744729274,0.14103210863780255,storyworld'.
18:01:55 [INFO] Filled tag <def[target].eye_location> with
'l@1068.2530077468425,25.304988809797898,701.595640501914,2.220636,141.49217,storyworld'.
18:01:55 [INFO] Filled tag
<def[phenex].location.add[l@0.13674934956766727,0.037544103744729274,0.14103210863780255,storyworld].face[l@1068.2530077468425,25.304988809797898,701.595640501914,2.220636,141.49217,storyworld]>
with 'l@1065.4500837858773,22.915454870210063,698.704935209459,-30.687202,315.8833,storyworld'.
18:01:55 [INFO] +> Executing 'SPAWNEDMODEL': action='teleport'
location='l@1065.4500837858773,22.915454870210063,698.704935209459,-30.687202,315.8833,storyworld'
uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:55 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Woah!! An exception has been called with this command (while executing it)!
18:01:55 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Internal exception was thrown!
18:01:55 [SEVERE] java.lang.NullPointerException
18:01:55 [SEVERE] net.wizardsmine.extendizen.models.SpawnedModel.teleport(SpawnedModel.java:142)
18:01:55 [SEVERE] net.wizardsmine.extendizen.commands.SpawnedModelCommand.execute(SpawnedModelCommand.java:205)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.commands.CommandExecuter.execute(CommandExecuter.java:168)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptEngine.revolve(ScriptEngine.java:70)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptQueue.revolve(ScriptQueue.java:670)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue.access$000(TimedQueue.java:12)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue$1.run(TimedQueue.java:164)
18:01:55 [SEVERE] net.aufdemrand.denizencore.utilities.scheduling.RepeatingSchedulable.tick(RepeatingSchedulable.java:20)
18:01:55 [SEVERE] net.aufdemrand.denizencore.DenizenCore.tick(DenizenCore.java:155)
18:01:55 [SEVERE] net.aufdemrand.denizen.Denizen$6.run(Denizen.java:924)
18:01:55 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftTask.run(CraftTask.java:63)
18:01:55 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftScheduler.mainThreadHeartbeat(CraftScheduler.java:423)
18:01:55 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.D(MinecraftServer.java:840)
18:01:55 [SEVERE] net.minecraft.server.v1_12_R1.DedicatedServer.D(DedicatedServer.java:423)
18:01:55 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.C(MinecraftServer.java:774)
18:01:55 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.run(MinecraftServer.java:666)
18:01:55 [SEVERE] java.lang.Thread.run(Thread.java:748)
18:01:55 [INFO] +> [Denizen] (Attempted: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>")
18:01:55 [INFO] +---------------------+
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "!contains"
"walk"
18:01:55 [INFO] +- Executing dCommand: IF ---------+
18:01:55 [INFO] +> Executing 'IF': use_braces='true'
18:01:55 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:55 [INFO] Logic='NEGATIVE', Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='false'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[loop_index]>" ">=" "<def[timeout]>"
18:01:55 [INFO] +- Executing dCommand: IF ---------+
18:01:55 [INFO] +> Executing 'IF': use_braces='true'
18:01:55 [INFO] Filled tag <def[loop_index]> with '5'.
18:01:55 [INFO] Filled tag <def[timeout]> with '100'.
18:01:55 [INFO] Comparable='Decimal(5.0)', Operator='OR_MORE', ComparedTo='Decimal(100.0)' --> OUTCOME='false'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WAIT "0.5t"
18:01:55 [INFO] +- Executing dCommand: WAIT ---------+
18:01:55 [INFO] +> Executing 'WAIT': queue='PHENEX_TRY_APPROACH_EscortFilteringOccasional' delay='d@0.025s'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "contains" "walk"
18:01:55 [INFO] +- Executing dCommand: IF ---------+
18:01:55 [INFO] +> Executing 'IF': use_braces='true'
18:01:55 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:55 [INFO] Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='true'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: ANIMATEMODEL "pause" "uuid:<def[phenex].uuid>"
"animation:walk"
18:01:55 [INFO] +- Executing dCommand: ANIMATEMODEL ---------+
18:01:55 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:55 [INFO] +> Executing 'ANIMATEMODEL': action='pause' animation='walk' uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WHILE " CALLBACK"
18:01:55 [INFO] Filled tag <def[target].location> with
'l@1068.6598040521887,23.697602721189526,702.0151713002971,2.220636,141.49217,storyworld'.
18:01:55 [INFO] Filled tag <def[distance]> with '3'.
18:01:55 [INFO] Filled tag
<def[phenex].location.distance[l@1068.6598040521887,23.697602721189526,702.0151713002971,2.220636,141.49217,storyworld].is[more].than[3]>
with 'true'.
18:01:55 [INFO] +- While loop 6 ---------+
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>"
18:01:55 [INFO] +- Executing dCommand: SPAWNEDMODEL ---------+
18:01:55 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:55 [INFO] Filled tag <def[target].location> with
'l@1068.6598040521887,23.697602721189526,702.0151713002971,2.220636,141.49217,storyworld'.
18:01:55 [INFO] Filled tag
<def[phenex].location.face[l@1068.6598040521887,23.697602721189526,702.0151713002971,2.220636,141.49217,storyworld].direction.vector.div[5]>
with 'l@0.13726369178908307,0.03344856026395372,0.14156225744420817,storyworld'.
18:01:55 [INFO] Filled tag <def[target].eye_location> with
'l@1068.6598040521887,25.317602725957897,702.0151713002971,2.220636,141.49217,storyworld'.
18:01:55 [INFO] Filled tag
<def[phenex].location.add[l@0.13726369178908307,0.03344856026395372,0.14156225744420817,storyworld].face[l@1068.6598040521887,25.317602725957897,702.0151713002971,2.220636,141.49217,storyworld]>
with 'l@1065.5873474776663,22.948903430474015,698.8464974669032,-28.221275,315.88324,storyworld'.
18:01:55 [INFO] +> Executing 'SPAWNEDMODEL': action='teleport'
location='l@1065.5873474776663,22.948903430474015,698.8464974669032,-28.221275,315.88324,storyworld'
uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:55 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Woah!! An exception has been called with this command (while executing it)!
18:01:55 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Internal exception was thrown!
18:01:55 [SEVERE] java.lang.NullPointerException
18:01:55 [SEVERE] net.wizardsmine.extendizen.models.SpawnedModel.teleport(SpawnedModel.java:142)
18:01:55 [SEVERE] net.wizardsmine.extendizen.commands.SpawnedModelCommand.execute(SpawnedModelCommand.java:205)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.commands.CommandExecuter.execute(CommandExecuter.java:168)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptEngine.revolve(ScriptEngine.java:70)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptQueue.revolve(ScriptQueue.java:670)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue.access$000(TimedQueue.java:12)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue$1.run(TimedQueue.java:164)
18:01:55 [SEVERE] net.aufdemrand.denizencore.utilities.scheduling.RepeatingSchedulable.tick(RepeatingSchedulable.java:20)
18:01:55 [SEVERE] net.aufdemrand.denizencore.DenizenCore.tick(DenizenCore.java:155)
18:01:55 [SEVERE] net.aufdemrand.denizen.Denizen$6.run(Denizen.java:924)
18:01:55 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftTask.run(CraftTask.java:63)
18:01:55 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftScheduler.mainThreadHeartbeat(CraftScheduler.java:423)
18:01:55 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.D(MinecraftServer.java:840)
18:01:55 [SEVERE] net.minecraft.server.v1_12_R1.DedicatedServer.D(DedicatedServer.java:423)
18:01:55 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.C(MinecraftServer.java:774)
18:01:55 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.run(MinecraftServer.java:666)
18:01:55 [SEVERE] java.lang.Thread.run(Thread.java:748)
18:01:55 [INFO] +> [Denizen] (Attempted: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>")
18:01:55 [INFO] +---------------------+
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "!contains"
"walk"
18:01:55 [INFO] +- Executing dCommand: IF ---------+
18:01:55 [INFO] +> Executing 'IF': use_braces='true'
18:01:55 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:55 [INFO] Logic='NEGATIVE', Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='false'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[loop_index]>" ">=" "<def[timeout]>"
18:01:55 [INFO] +- Executing dCommand: IF ---------+
18:01:55 [INFO] +> Executing 'IF': use_braces='true'
18:01:55 [INFO] Filled tag <def[loop_index]> with '6'.
18:01:55 [INFO] Filled tag <def[timeout]> with '100'.
18:01:55 [INFO] Comparable='Decimal(6.0)', Operator='OR_MORE', ComparedTo='Decimal(100.0)' --> OUTCOME='false'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WAIT "0.5t"
18:01:55 [INFO] +- Executing dCommand: WAIT ---------+
18:01:55 [INFO] +> Executing 'WAIT': queue='PHENEX_TRY_APPROACH_EscortFilteringOccasional' delay='d@0.025s'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "contains" "walk"
18:01:55 [INFO] +- Executing dCommand: IF ---------+
18:01:55 [INFO] +> Executing 'IF': use_braces='true'
18:01:55 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:55 [INFO] Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='true'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: ANIMATEMODEL "pause" "uuid:<def[phenex].uuid>"
"animation:walk"
18:01:55 [INFO] +- Executing dCommand: ANIMATEMODEL ---------+
18:01:55 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:55 [INFO] +> Executing 'ANIMATEMODEL': action='pause' animation='walk' uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WHILE " CALLBACK"
18:01:55 [INFO] Filled tag <def[target].location> with
'l@1068.8736422426143,23.697602721189526,702.2357035558143,2.220636,141.49217,storyworld'.
18:01:55 [INFO] Filled tag <def[distance]> with '3'.
18:01:55 [INFO] Filled tag
<def[phenex].location.distance[l@1068.8736422426143,23.697602721189526,702.2357035558143,2.220636,141.49217,storyworld].is[more].than[3]>
with 'true'.
18:01:55 [INFO] +- While loop 7 ---------+
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>"
18:01:55 [INFO] +- Executing dCommand: SPAWNEDMODEL ---------+
18:01:55 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:55 [INFO] Filled tag <def[target].location> with
'l@1068.8736422426143,23.697602721189526,702.2357035558143,2.220636,141.49217,storyworld'.
18:01:55 [INFO] Filled tag
<def[phenex].location.face[l@1068.8736422426143,23.697602721189526,702.2357035558143,2.220636,141.49217,storyworld].direction.vector.div[5]>
with 'l@0.13750602394949282,0.03132729488505852,0.14181217850659406,storyworld'.
18:01:55 [INFO] Filled tag <def[target].eye_location> with
'l@1068.8736422426143,25.317602725957897,702.2357035558143,2.220636,141.49217,storyworld'.
18:01:55 [INFO] Filled tag
<def[phenex].location.add[l@0.13750602394949282,0.03132729488505852,0.14181217850659406,storyworld].face[l@1068.8736422426143,25.317602725957897,702.2357035558143,2.220636,141.49217,storyworld]>
with 'l@1065.7248535016158,22.980230725359075,698.9883096454098,-27.327118,315.8832,storyworld'.
18:01:55 [INFO] +> Executing 'SPAWNEDMODEL': action='teleport'
location='l@1065.7248535016158,22.980230725359075,698.9883096454098,-27.327118,315.8832,storyworld'
uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:55 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Woah!! An exception has been called with this command (while executing it)!
18:01:55 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Internal exception was thrown!
18:01:55 [SEVERE] java.lang.NullPointerException
18:01:55 [SEVERE] net.wizardsmine.extendizen.models.SpawnedModel.teleport(SpawnedModel.java:142)
18:01:55 [SEVERE] net.wizardsmine.extendizen.commands.SpawnedModelCommand.execute(SpawnedModelCommand.java:205)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.commands.CommandExecuter.execute(CommandExecuter.java:168)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptEngine.revolve(ScriptEngine.java:70)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptQueue.revolve(ScriptQueue.java:670)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue.access$000(TimedQueue.java:12)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue$1.run(TimedQueue.java:164)
18:01:55 [SEVERE] net.aufdemrand.denizencore.utilities.scheduling.RepeatingSchedulable.tick(RepeatingSchedulable.java:20)
18:01:55 [SEVERE] net.aufdemrand.denizencore.DenizenCore.tick(DenizenCore.java:155)
18:01:55 [SEVERE] net.aufdemrand.denizen.Denizen$6.run(Denizen.java:924)
18:01:55 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftTask.run(CraftTask.java:63)
18:01:55 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftScheduler.mainThreadHeartbeat(CraftScheduler.java:423)
18:01:55 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.D(MinecraftServer.java:840)
18:01:55 [SEVERE] net.minecraft.server.v1_12_R1.DedicatedServer.D(DedicatedServer.java:423)
18:01:55 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.C(MinecraftServer.java:774)
18:01:55 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.run(MinecraftServer.java:666)
18:01:55 [SEVERE] java.lang.Thread.run(Thread.java:748)
18:01:55 [INFO] +> [Denizen] (Attempted: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>")
18:01:55 [INFO] +---------------------+
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "!contains"
"walk"
18:01:55 [INFO] +- Executing dCommand: IF ---------+
18:01:55 [INFO] +> Executing 'IF': use_braces='true'
18:01:55 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:55 [INFO] Logic='NEGATIVE', Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='false'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[loop_index]>" ">=" "<def[timeout]>"
18:01:55 [INFO] +- Executing dCommand: IF ---------+
18:01:55 [INFO] +> Executing 'IF': use_braces='true'
18:01:55 [INFO] Filled tag <def[loop_index]> with '7'.
18:01:55 [INFO] Filled tag <def[timeout]> with '100'.
18:01:55 [INFO] Comparable='Decimal(7.0)', Operator='OR_MORE', ComparedTo='Decimal(100.0)' --> OUTCOME='false'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WAIT "0.5t"
18:01:55 [INFO] +- Executing dCommand: WAIT ---------+
18:01:55 [INFO] +> Executing 'WAIT': queue='PHENEX_TRY_APPROACH_EscortFilteringOccasional' delay='d@0.025s'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "contains" "walk"
18:01:55 [INFO] +- Executing dCommand: IF ---------+
18:01:55 [INFO] +> Executing 'IF': use_braces='true'
18:01:55 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:55 [INFO] Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='true'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: ANIMATEMODEL "pause" "uuid:<def[phenex].uuid>"
"animation:walk"
18:01:55 [INFO] +- Executing dCommand: ANIMATEMODEL ---------+
18:01:55 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:55 [INFO] +> Executing 'ANIMATEMODEL': action='pause' animation='walk' uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WHILE " CALLBACK"
18:01:55 [INFO] Filled tag <def[target].location> with
'l@1069.1274962502384,23.697602721189526,702.4975042975901,2.220636,141.49217,storyworld'.
18:01:55 [INFO] Filled tag <def[distance]> with '3'.
18:01:55 [INFO] Filled tag
<def[phenex].location.distance[l@1069.1274962502384,23.697602721189526,702.4975042975901,2.220636,141.49217,storyworld].is[more].than[3]>
with 'true'.
18:01:55 [INFO] +- While loop 8 ---------+
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>"
18:01:55 [INFO] +- Executing dCommand: SPAWNEDMODEL ---------+
18:01:55 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:55 [INFO] Filled tag <def[target].location> with
'l@1069.1274962502384,23.697602721189526,702.4975042975901,2.220636,141.49217,storyworld'.
18:01:55 [INFO] Filled tag
<def[phenex].location.face[l@1069.1274962502384,23.697602721189526,702.4975042975901,2.220636,141.49217,storyworld].direction.vector.div[5]>
with 'l@0.1377491238657147,0.029041346511621487,0.14206258855525591,storyworld'.
18:01:55 [INFO] Filled tag <def[target].eye_location> with
'l@1069.1274962502384,25.317602725957897,702.4975042975901,2.220636,141.49217,storyworld'.
18:01:55 [INFO] Filled tag
<def[phenex].location.add[l@0.1377491238657147,0.029041346511621487,0.14206258855525591,storyworld].face[l@1069.1274962502384,25.317602725957897,702.4975042975901,2.220636,141.49217,storyworld]>
with 'l@1065.8626026254815,23.009272071870697,699.1303722339651,-26.205032,315.88318,storyworld'.
18:01:55 [INFO] +> Executing 'SPAWNEDMODEL': action='teleport'
location='l@1065.8626026254815,23.009272071870697,699.1303722339651,-26.205032,315.88318,storyworld'
uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:55 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Woah!! An exception has been called with this command (while executing it)!
18:01:55 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Internal exception was thrown!
18:01:55 [SEVERE] java.lang.NullPointerException
18:01:55 [SEVERE] net.wizardsmine.extendizen.models.SpawnedModel.teleport(SpawnedModel.java:142)
18:01:55 [SEVERE] net.wizardsmine.extendizen.commands.SpawnedModelCommand.execute(SpawnedModelCommand.java:205)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.commands.CommandExecuter.execute(CommandExecuter.java:168)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptEngine.revolve(ScriptEngine.java:70)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptQueue.revolve(ScriptQueue.java:670)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue.access$000(TimedQueue.java:12)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue$1.run(TimedQueue.java:164)
18:01:55 [SEVERE] net.aufdemrand.denizencore.utilities.scheduling.RepeatingSchedulable.tick(RepeatingSchedulable.java:20)
18:01:55 [SEVERE] net.aufdemrand.denizencore.DenizenCore.tick(DenizenCore.java:155)
18:01:55 [SEVERE] net.aufdemrand.denizen.Denizen$6.run(Denizen.java:924)
18:01:55 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftTask.run(CraftTask.java:63)
18:01:55 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftScheduler.mainThreadHeartbeat(CraftScheduler.java:423)
18:01:55 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.D(MinecraftServer.java:840)
18:01:55 [SEVERE] net.minecraft.server.v1_12_R1.DedicatedServer.D(DedicatedServer.java:423)
18:01:55 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.C(MinecraftServer.java:774)
18:01:55 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.run(MinecraftServer.java:666)
18:01:55 [SEVERE] java.lang.Thread.run(Thread.java:748)
18:01:55 [INFO] +> [Denizen] (Attempted: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>")
18:01:55 [INFO] +---------------------+
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "!contains"
"walk"
18:01:55 [INFO] +- Executing dCommand: IF ---------+
18:01:55 [INFO] +> Executing 'IF': use_braces='true'
18:01:55 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:55 [INFO] Logic='NEGATIVE', Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='false'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[loop_index]>" ">=" "<def[timeout]>"
18:01:55 [INFO] +- Executing dCommand: IF ---------+
18:01:55 [INFO] +> Executing 'IF': use_braces='true'
18:01:55 [INFO] Filled tag <def[loop_index]> with '8'.
18:01:55 [INFO] Filled tag <def[timeout]> with '100'.
18:01:55 [INFO] Comparable='Decimal(8.0)', Operator='OR_MORE', ComparedTo='Decimal(100.0)' --> OUTCOME='false'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WAIT "0.5t"
18:01:55 [INFO] +- Executing dCommand: WAIT ---------+
18:01:55 [INFO] +> Executing 'WAIT': queue='PHENEX_TRY_APPROACH_EscortFilteringOccasional' delay='d@0.025s'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "contains" "walk"
18:01:55 [INFO] +- Executing dCommand: IF ---------+
18:01:55 [INFO] +> Executing 'IF': use_braces='true'
18:01:55 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:55 [INFO] Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='true'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: ANIMATEMODEL "pause" "uuid:<def[phenex].uuid>"
"animation:walk"
18:01:55 [INFO] +- Executing dCommand: ANIMATEMODEL ---------+
18:01:55 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:55 [INFO] +> Executing 'ANIMATEMODEL': action='pause' animation='walk' uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WHILE " CALLBACK"
18:01:55 [INFO] Filled tag <def[target].location> with
'l@1069.3187932851572,23.697602721189526,702.6947897614281,2.220636,141.49217,storyworld'.
18:01:55 [INFO] Filled tag <def[distance]> with '3'.
18:01:55 [INFO] Filled tag
<def[phenex].location.distance[l@1069.3187932851572,23.697602721189526,702.6947897614281,2.220636,141.49217,storyworld].is[more].than[3]>
with 'true'.
18:01:55 [INFO] +- While loop 9 ---------+
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>"
18:01:55 [INFO] +- Executing dCommand: SPAWNEDMODEL ---------+
18:01:55 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:55 [INFO] Filled tag <def[target].location> with
'l@1069.3187932851572,23.697602721189526,702.6947897614281,2.220636,141.49217,storyworld'.
18:01:55 [INFO] Filled tag
<def[phenex].location.face[l@1069.3187932851572,23.697602721189526,702.6947897614281,2.220636,141.49217,storyworld].direction.vector.div[5]>
with 'l@0.13790569934468697,0.027465120550986617,0.14222406702584686,storyworld'.
18:01:55 [INFO] Filled tag <def[target].eye_location> with
'l@1069.3187932851572,25.317602725957897,702.6947897614281,2.220636,141.49217,storyworld'.
18:01:55 [INFO] Filled tag
<def[phenex].location.add[l@0.13790569934468697,0.027465120550986617,0.14222406702584686,storyworld].face[l@1069.3187932851572,25.317602725957897,702.6947897614281,2.220636,141.49217,storyworld]>
with 'l@1066.0005083248261,23.036737192421683,699.2725963009909,-25.570625,315.88318,storyworld'.
18:01:55 [INFO] +> Executing 'SPAWNEDMODEL': action='teleport'
location='l@1066.0005083248261,23.036737192421683,699.2725963009909,-25.570625,315.88318,storyworld'
uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:55 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Woah!! An exception has been called with this command (while executing it)!
18:01:55 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Internal exception was thrown!
18:01:55 [SEVERE] java.lang.NullPointerException
18:01:55 [SEVERE] net.wizardsmine.extendizen.models.SpawnedModel.teleport(SpawnedModel.java:142)
18:01:55 [SEVERE] net.wizardsmine.extendizen.commands.SpawnedModelCommand.execute(SpawnedModelCommand.java:205)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.commands.CommandExecuter.execute(CommandExecuter.java:168)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptEngine.revolve(ScriptEngine.java:70)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptQueue.revolve(ScriptQueue.java:670)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue.access$000(TimedQueue.java:12)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue$1.run(TimedQueue.java:164)
18:01:55 [SEVERE] net.aufdemrand.denizencore.utilities.scheduling.RepeatingSchedulable.tick(RepeatingSchedulable.java:20)
18:01:55 [SEVERE] net.aufdemrand.denizencore.DenizenCore.tick(DenizenCore.java:155)
18:01:55 [SEVERE] net.aufdemrand.denizen.Denizen$6.run(Denizen.java:924)
18:01:55 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftTask.run(CraftTask.java:63)
18:01:55 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftScheduler.mainThreadHeartbeat(CraftScheduler.java:423)
18:01:55 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.D(MinecraftServer.java:840)
18:01:55 [SEVERE] net.minecraft.server.v1_12_R1.DedicatedServer.D(DedicatedServer.java:423)
18:01:55 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.C(MinecraftServer.java:774)
18:01:55 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.run(MinecraftServer.java:666)
18:01:55 [SEVERE] java.lang.Thread.run(Thread.java:748)
18:01:55 [INFO] +> [Denizen] (Attempted: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>")
18:01:55 [INFO] +---------------------+
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "!contains"
"walk"
18:01:55 [INFO] +- Executing dCommand: IF ---------+
18:01:55 [INFO] +> Executing 'IF': use_braces='true'
18:01:55 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:55 [INFO] Logic='NEGATIVE', Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='false'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[loop_index]>" ">=" "<def[timeout]>"
18:01:55 [INFO] +- Executing dCommand: IF ---------+
18:01:55 [INFO] +> Executing 'IF': use_braces='true'
18:01:55 [INFO] Filled tag <def[loop_index]> with '9'.
18:01:55 [INFO] Filled tag <def[timeout]> with '100'.
18:01:55 [INFO] Comparable='Decimal(9.0)', Operator='OR_MORE', ComparedTo='Decimal(100.0)' --> OUTCOME='false'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WAIT "0.5t"
18:01:55 [INFO] +- Executing dCommand: WAIT ---------+
18:01:55 [INFO] +> Executing 'WAIT': queue='PHENEX_TRY_APPROACH_EscortFilteringOccasional' delay='d@0.025s'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "contains" "walk"
18:01:55 [INFO] +- Executing dCommand: IF ---------+
18:01:55 [INFO] +> Executing 'IF': use_braces='true'
18:01:55 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:55 [INFO] Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='true'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: ANIMATEMODEL "pause" "uuid:<def[phenex].uuid>"
"animation:walk"
18:01:55 [INFO] +- Executing dCommand: ANIMATEMODEL ---------+
18:01:55 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:55 [INFO] +> Executing 'ANIMATEMODEL': action='pause' animation='walk' uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WHILE " CALLBACK"
18:01:55 [INFO] Filled tag <def[target].location> with
'l@1069.4629491955216,23.697602721189526,702.8434583785518,2.220636,141.49217,storyworld'.
18:01:55 [INFO] Filled tag <def[distance]> with '3'.
18:01:55 [INFO] Filled tag
<def[phenex].location.distance[l@1069.4629491955216,23.697602721189526,702.8434583785518,2.220636,141.49217,storyworld].is[more].than[3]>
with 'true'.
18:01:55 [INFO] +- While loop 10 ---------+
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>"
18:01:55 [INFO] +- Executing dCommand: SPAWNEDMODEL ---------+
18:01:55 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:55 [INFO] Filled tag <def[target].location> with
'l@1069.4629491955216,23.697602721189526,702.8434583785518,2.220636,141.49217,storyworld'.
18:01:55 [INFO] Filled tag
<def[phenex].location.face[l@1069.4629491955216,23.697602721189526,702.8434583785518,2.220636,141.49217,storyworld].direction.vector.div[5]>
with 'l@0.13801184351988863,0.026341903219237874,0.14233353499098547,storyworld'.
18:01:55 [INFO] Filled tag <def[target].eye_location> with
'l@1069.4629491955216,25.317602725957897,702.8434583785518,2.220636,141.49217,storyworld'.
18:01:55 [INFO] Filled tag
<def[phenex].location.add[l@0.13801184351988863,0.026341903219237874,0.14233353499098547,storyworld].face[l@1069.4629491955216,25.317602725957897,702.8434583785518,2.220636,141.49217,storyworld]>
with 'l@1066.138520168346,23.06307909564092,699.4149298359819,-25.271492,315.88318,storyworld'.
18:01:55 [INFO] +> Executing 'SPAWNEDMODEL': action='teleport'
location='l@1066.138520168346,23.06307909564092,699.4149298359819,-25.271492,315.88318,storyworld'
uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:55 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Woah!! An exception has been called with this command (while executing it)!
18:01:55 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Internal exception was thrown!
18:01:55 [SEVERE] java.lang.NullPointerException
18:01:55 [SEVERE] net.wizardsmine.extendizen.models.SpawnedModel.teleport(SpawnedModel.java:142)
18:01:55 [SEVERE] net.wizardsmine.extendizen.commands.SpawnedModelCommand.execute(SpawnedModelCommand.java:205)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.commands.CommandExecuter.execute(CommandExecuter.java:168)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptEngine.revolve(ScriptEngine.java:70)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptQueue.revolve(ScriptQueue.java:670)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue.access$000(TimedQueue.java:12)
18:01:55 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue$1.run(TimedQueue.java:164)
18:01:55 [SEVERE] net.aufdemrand.denizencore.utilities.scheduling.RepeatingSchedulable.tick(RepeatingSchedulable.java:20)
18:01:55 [SEVERE] net.aufdemrand.denizencore.DenizenCore.tick(DenizenCore.java:155)
18:01:55 [SEVERE] net.aufdemrand.denizen.Denizen$6.run(Denizen.java:924)
18:01:55 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftTask.run(CraftTask.java:63)
18:01:55 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftScheduler.mainThreadHeartbeat(CraftScheduler.java:423)
18:01:55 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.D(MinecraftServer.java:840)
18:01:55 [SEVERE] net.minecraft.server.v1_12_R1.DedicatedServer.D(DedicatedServer.java:423)
18:01:55 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.C(MinecraftServer.java:774)
18:01:55 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.run(MinecraftServer.java:666)
18:01:55 [SEVERE] java.lang.Thread.run(Thread.java:748)
18:01:55 [INFO] +> [Denizen] (Attempted: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>")
18:01:55 [INFO] +---------------------+
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "!contains"
"walk"
18:01:55 [INFO] +- Executing dCommand: IF ---------+
18:01:55 [INFO] +> Executing 'IF': use_braces='true'
18:01:55 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:55 [INFO] Logic='NEGATIVE', Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='false'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[loop_index]>" ">=" "<def[timeout]>"
18:01:55 [INFO] +- Executing dCommand: IF ---------+
18:01:55 [INFO] +> Executing 'IF': use_braces='true'
18:01:55 [INFO] Filled tag <def[loop_index]> with '10'.
18:01:55 [INFO] Filled tag <def[timeout]> with '100'.
18:01:55 [INFO] Comparable='Decimal(10.0)', Operator='OR_MORE', ComparedTo='Decimal(100.0)' --> OUTCOME='false'
18:01:55 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WAIT "0.5t"
18:01:55 [INFO] +- Executing dCommand: WAIT ---------+
18:01:55 [INFO] +> Executing 'WAIT': queue='PHENEX_TRY_APPROACH_EscortFilteringOccasional' delay='d@0.025s'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "contains" "walk"
18:01:56 [INFO] +- Executing dCommand: IF ---------+
18:01:56 [INFO] +> Executing 'IF': use_braces='true'
18:01:56 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:56 [INFO] Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='true'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: ANIMATEMODEL "pause" "uuid:<def[phenex].uuid>"
"animation:walk"
18:01:56 [INFO] +- Executing dCommand: ANIMATEMODEL ---------+
18:01:56 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:56 [INFO] +> Executing 'ANIMATEMODEL': action='pause' animation='walk' uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WHILE " CALLBACK"
18:01:56 [INFO] Filled tag <def[target].location> with
'l@1069.5387267741435,23.697602721189526,702.9216081248524,2.220636,141.49217,storyworld'.
18:01:56 [INFO] Filled tag <def[distance]> with '3'.
18:01:56 [INFO] Filled tag
<def[phenex].location.distance[l@1069.5387267741435,23.697602721189526,702.9216081248524,2.220636,141.49217,storyworld].is[more].than[3]>
with 'true'.
18:01:56 [INFO] +- While loop 11 ---------+
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>"
18:01:56 [INFO] +- Executing dCommand: SPAWNEDMODEL ---------+
18:01:56 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:56 [INFO] Filled tag <def[target].location> with
'l@1069.5387267741435,23.697602721189526,702.9216081248524,2.220636,141.49217,storyworld'.
18:01:56 [INFO] Filled tag
<def[phenex].location.face[l@1069.5387267741435,23.697602721189526,702.9216081248524,2.220636,141.49217,storyworld].direction.vector.div[5]>
with 'l@0.13806463538492572,0.025764697055199,0.14238797997612487,storyworld'.
18:01:56 [INFO] Filled tag <def[target].eye_location> with
'l@1069.5387267741435,25.317602725957897,702.9216081248524,2.220636,141.49217,storyworld'.
18:01:56 [INFO] Filled tag
<def[phenex].location.add[l@0.13806463538492572,0.025764697055199,0.14238797997612487,storyworld].face[l@1069.5387267741435,25.317602725957897,702.9216081248524,2.220636,141.49217,storyworld]>
with 'l@1066.276584803731,23.088843792696117,699.557317815958,-25.436012,315.88318,storyworld'.
18:01:56 [INFO] +> Executing 'SPAWNEDMODEL': action='teleport'
location='l@1066.276584803731,23.088843792696117,699.557317815958,-25.436012,315.88318,storyworld'
uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:56 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Woah!! An exception has been called with this command (while executing it)!
18:01:56 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Internal exception was thrown!
18:01:56 [SEVERE] java.lang.NullPointerException
18:01:56 [SEVERE] net.wizardsmine.extendizen.models.SpawnedModel.teleport(SpawnedModel.java:142)
18:01:56 [SEVERE] net.wizardsmine.extendizen.commands.SpawnedModelCommand.execute(SpawnedModelCommand.java:205)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.commands.CommandExecuter.execute(CommandExecuter.java:168)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptEngine.revolve(ScriptEngine.java:70)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptQueue.revolve(ScriptQueue.java:670)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue.access$000(TimedQueue.java:12)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue$1.run(TimedQueue.java:164)
18:01:56 [SEVERE] net.aufdemrand.denizencore.utilities.scheduling.RepeatingSchedulable.tick(RepeatingSchedulable.java:20)
18:01:56 [SEVERE] net.aufdemrand.denizencore.DenizenCore.tick(DenizenCore.java:155)
18:01:56 [SEVERE] net.aufdemrand.denizen.Denizen$6.run(Denizen.java:924)
18:01:56 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftTask.run(CraftTask.java:63)
18:01:56 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftScheduler.mainThreadHeartbeat(CraftScheduler.java:423)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.D(MinecraftServer.java:840)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.DedicatedServer.D(DedicatedServer.java:423)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.C(MinecraftServer.java:774)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.run(MinecraftServer.java:666)
18:01:56 [SEVERE] java.lang.Thread.run(Thread.java:748)
18:01:56 [INFO] +> [Denizen] (Attempted: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>")
18:01:56 [INFO] +---------------------+
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "!contains"
"walk"
18:01:56 [INFO] +- Executing dCommand: IF ---------+
18:01:56 [INFO] +> Executing 'IF': use_braces='true'
18:01:56 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:56 [INFO] Logic='NEGATIVE', Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='false'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[loop_index]>" ">=" "<def[timeout]>"
18:01:56 [INFO] +- Executing dCommand: IF ---------+
18:01:56 [INFO] +> Executing 'IF': use_braces='true'
18:01:56 [INFO] Filled tag <def[loop_index]> with '11'.
18:01:56 [INFO] Filled tag <def[timeout]> with '100'.
18:01:56 [INFO] Comparable='Decimal(11.0)', Operator='OR_MORE', ComparedTo='Decimal(100.0)' --> OUTCOME='false'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WAIT "0.5t"
18:01:56 [INFO] +- Executing dCommand: WAIT ---------+
18:01:56 [INFO] +> Executing 'WAIT': queue='PHENEX_TRY_APPROACH_EscortFilteringOccasional' delay='d@0.025s'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "contains" "walk"
18:01:56 [INFO] +- Executing dCommand: IF ---------+
18:01:56 [INFO] +> Executing 'IF': use_braces='true'
18:01:56 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:56 [INFO] Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='true'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: ANIMATEMODEL "pause" "uuid:<def[phenex].uuid>"
"animation:walk"
18:01:56 [INFO] +- Executing dCommand: ANIMATEMODEL ---------+
18:01:56 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:56 [INFO] +> Executing 'ANIMATEMODEL': action='pause' animation='walk' uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WHILE " CALLBACK"
18:01:56 [INFO] Filled tag <def[target].location> with
'l@1069.6014781906172,23.697602721189526,702.986323933494,2.220636,141.49217,storyworld'.
18:01:56 [INFO] Filled tag <def[distance]> with '3'.
18:01:56 [INFO] Filled tag
<def[phenex].location.distance[l@1069.6014781906172,23.697602721189526,702.986323933494,2.220636,141.49217,storyworld].is[more].than[3]>
with 'true'.
18:01:56 [INFO] +- While loop 12 ---------+
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>"
18:01:56 [INFO] +- Executing dCommand: SPAWNEDMODEL ---------+
18:01:56 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:56 [INFO] Filled tag <def[target].location> with
'l@1069.6014781906172,23.697602721189526,702.986323933494,2.220636,141.49217,storyworld'.
18:01:56 [INFO] Filled tag
<def[phenex].location.face[l@1069.6014781906172,23.697602721189526,702.986323933494,2.220636,141.49217,storyworld].direction.vector.div[5]>
with 'l@0.13810748970078113,0.025286290027711697,0.1424321762284881,storyworld'.
18:01:56 [INFO] Filled tag <def[target].eye_location> with
'l@1069.6014781906172,25.317602725957897,702.986323933494,2.220636,141.49217,storyworld'.
18:01:56 [INFO] Filled tag
<def[phenex].location.add[l@0.13810748970078113,0.025286290027711697,0.1424321762284881,storyworld].face[l@1069.6014781906172,25.317602725957897,702.986323933494,2.220636,141.49217,storyworld]>
with 'l@1066.414692293432,23.11413008272383,699.6997499921864,-25.702827,315.88315,storyworld'.
18:01:56 [INFO] +> Executing 'SPAWNEDMODEL': action='teleport'
location='l@1066.414692293432,23.11413008272383,699.6997499921864,-25.702827,315.88315,storyworld'
uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:56 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Woah!! An exception has been called with this command (while executing it)!
18:01:56 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Internal exception was thrown!
18:01:56 [SEVERE] java.lang.NullPointerException
18:01:56 [SEVERE] net.wizardsmine.extendizen.models.SpawnedModel.teleport(SpawnedModel.java:142)
18:01:56 [SEVERE] net.wizardsmine.extendizen.commands.SpawnedModelCommand.execute(SpawnedModelCommand.java:205)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.commands.CommandExecuter.execute(CommandExecuter.java:168)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptEngine.revolve(ScriptEngine.java:70)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptQueue.revolve(ScriptQueue.java:670)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue.access$000(TimedQueue.java:12)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue$1.run(TimedQueue.java:164)
18:01:56 [SEVERE] net.aufdemrand.denizencore.utilities.scheduling.RepeatingSchedulable.tick(RepeatingSchedulable.java:20)
18:01:56 [SEVERE] net.aufdemrand.denizencore.DenizenCore.tick(DenizenCore.java:155)
18:01:56 [SEVERE] net.aufdemrand.denizen.Denizen$6.run(Denizen.java:924)
18:01:56 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftTask.run(CraftTask.java:63)
18:01:56 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftScheduler.mainThreadHeartbeat(CraftScheduler.java:423)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.D(MinecraftServer.java:840)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.DedicatedServer.D(DedicatedServer.java:423)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.C(MinecraftServer.java:774)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.run(MinecraftServer.java:666)
18:01:56 [SEVERE] java.lang.Thread.run(Thread.java:748)
18:01:56 [INFO] +> [Denizen] (Attempted: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>")
18:01:56 [INFO] +---------------------+
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "!contains"
"walk"
18:01:56 [INFO] +- Executing dCommand: IF ---------+
18:01:56 [INFO] +> Executing 'IF': use_braces='true'
18:01:56 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:56 [INFO] Logic='NEGATIVE', Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='false'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[loop_index]>" ">=" "<def[timeout]>"
18:01:56 [INFO] +- Executing dCommand: IF ---------+
18:01:56 [INFO] +> Executing 'IF': use_braces='true'
18:01:56 [INFO] Filled tag <def[loop_index]> with '12'.
18:01:56 [INFO] Filled tag <def[timeout]> with '100'.
18:01:56 [INFO] Comparable='Decimal(12.0)', Operator='OR_MORE', ComparedTo='Decimal(100.0)' --> OUTCOME='false'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WAIT "0.5t"
18:01:56 [INFO] +- Executing dCommand: WAIT ---------+
18:01:56 [INFO] +> Executing 'WAIT': queue='PHENEX_TRY_APPROACH_EscortFilteringOccasional' delay='d@0.025s'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "contains" "walk"
18:01:56 [INFO] +- Executing dCommand: IF ---------+
18:01:56 [INFO] +> Executing 'IF': use_braces='true'
18:01:56 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:56 [INFO] Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='true'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: ANIMATEMODEL "pause" "uuid:<def[phenex].uuid>"
"animation:walk"
18:01:56 [INFO] +- Executing dCommand: ANIMATEMODEL ---------+
18:01:56 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:56 [INFO] +> Executing 'ANIMATEMODEL': action='pause' animation='walk' uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WHILE " CALLBACK"
18:01:56 [INFO] Filled tag <def[target].location> with
'l@1069.675972360832,23.697602721189526,703.063150095124,2.220636,141.49217,storyworld'.
18:01:56 [INFO] Filled tag <def[distance]> with '3'.
18:01:56 [INFO] Filled tag
<def[phenex].location.distance[l@1069.675972360832,23.697602721189526,703.063150095124,2.220636,141.49217,storyworld].is[more].than[3]>
with 'true'.
18:01:56 [INFO] +- While loop 13 ---------+
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>"
18:01:56 [INFO] +- Executing dCommand: SPAWNEDMODEL ---------+
18:01:56 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:56 [INFO] Filled tag <def[target].location> with
'l@1069.675972360832,23.697602721189526,703.063150095124,2.220636,141.49217,storyworld'.
18:01:56 [INFO] Filled tag
<def[phenex].location.face[l@1069.675972360832,23.697602721189526,703.063150095124,2.220636,141.49217,storyworld].direction.vector.div[5]>
with 'l@0.1381574437837819,0.02471762089317104,0.1424835427146329,storyworld'.
18:01:56 [INFO] Filled tag <def[target].eye_location> with
'l@1069.675972360832,25.317602725957897,703.063150095124,2.220636,141.49217,storyworld'.
18:01:56 [INFO] Filled tag
<def[phenex].location.add[l@0.1381574437837819,0.02471762089317104,0.1424835427146329,storyworld].face[l@1069.675972360832,25.317602725957897,703.063150095124,2.220636,141.49217,storyworld]>
with 'l@1066.5528497372156,23.138847703617,699.8422335349011,-25.902626,315.88315,storyworld'.
18:01:56 [INFO] +> Executing 'SPAWNEDMODEL': action='teleport'
location='l@1066.5528497372156,23.138847703617,699.8422335349011,-25.902626,315.88315,storyworld'
uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:56 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Woah!! An exception has been called with this command (while executing it)!
18:01:56 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Internal exception was thrown!
18:01:56 [SEVERE] java.lang.NullPointerException
18:01:56 [SEVERE] net.wizardsmine.extendizen.models.SpawnedModel.teleport(SpawnedModel.java:142)
18:01:56 [SEVERE] net.wizardsmine.extendizen.commands.SpawnedModelCommand.execute(SpawnedModelCommand.java:205)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.commands.CommandExecuter.execute(CommandExecuter.java:168)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptEngine.revolve(ScriptEngine.java:70)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptQueue.revolve(ScriptQueue.java:670)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue.access$000(TimedQueue.java:12)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue$1.run(TimedQueue.java:164)
18:01:56 [SEVERE] net.aufdemrand.denizencore.utilities.scheduling.RepeatingSchedulable.tick(RepeatingSchedulable.java:20)
18:01:56 [SEVERE] net.aufdemrand.denizencore.DenizenCore.tick(DenizenCore.java:155)
18:01:56 [SEVERE] net.aufdemrand.denizen.Denizen$6.run(Denizen.java:924)
18:01:56 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftTask.run(CraftTask.java:63)
18:01:56 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftScheduler.mainThreadHeartbeat(CraftScheduler.java:423)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.D(MinecraftServer.java:840)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.DedicatedServer.D(DedicatedServer.java:423)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.C(MinecraftServer.java:774)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.run(MinecraftServer.java:666)
18:01:56 [SEVERE] java.lang.Thread.run(Thread.java:748)
18:01:56 [INFO] +> [Denizen] (Attempted: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>")
18:01:56 [INFO] +---------------------+
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "!contains"
"walk"
18:01:56 [INFO] +- Executing dCommand: IF ---------+
18:01:56 [INFO] +> Executing 'IF': use_braces='true'
18:01:56 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:56 [INFO] Logic='NEGATIVE', Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='false'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[loop_index]>" ">=" "<def[timeout]>"
18:01:56 [INFO] +- Executing dCommand: IF ---------+
18:01:56 [INFO] +> Executing 'IF': use_braces='true'
18:01:56 [INFO] Filled tag <def[loop_index]> with '13'.
18:01:56 [INFO] Filled tag <def[timeout]> with '100'.
18:01:56 [INFO] Comparable='Decimal(13.0)', Operator='OR_MORE', ComparedTo='Decimal(100.0)' --> OUTCOME='false'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WAIT "0.5t"
18:01:56 [INFO] +- Executing dCommand: WAIT ---------+
18:01:56 [INFO] +> Executing 'WAIT': queue='PHENEX_TRY_APPROACH_EscortFilteringOccasional' delay='d@0.025s'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "contains" "walk"
18:01:56 [INFO] +- Executing dCommand: IF ---------+
18:01:56 [INFO] +> Executing 'IF': use_braces='true'
18:01:56 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:56 [INFO] Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='true'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: ANIMATEMODEL "pause" "uuid:<def[phenex].uuid>"
"animation:walk"
18:01:56 [INFO] +- Executing dCommand: ANIMATEMODEL ---------+
18:01:56 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:56 [INFO] +> Executing 'ANIMATEMODEL': action='pause' animation='walk' uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WHILE " CALLBACK"
18:01:56 [INFO] Filled tag <def[target].location> with
'l@1069.7151312675048,23.697602721189526,703.103534845832,2.220636,141.49217,storyworld'.
18:01:56 [INFO] Filled tag <def[distance]> with '3'.
18:01:56 [INFO] Filled tag
<def[phenex].location.distance[l@1069.7151312675048,23.697602721189526,703.103534845832,2.220636,141.49217,storyworld].is[more].than[3]>
with 'true'.
18:01:56 [INFO] +- While loop 14 ---------+
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>"
18:01:56 [INFO] +- Executing dCommand: SPAWNEDMODEL ---------+
18:01:56 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:56 [INFO] Filled tag <def[target].location> with
'l@1069.7151312675048,23.697602721189526,703.103534845832,2.220636,141.49217,storyworld'.
18:01:56 [INFO] Filled tag
<def[phenex].location.face[l@1069.7151312675048,23.697602721189526,703.103534845832,2.220636,141.49217,storyworld].direction.vector.div[5]>
with 'l@0.1381834199782518,0.02441613465977341,0.14251033229695978,storyworld'.
18:01:56 [INFO] Filled tag <def[target].eye_location> with
'l@1069.7151312675048,25.317602725957897,703.103534845832,2.220636,141.49217,storyworld'.
18:01:56 [INFO] Filled tag
<def[phenex].location.add[l@0.1381834199782518,0.02441613465977341,0.14251033229695978,storyworld].face[l@1069.7151312675048,25.317602725957897,703.103534845832,2.220636,141.49217,storyworld]>
with 'l@1066.691033157194,23.163263838276773,699.9847438671981,-26.377373,315.88315,storyworld'.
18:01:56 [INFO] +> Executing 'SPAWNEDMODEL': action='teleport'
location='l@1066.691033157194,23.163263838276773,699.9847438671981,-26.377373,315.88315,storyworld'
uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:56 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Woah!! An exception has been called with this command (while executing it)!
18:01:56 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Internal exception was thrown!
18:01:56 [SEVERE] java.lang.NullPointerException
18:01:56 [SEVERE] net.wizardsmine.extendizen.models.SpawnedModel.teleport(SpawnedModel.java:142)
18:01:56 [SEVERE] net.wizardsmine.extendizen.commands.SpawnedModelCommand.execute(SpawnedModelCommand.java:205)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.commands.CommandExecuter.execute(CommandExecuter.java:168)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptEngine.revolve(ScriptEngine.java:70)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptQueue.revolve(ScriptQueue.java:670)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue.access$000(TimedQueue.java:12)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue$1.run(TimedQueue.java:164)
18:01:56 [SEVERE] net.aufdemrand.denizencore.utilities.scheduling.RepeatingSchedulable.tick(RepeatingSchedulable.java:20)
18:01:56 [SEVERE] net.aufdemrand.denizencore.DenizenCore.tick(DenizenCore.java:155)
18:01:56 [SEVERE] net.aufdemrand.denizen.Denizen$6.run(Denizen.java:924)
18:01:56 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftTask.run(CraftTask.java:63)
18:01:56 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftScheduler.mainThreadHeartbeat(CraftScheduler.java:423)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.D(MinecraftServer.java:840)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.DedicatedServer.D(DedicatedServer.java:423)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.C(MinecraftServer.java:774)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.run(MinecraftServer.java:666)
18:01:56 [SEVERE] java.lang.Thread.run(Thread.java:748)
18:01:56 [INFO] +> [Denizen] (Attempted: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>")
18:01:56 [INFO] +---------------------+
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "!contains"
"walk"
18:01:56 [INFO] +- Executing dCommand: IF ---------+
18:01:56 [INFO] +> Executing 'IF': use_braces='true'
18:01:56 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:56 [INFO] Logic='NEGATIVE', Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='false'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[loop_index]>" ">=" "<def[timeout]>"
18:01:56 [INFO] +- Executing dCommand: IF ---------+
18:01:56 [INFO] +> Executing 'IF': use_braces='true'
18:01:56 [INFO] Filled tag <def[loop_index]> with '14'.
18:01:56 [INFO] Filled tag <def[timeout]> with '100'.
18:01:56 [INFO] Comparable='Decimal(14.0)', Operator='OR_MORE', ComparedTo='Decimal(100.0)' --> OUTCOME='false'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WAIT "0.5t"
18:01:56 [INFO] +- Executing dCommand: WAIT ---------+
18:01:56 [INFO] +> Executing 'WAIT': queue='PHENEX_TRY_APPROACH_EscortFilteringOccasional' delay='d@0.025s'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "contains" "walk"
18:01:56 [INFO] +- Executing dCommand: IF ---------+
18:01:56 [INFO] +> Executing 'IF': use_braces='true'
18:01:56 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:56 [INFO] Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='true'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: ANIMATEMODEL "pause" "uuid:<def[phenex].uuid>"
"animation:walk"
18:01:56 [INFO] +- Executing dCommand: ANIMATEMODEL ---------+
18:01:56 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:56 [INFO] +> Executing 'ANIMATEMODEL': action='pause' animation='walk' uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WHILE " CALLBACK"
18:01:56 [INFO] Filled tag <def[target].location> with
'l@1069.74755875999,23.697602721189526,703.1369774598207,2.220636,141.49217,storyworld'.
18:01:56 [INFO] Filled tag <def[distance]> with '3'.
18:01:56 [INFO] Filled tag
<def[phenex].location.distance[l@1069.74755875999,23.697602721189526,703.1369774598207,2.220636,141.49217,storyworld].is[more].than[3]>
with 'true'.
18:01:56 [INFO] +- While loop 15 ---------+
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>"
18:01:56 [INFO] +- Executing dCommand: SPAWNEDMODEL ---------+
18:01:56 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:56 [INFO] Filled tag <def[target].location> with
'l@1069.74755875999,23.697602721189526,703.1369774598207,2.220636,141.49217,storyworld'.
18:01:56 [INFO] Filled tag
<def[phenex].location.face[l@1069.74755875999,23.697602721189526,703.1369774598207,2.220636,141.49217,storyworld].direction.vector.div[5]>
with 'l@0.13820515961123278,0.024160883184363314,0.14253275265911772,storyworld'.
18:01:56 [INFO] Filled tag <def[target].eye_location> with
'l@1069.74755875999,25.317602725957897,703.1369774598207,2.220636,141.49217,storyworld'.
18:01:56 [INFO] Filled tag
<def[phenex].location.add[l@0.13820515961123278,0.024160883184363314,0.14253275265911772,storyworld].face[l@1069.74755875999,25.317602725957897,703.1369774598207,2.220636,141.49217,storyworld]>
with 'l@1066.8292383168052,23.187424721461138,700.1272766198572,-26.93621,315.88315,storyworld'.
18:01:56 [INFO] +> Executing 'SPAWNEDMODEL': action='teleport'
location='l@1066.8292383168052,23.187424721461138,700.1272766198572,-26.93621,315.88315,storyworld'
uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:56 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Woah!! An exception has been called with this command (while executing it)!
18:01:56 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Internal exception was thrown!
18:01:56 [SEVERE] java.lang.NullPointerException
18:01:56 [SEVERE] net.wizardsmine.extendizen.models.SpawnedModel.teleport(SpawnedModel.java:142)
18:01:56 [SEVERE] net.wizardsmine.extendizen.commands.SpawnedModelCommand.execute(SpawnedModelCommand.java:205)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.commands.CommandExecuter.execute(CommandExecuter.java:168)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptEngine.revolve(ScriptEngine.java:70)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptQueue.revolve(ScriptQueue.java:670)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue.access$000(TimedQueue.java:12)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue$1.run(TimedQueue.java:164)
18:01:56 [SEVERE] net.aufdemrand.denizencore.utilities.scheduling.RepeatingSchedulable.tick(RepeatingSchedulable.java:20)
18:01:56 [SEVERE] net.aufdemrand.denizencore.DenizenCore.tick(DenizenCore.java:155)
18:01:56 [SEVERE] net.aufdemrand.denizen.Denizen$6.run(Denizen.java:924)
18:01:56 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftTask.run(CraftTask.java:63)
18:01:56 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftScheduler.mainThreadHeartbeat(CraftScheduler.java:423)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.D(MinecraftServer.java:840)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.DedicatedServer.D(DedicatedServer.java:423)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.C(MinecraftServer.java:774)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.run(MinecraftServer.java:666)
18:01:56 [SEVERE] java.lang.Thread.run(Thread.java:748)
18:01:56 [INFO] +> [Denizen] (Attempted: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>")
18:01:56 [INFO] +---------------------+
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "!contains"
"walk"
18:01:56 [INFO] +- Executing dCommand: IF ---------+
18:01:56 [INFO] +> Executing 'IF': use_braces='true'
18:01:56 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:56 [INFO] Logic='NEGATIVE', Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='false'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[loop_index]>" ">=" "<def[timeout]>"
18:01:56 [INFO] +- Executing dCommand: IF ---------+
18:01:56 [INFO] +> Executing 'IF': use_braces='true'
18:01:56 [INFO] Filled tag <def[loop_index]> with '15'.
18:01:56 [INFO] Filled tag <def[timeout]> with '100'.
18:01:56 [INFO] Comparable='Decimal(15.0)', Operator='OR_MORE', ComparedTo='Decimal(100.0)' --> OUTCOME='false'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WAIT "0.5t"
18:01:56 [INFO] +- Executing dCommand: WAIT ---------+
18:01:56 [INFO] +> Executing 'WAIT': queue='PHENEX_TRY_APPROACH_EscortFilteringOccasional' delay='d@0.025s'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "contains" "walk"
18:01:56 [INFO] +- Executing dCommand: IF ---------+
18:01:56 [INFO] +> Executing 'IF': use_braces='true'
18:01:56 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:56 [INFO] Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='true'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: ANIMATEMODEL "pause" "uuid:<def[phenex].uuid>"
"animation:walk"
18:01:56 [INFO] +- Executing dCommand: ANIMATEMODEL ---------+
18:01:56 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:56 [INFO] +> Executing 'ANIMATEMODEL': action='pause' animation='walk' uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WHILE " CALLBACK"
18:01:56 [INFO] Filled tag <def[target].location> with
'l@1069.7744119680647,23.697602721189526,703.1646712900612,2.220636,141.49217,storyworld'.
18:01:56 [INFO] Filled tag <def[distance]> with '3'.
18:01:56 [INFO] Filled tag
<def[phenex].location.distance[l@1069.7744119680647,23.697602721189526,703.1646712900612,2.220636,141.49217,storyworld].is[more].than[3]>
with 'true'.
18:01:56 [INFO] +- While loop 16 ---------+
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>"
18:01:56 [INFO] +- Executing dCommand: SPAWNEDMODEL ---------+
18:01:56 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:56 [INFO] Filled tag <def[target].location> with
'l@1069.7744119680647,23.697602721189526,703.1646712900612,2.220636,141.49217,storyworld'.
18:01:56 [INFO] Filled tag
<def[phenex].location.face[l@1069.7744119680647,23.697602721189526,703.1646712900612,2.220636,141.49217,storyworld].direction.vector.div[5]>
with 'l@0.1382234684216652,0.023943771672071706,0.14255163477000404,storyworld'.
18:01:56 [INFO] Filled tag <def[target].eye_location> with
'l@1069.7744119680647,25.317602725957897,703.1646712900612,2.220636,141.49217,storyworld'.
18:01:56 [INFO] Filled tag
<def[phenex].location.add[l@0.1382234684216652,0.023943771672071706,0.14255163477000404,storyworld].face[l@1069.7744119680647,25.317602725957897,703.1646712900612,2.220636,141.49217,storyworld]>
with 'l@1066.967461785227,23.21136849313321,700.2698282546272,-27.580154,315.88315,storyworld'.
18:01:56 [INFO] +> Executing 'SPAWNEDMODEL': action='teleport'
location='l@1066.967461785227,23.21136849313321,700.2698282546272,-27.580154,315.88315,storyworld'
uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:56 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Woah!! An exception has been called with this command (while executing it)!
18:01:56 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Internal exception was thrown!
18:01:56 [SEVERE] java.lang.NullPointerException
18:01:56 [SEVERE] net.wizardsmine.extendizen.models.SpawnedModel.teleport(SpawnedModel.java:142)
18:01:56 [SEVERE] net.wizardsmine.extendizen.commands.SpawnedModelCommand.execute(SpawnedModelCommand.java:205)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.commands.CommandExecuter.execute(CommandExecuter.java:168)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptEngine.revolve(ScriptEngine.java:70)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptQueue.revolve(ScriptQueue.java:670)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue.access$000(TimedQueue.java:12)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue$1.run(TimedQueue.java:164)
18:01:56 [SEVERE] net.aufdemrand.denizencore.utilities.scheduling.RepeatingSchedulable.tick(RepeatingSchedulable.java:20)
18:01:56 [SEVERE] net.aufdemrand.denizencore.DenizenCore.tick(DenizenCore.java:155)
18:01:56 [SEVERE] net.aufdemrand.denizen.Denizen$6.run(Denizen.java:924)
18:01:56 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftTask.run(CraftTask.java:63)
18:01:56 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftScheduler.mainThreadHeartbeat(CraftScheduler.java:423)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.D(MinecraftServer.java:840)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.DedicatedServer.D(DedicatedServer.java:423)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.C(MinecraftServer.java:774)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.run(MinecraftServer.java:666)
18:01:56 [SEVERE] java.lang.Thread.run(Thread.java:748)
18:01:56 [INFO] +> [Denizen] (Attempted: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>")
18:01:56 [INFO] +---------------------+
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "!contains"
"walk"
18:01:56 [INFO] +- Executing dCommand: IF ---------+
18:01:56 [INFO] +> Executing 'IF': use_braces='true'
18:01:56 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:56 [INFO] Logic='NEGATIVE', Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='false'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[loop_index]>" ">=" "<def[timeout]>"
18:01:56 [INFO] +- Executing dCommand: IF ---------+
18:01:56 [INFO] +> Executing 'IF': use_braces='true'
18:01:56 [INFO] Filled tag <def[loop_index]> with '16'.
18:01:56 [INFO] Filled tag <def[timeout]> with '100'.
18:01:56 [INFO] Comparable='Decimal(16.0)', Operator='OR_MORE', ComparedTo='Decimal(100.0)' --> OUTCOME='false'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WAIT "0.5t"
18:01:56 [INFO] +- Executing dCommand: WAIT ---------+
18:01:56 [INFO] +> Executing 'WAIT': queue='PHENEX_TRY_APPROACH_EscortFilteringOccasional' delay='d@0.025s'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "contains" "walk"
18:01:56 [INFO] +- Executing dCommand: IF ---------+
18:01:56 [INFO] +> Executing 'IF': use_braces='true'
18:01:56 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:56 [INFO] Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='true'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: ANIMATEMODEL "pause" "uuid:<def[phenex].uuid>"
"animation:walk"
18:01:56 [INFO] +- Executing dCommand: ANIMATEMODEL ---------+
18:01:56 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:56 [INFO] +> Executing 'ANIMATEMODEL': action='pause' animation='walk' uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WHILE " CALLBACK"
18:01:56 [INFO] Filled tag <def[target].location> with
'l@1069.796649110953,23.697602721189526,703.1876045522051,2.220636,141.49217,storyworld'.
18:01:56 [INFO] Filled tag <def[distance]> with '3'.
18:01:56 [INFO] Filled tag
<def[phenex].location.distance[l@1069.796649110953,23.697602721189526,703.1876045522051,2.220636,141.49217,storyworld].is[more].than[3]>
with 'true'.
18:01:56 [INFO] +- While loop 17 ---------+
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>"
18:01:56 [INFO] +- Executing dCommand: SPAWNEDMODEL ---------+
18:01:56 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:56 [INFO] Filled tag <def[target].location> with
'l@1069.796649110953,23.697602721189526,703.1876045522051,2.220636,141.49217,storyworld'.
18:01:56 [INFO] Filled tag
<def[phenex].location.face[l@1069.796649110953,23.697602721189526,703.1876045522051,2.220636,141.49217,storyworld].direction.vector.div[5]>
with 'l@0.1382390557403019,0.023758257705348496,0.14256755822709444,storyworld'.
18:01:56 [INFO] Filled tag <def[target].eye_location> with
'l@1069.796649110953,25.317602725957897,703.1876045522051,2.220636,141.49217,storyworld'.
18:01:56 [INFO] Filled tag
<def[phenex].location.add[l@0.1382390557403019,0.023758257705348496,0.14256755822709444,storyworld].face[l@1069.796649110953,25.317602725957897,703.1876045522051,2.220636,141.49217,storyworld]>
with 'l@1067.1057008409673,23.23512675083856,700.4123958128544,-28.312134,315.88315,storyworld'.
18:01:56 [INFO] +> Executing 'SPAWNEDMODEL': action='teleport'
location='l@1067.1057008409673,23.23512675083856,700.4123958128544,-28.312134,315.88315,storyworld'
uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:56 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Woah!! An exception has been called with this command (while executing it)!
18:01:56 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Internal exception was thrown!
18:01:56 [SEVERE] java.lang.NullPointerException
18:01:56 [SEVERE] net.wizardsmine.extendizen.models.SpawnedModel.teleport(SpawnedModel.java:142)
18:01:56 [SEVERE] net.wizardsmine.extendizen.commands.SpawnedModelCommand.execute(SpawnedModelCommand.java:205)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.commands.CommandExecuter.execute(CommandExecuter.java:168)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptEngine.revolve(ScriptEngine.java:70)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptQueue.revolve(ScriptQueue.java:670)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue.access$000(TimedQueue.java:12)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue$1.run(TimedQueue.java:164)
18:01:56 [SEVERE] net.aufdemrand.denizencore.utilities.scheduling.RepeatingSchedulable.tick(RepeatingSchedulable.java:20)
18:01:56 [SEVERE] net.aufdemrand.denizencore.DenizenCore.tick(DenizenCore.java:155)
18:01:56 [SEVERE] net.aufdemrand.denizen.Denizen$6.run(Denizen.java:924)
18:01:56 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftTask.run(CraftTask.java:63)
18:01:56 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftScheduler.mainThreadHeartbeat(CraftScheduler.java:423)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.D(MinecraftServer.java:840)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.DedicatedServer.D(DedicatedServer.java:423)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.C(MinecraftServer.java:774)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.run(MinecraftServer.java:666)
18:01:56 [SEVERE] java.lang.Thread.run(Thread.java:748)
18:01:56 [INFO] +> [Denizen] (Attempted: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>")
18:01:56 [INFO] +---------------------+
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "!contains"
"walk"
18:01:56 [INFO] +- Executing dCommand: IF ---------+
18:01:56 [INFO] +> Executing 'IF': use_braces='true'
18:01:56 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:56 [INFO] Logic='NEGATIVE', Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='false'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[loop_index]>" ">=" "<def[timeout]>"
18:01:56 [INFO] +- Executing dCommand: IF ---------+
18:01:56 [INFO] +> Executing 'IF': use_braces='true'
18:01:56 [INFO] Filled tag <def[loop_index]> with '17'.
18:01:56 [INFO] Filled tag <def[timeout]> with '100'.
18:01:56 [INFO] Comparable='Decimal(17.0)', Operator='OR_MORE', ComparedTo='Decimal(100.0)' --> OUTCOME='false'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WAIT "0.5t"
18:01:56 [INFO] +- Executing dCommand: WAIT ---------+
18:01:56 [INFO] +> Executing 'WAIT': queue='PHENEX_TRY_APPROACH_EscortFilteringOccasional' delay='d@0.025s'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "contains" "walk"
18:01:56 [INFO] +- Executing dCommand: IF ---------+
18:01:56 [INFO] +> Executing 'IF': use_braces='true'
18:01:56 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:56 [INFO] Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='true'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: ANIMATEMODEL "pause" "uuid:<def[phenex].uuid>"
"animation:walk"
18:01:56 [INFO] +- Executing dCommand: ANIMATEMODEL ---------+
18:01:56 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:56 [INFO] +> Executing 'ANIMATEMODEL': action='pause' animation='walk' uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WHILE " CALLBACK"
18:01:56 [INFO] Filled tag <def[target].location> with
'l@1069.8230475191563,23.697602721189526,703.2148293453608,2.220636,141.49217,storyworld'.
18:01:56 [INFO] Filled tag <def[distance]> with '3'.
18:01:56 [INFO] Filled tag
<def[phenex].location.distance[l@1069.8230475191563,23.697602721189526,703.2148293453608,2.220636,141.49217,storyworld].is[more].than[3]>
with 'true'.
18:01:56 [INFO] +- While loop 18 ---------+
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>"
18:01:56 [INFO] +- Executing dCommand: SPAWNEDMODEL ---------+
18:01:56 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:56 [INFO] Filled tag <def[target].location> with
'l@1069.8230475191563,23.697602721189526,703.2148293453608,2.220636,141.49217,storyworld'.
18:01:56 [INFO] Filled tag
<def[phenex].location.face[l@1069.8230475191563,23.697602721189526,703.2148293453608,2.220636,141.49217,storyworld].direction.vector.div[5]>
with 'l@0.13825791980965715,0.02353064691475224,0.14258701296289109,storyworld'.
18:01:56 [INFO] Filled tag <def[target].eye_location> with
'l@1069.8230475191563,25.317602725957897,703.2148293453608,2.220636,141.49217,storyworld'.
18:01:56 [INFO] Filled tag
<def[phenex].location.add[l@0.13825791980965715,0.02353064691475224,0.14258701296289109,storyworld].face[l@1069.8230475191563,25.317602725957897,703.2148293453608,2.220636,141.49217,storyworld]>
with 'l@1067.2439587607769,23.258657397753314,700.5549828258172,-29.062317,315.88312,storyworld'.
18:01:56 [INFO] +> Executing 'SPAWNEDMODEL': action='teleport'
location='l@1067.2439587607769,23.258657397753314,700.5549828258172,-29.062317,315.88312,storyworld'
uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:56 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Woah!! An exception has been called with this command (while executing it)!
18:01:56 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Internal exception was thrown!
18:01:56 [SEVERE] java.lang.NullPointerException
18:01:56 [SEVERE] net.wizardsmine.extendizen.models.SpawnedModel.teleport(SpawnedModel.java:142)
18:01:56 [SEVERE] net.wizardsmine.extendizen.commands.SpawnedModelCommand.execute(SpawnedModelCommand.java:205)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.commands.CommandExecuter.execute(CommandExecuter.java:168)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptEngine.revolve(ScriptEngine.java:70)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptQueue.revolve(ScriptQueue.java:670)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue.access$000(TimedQueue.java:12)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue$1.run(TimedQueue.java:164)
18:01:56 [SEVERE] net.aufdemrand.denizencore.utilities.scheduling.RepeatingSchedulable.tick(RepeatingSchedulable.java:20)
18:01:56 [SEVERE] net.aufdemrand.denizencore.DenizenCore.tick(DenizenCore.java:155)
18:01:56 [SEVERE] net.aufdemrand.denizen.Denizen$6.run(Denizen.java:924)
18:01:56 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftTask.run(CraftTask.java:63)
18:01:56 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftScheduler.mainThreadHeartbeat(CraftScheduler.java:423)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.D(MinecraftServer.java:840)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.DedicatedServer.D(DedicatedServer.java:423)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.C(MinecraftServer.java:774)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.run(MinecraftServer.java:666)
18:01:56 [SEVERE] java.lang.Thread.run(Thread.java:748)
18:01:56 [INFO] +> [Denizen] (Attempted: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>")
18:01:56 [INFO] +---------------------+
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "!contains"
"walk"
18:01:56 [INFO] +- Executing dCommand: IF ---------+
18:01:56 [INFO] +> Executing 'IF': use_braces='true'
18:01:56 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:56 [INFO] Logic='NEGATIVE', Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='false'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[loop_index]>" ">=" "<def[timeout]>"
18:01:56 [INFO] +- Executing dCommand: IF ---------+
18:01:56 [INFO] +> Executing 'IF': use_braces='true'
18:01:56 [INFO] Filled tag <def[loop_index]> with '18'.
18:01:56 [INFO] Filled tag <def[timeout]> with '100'.
18:01:56 [INFO] Comparable='Decimal(18.0)', Operator='OR_MORE', ComparedTo='Decimal(100.0)' --> OUTCOME='false'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WAIT "0.5t"
18:01:56 [INFO] +- Executing dCommand: WAIT ---------+
18:01:56 [INFO] +> Executing 'WAIT': queue='PHENEX_TRY_APPROACH_EscortFilteringOccasional' delay='d@0.025s'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "contains" "walk"
18:01:56 [INFO] +- Executing dCommand: IF ---------+
18:01:56 [INFO] +> Executing 'IF': use_braces='true'
18:01:56 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:56 [INFO] Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='true'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: ANIMATEMODEL "pause" "uuid:<def[phenex].uuid>"
"animation:walk"
18:01:56 [INFO] +- Executing dCommand: ANIMATEMODEL ---------+
18:01:56 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:56 [INFO] +> Executing 'ANIMATEMODEL': action='pause' animation='walk' uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WHILE " CALLBACK"
18:01:56 [INFO] Filled tag <def[target].location> with
'l@1069.8230475191563,23.697602721189526,703.2148293453608,2.220636,141.49217,storyworld'.
18:01:56 [INFO] Filled tag <def[distance]> with '3'.
18:01:56 [INFO] Filled tag
<def[phenex].location.distance[l@1069.8230475191563,23.697602721189526,703.2148293453608,2.220636,141.49217,storyworld].is[more].than[3]>
with 'true'.
18:01:56 [INFO] +- While loop 19 ---------+
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>"
18:01:56 [INFO] +- Executing dCommand: SPAWNEDMODEL ---------+
18:01:56 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:56 [INFO] Filled tag <def[target].location> with
'l@1069.8230475191563,23.697602721189526,703.2148293453608,2.220636,141.49217,storyworld'.
18:01:56 [INFO] Filled tag
<def[phenex].location.face[l@1069.8230475191563,23.697602721189526,703.2148293453608,2.220636,141.49217,storyworld].direction.vector.div[5]>
with 'l@0.13825791980965715,0.02353064691475224,0.14258701296289109,storyworld'.
18:01:56 [INFO] Filled tag <def[target].eye_location> with
'l@1069.8230475191563,25.317602725957897,703.2148293453608,2.220636,141.49217,storyworld'.
18:01:56 [INFO] Filled tag
<def[phenex].location.add[l@0.13825791980965715,0.02353064691475224,0.14258701296289109,storyworld].face[l@1069.8230475191563,25.317602725957897,703.2148293453608,2.220636,141.49217,storyworld]>
with 'l@1067.3822166805865,23.282188044668068,700.69756983878,-30.135147,315.88315,storyworld'.
18:01:56 [INFO] +> Executing 'SPAWNEDMODEL': action='teleport'
location='l@1067.3822166805865,23.282188044668068,700.69756983878,-30.135147,315.88315,storyworld'
uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:56 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Woah!! An exception has been called with this command (while executing it)!
18:01:56 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Internal exception was thrown!
18:01:56 [SEVERE] java.lang.NullPointerException
18:01:56 [SEVERE] net.wizardsmine.extendizen.models.SpawnedModel.teleport(SpawnedModel.java:142)
18:01:56 [SEVERE] net.wizardsmine.extendizen.commands.SpawnedModelCommand.execute(SpawnedModelCommand.java:205)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.commands.CommandExecuter.execute(CommandExecuter.java:168)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptEngine.revolve(ScriptEngine.java:70)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptQueue.revolve(ScriptQueue.java:670)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue.access$000(TimedQueue.java:12)
18:01:56 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue$1.run(TimedQueue.java:164)
18:01:56 [SEVERE] net.aufdemrand.denizencore.utilities.scheduling.RepeatingSchedulable.tick(RepeatingSchedulable.java:20)
18:01:56 [SEVERE] net.aufdemrand.denizencore.DenizenCore.tick(DenizenCore.java:155)
18:01:56 [SEVERE] net.aufdemrand.denizen.Denizen$6.run(Denizen.java:924)
18:01:56 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftTask.run(CraftTask.java:63)
18:01:56 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftScheduler.mainThreadHeartbeat(CraftScheduler.java:423)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.D(MinecraftServer.java:840)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.DedicatedServer.D(DedicatedServer.java:423)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.C(MinecraftServer.java:774)
18:01:56 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.run(MinecraftServer.java:666)
18:01:56 [SEVERE] java.lang.Thread.run(Thread.java:748)
18:01:56 [INFO] +> [Denizen] (Attempted: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>")
18:01:56 [INFO] +---------------------+
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "!contains"
"walk"
18:01:56 [INFO] +- Executing dCommand: IF ---------+
18:01:56 [INFO] +> Executing 'IF': use_braces='true'
18:01:56 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:56 [INFO] Logic='NEGATIVE', Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='false'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[loop_index]>" ">=" "<def[timeout]>"
18:01:56 [INFO] +- Executing dCommand: IF ---------+
18:01:56 [INFO] +> Executing 'IF': use_braces='true'
18:01:56 [INFO] Filled tag <def[loop_index]> with '19'.
18:01:56 [INFO] Filled tag <def[timeout]> with '100'.
18:01:56 [INFO] Comparable='Decimal(19.0)', Operator='OR_MORE', ComparedTo='Decimal(100.0)' --> OUTCOME='false'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WAIT "0.5t"
18:01:56 [INFO] +- Executing dCommand: WAIT ---------+
18:01:56 [INFO] +> Executing 'WAIT': queue='PHENEX_TRY_APPROACH_EscortFilteringOccasional' delay='d@0.025s'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "contains" "walk"
18:01:56 [INFO] +- Executing dCommand: IF ---------+
18:01:56 [INFO] +> Executing 'IF': use_braces='true'
18:01:56 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:56 [INFO] Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='true'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: ANIMATEMODEL "pause" "uuid:<def[phenex].uuid>"
"animation:walk"
18:01:56 [INFO] +- Executing dCommand: ANIMATEMODEL ---------+
18:01:56 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:56 [INFO] +> Executing 'ANIMATEMODEL': action='pause' animation='walk' uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WHILE " CALLBACK"
18:01:56 [INFO] Filled tag <def[target].location> with
'l@1069.8230475191563,23.697602721189526,703.2148293453608,2.220636,141.49217,storyworld'.
18:01:56 [INFO] Filled tag <def[distance]> with '3'.
18:01:56 [INFO] Filled tag
<def[phenex].location.distance[l@1069.8230475191563,23.697602721189526,703.2148293453608,2.220636,141.49217,storyworld].is[more].than[3]>
with 'true'.
18:01:56 [INFO] +- While loop 20 ---------+
18:01:56 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>"
18:01:56 [INFO] +- Executing dCommand: SPAWNEDMODEL ---------+
18:01:56 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:57 [INFO] Filled tag <def[target].location> with
'l@1069.8230475191563,23.697602721189526,703.2148293453608,2.220636,141.49217,storyworld'.
18:01:57 [INFO] Filled tag
<def[phenex].location.face[l@1069.8230475191563,23.697602721189526,703.2148293453608,2.220636,141.49217,storyworld].direction.vector.div[5]>
with 'l@0.13825784386320053,0.02353064691475224,0.1425870866034934,storyworld'.
18:01:57 [INFO] Filled tag <def[target].eye_location> with
'l@1069.8230475191563,25.317602725957897,703.2148293453608,2.220636,141.49217,storyworld'.
18:01:57 [INFO] Filled tag
<def[phenex].location.add[l@0.13825784386320053,0.02353064691475224,0.1425870866034934,storyworld].face[l@1069.8230475191563,25.317602725957897,703.2148293453608,2.220636,141.49217,storyworld]>
with 'l@1067.5204745244496,23.305718691582822,700.8401569253836,-31.309708,315.88315,storyworld'.
18:01:57 [INFO] +> Executing 'SPAWNEDMODEL': action='teleport'
location='l@1067.5204745244496,23.305718691582822,700.8401569253836,-31.309708,315.88315,storyworld'
uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:57 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Woah!! An exception has been called with this command (while executing it)!
18:01:57 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Internal exception was thrown!
18:01:57 [SEVERE] java.lang.NullPointerException
18:01:57 [SEVERE] net.wizardsmine.extendizen.models.SpawnedModel.teleport(SpawnedModel.java:142)
18:01:57 [SEVERE] net.wizardsmine.extendizen.commands.SpawnedModelCommand.execute(SpawnedModelCommand.java:205)
18:01:57 [SEVERE] net.aufdemrand.denizencore.scripts.commands.CommandExecuter.execute(CommandExecuter.java:168)
18:01:57 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptEngine.revolve(ScriptEngine.java:70)
18:01:57 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptQueue.revolve(ScriptQueue.java:670)
18:01:57 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue.access$000(TimedQueue.java:12)
18:01:57 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue$1.run(TimedQueue.java:164)
18:01:57 [SEVERE] net.aufdemrand.denizencore.utilities.scheduling.RepeatingSchedulable.tick(RepeatingSchedulable.java:20)
18:01:57 [SEVERE] net.aufdemrand.denizencore.DenizenCore.tick(DenizenCore.java:155)
18:01:57 [SEVERE] net.aufdemrand.denizen.Denizen$6.run(Denizen.java:924)
18:01:57 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftTask.run(CraftTask.java:63)
18:01:57 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftScheduler.mainThreadHeartbeat(CraftScheduler.java:423)
18:01:57 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.D(MinecraftServer.java:840)
18:01:57 [SEVERE] net.minecraft.server.v1_12_R1.DedicatedServer.D(DedicatedServer.java:423)
18:01:57 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.C(MinecraftServer.java:774)
18:01:57 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.run(MinecraftServer.java:666)
18:01:57 [SEVERE] java.lang.Thread.run(Thread.java:748)
18:01:57 [INFO] +> [Denizen] (Attempted: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>")
18:01:57 [INFO] +---------------------+
18:01:57 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "!contains"
"walk"
18:01:57 [INFO] +- Executing dCommand: IF ---------+
18:01:57 [INFO] +> Executing 'IF': use_braces='true'
18:01:57 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:57 [INFO] Logic='NEGATIVE', Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='false'
18:01:57 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[loop_index]>" ">=" "<def[timeout]>"
18:01:57 [INFO] +- Executing dCommand: IF ---------+
18:01:57 [INFO] +> Executing 'IF': use_braces='true'
18:01:57 [INFO] Filled tag <def[loop_index]> with '20'.
18:01:57 [INFO] Filled tag <def[timeout]> with '100'.
18:01:57 [INFO] Comparable='Decimal(20.0)', Operator='OR_MORE', ComparedTo='Decimal(100.0)' --> OUTCOME='false'
18:01:57 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WAIT "0.5t"
18:01:57 [INFO] +- Executing dCommand: WAIT ---------+
18:01:57 [INFO] +> Executing 'WAIT': queue='PHENEX_TRY_APPROACH_EscortFilteringOccasional' delay='d@0.025s'
18:01:57 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "contains" "walk"
18:01:57 [INFO] +- Executing dCommand: IF ---------+
18:01:57 [INFO] +> Executing 'IF': use_braces='true'
18:01:57 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:57 [INFO] Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='true'
18:01:57 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: ANIMATEMODEL "pause" "uuid:<def[phenex].uuid>"
"animation:walk"
18:01:57 [INFO] +- Executing dCommand: ANIMATEMODEL ---------+
18:01:57 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:57 [INFO] +> Executing 'ANIMATEMODEL': action='pause' animation='walk' uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:57 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WHILE " CALLBACK"
18:01:57 [INFO] Filled tag <def[target].location> with
'l@1069.8484155040783,23.697602721189526,703.2409914585065,2.220636,141.49217,storyworld'.
18:01:57 [INFO] Filled tag <def[distance]> with '3'.
18:01:57 [INFO] Filled tag
<def[phenex].location.distance[l@1069.8484155040783,23.697602721189526,703.2409914585065,2.220636,141.49217,storyworld].is[more].than[3]>
with 'true'.
18:01:57 [INFO] +- While loop 21 ---------+
18:01:57 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>"
18:01:57 [INFO] +- Executing dCommand: SPAWNEDMODEL ---------+
18:01:57 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:57 [INFO] Filled tag <def[target].location> with
'l@1069.8484155040783,23.697602721189526,703.2409914585065,2.220636,141.49217,storyworld'.
18:01:57 [INFO] Filled tag
<def[phenex].location.face[l@1069.8484155040783,23.697602721189526,703.2409914585065,2.220636,141.49217,storyworld].direction.vector.div[5]>
with 'l@0.13827866617256995,0.023277718615931545,0.14260840893009247,storyworld'.
18:01:57 [INFO] Filled tag <def[target].eye_location> with
'l@1069.8484155040783,25.317602725957897,703.2409914585065,2.220636,141.49217,storyworld'.
18:01:57 [INFO] Filled tag
<def[phenex].location.add[l@0.13827866617256995,0.023277718615931545,0.14260840893009247,storyworld].face[l@1069.8484155040783,25.317602725957897,703.2409914585065,2.220636,141.49217,storyworld]>
with 'l@1067.658753190622,23.328996410198755,700.9827653343136,-32.3013,315.88312,storyworld'.
18:01:57 [INFO] +> Executing 'SPAWNEDMODEL': action='teleport'
location='l@1067.658753190622,23.328996410198755,700.9827653343136,-32.3013,315.88312,storyworld'
uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:57 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Woah!! An exception has been called with this command (while executing it)!
18:01:57 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Internal exception was thrown!
18:01:57 [SEVERE] java.lang.NullPointerException
18:01:57 [SEVERE] net.wizardsmine.extendizen.models.SpawnedModel.teleport(SpawnedModel.java:142)
18:01:57 [SEVERE] net.wizardsmine.extendizen.commands.SpawnedModelCommand.execute(SpawnedModelCommand.java:205)
18:01:57 [SEVERE] net.aufdemrand.denizencore.scripts.commands.CommandExecuter.execute(CommandExecuter.java:168)
18:01:57 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptEngine.revolve(ScriptEngine.java:70)
18:01:57 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptQueue.revolve(ScriptQueue.java:670)
18:01:57 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue.access$000(TimedQueue.java:12)
18:01:57 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue$1.run(TimedQueue.java:164)
18:01:57 [SEVERE] net.aufdemrand.denizencore.utilities.scheduling.RepeatingSchedulable.tick(RepeatingSchedulable.java:20)
18:01:57 [SEVERE] net.aufdemrand.denizencore.DenizenCore.tick(DenizenCore.java:155)
18:01:57 [SEVERE] net.aufdemrand.denizen.Denizen$6.run(Denizen.java:924)
18:01:57 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftTask.run(CraftTask.java:63)
18:01:57 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftScheduler.mainThreadHeartbeat(CraftScheduler.java:423)
18:01:57 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.D(MinecraftServer.java:840)
18:01:57 [SEVERE] net.minecraft.server.v1_12_R1.DedicatedServer.D(DedicatedServer.java:423)
18:01:57 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.C(MinecraftServer.java:774)
18:01:57 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.run(MinecraftServer.java:666)
18:01:57 [SEVERE] java.lang.Thread.run(Thread.java:748)
18:01:57 [INFO] +> [Denizen] (Attempted: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>")
18:01:57 [INFO] +---------------------+
18:01:57 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "!contains"
"walk"
18:01:57 [INFO] +- Executing dCommand: IF ---------+
18:01:57 [INFO] +> Executing 'IF': use_braces='true'
18:01:57 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:57 [INFO] Logic='NEGATIVE', Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='false'
18:01:57 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[loop_index]>" ">=" "<def[timeout]>"
18:01:57 [INFO] +- Executing dCommand: IF ---------+
18:01:57 [INFO] +> Executing 'IF': use_braces='true'
18:01:57 [INFO] Filled tag <def[loop_index]> with '21'.
18:01:57 [INFO] Filled tag <def[timeout]> with '100'.
18:01:57 [INFO] Comparable='Decimal(21.0)', Operator='OR_MORE', ComparedTo='Decimal(100.0)' --> OUTCOME='false'
18:01:57 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WAIT "0.5t"
18:01:57 [INFO] +- Executing dCommand: WAIT ---------+
18:01:57 [INFO] +> Executing 'WAIT': queue='PHENEX_TRY_APPROACH_EscortFilteringOccasional' delay='d@0.025s'
18:01:57 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "contains" "walk"
18:01:57 [INFO] +- Executing dCommand: IF ---------+
18:01:57 [INFO] +> Executing 'IF': use_braces='true'
18:01:57 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:57 [INFO] Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='true'
18:01:57 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: ANIMATEMODEL "pause" "uuid:<def[phenex].uuid>"
"animation:walk"
18:01:57 [INFO] +- Executing dCommand: ANIMATEMODEL ---------+
18:01:57 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:57 [INFO] +> Executing 'ANIMATEMODEL': action='pause' animation='walk' uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:57 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WHILE " CALLBACK"
18:01:57 [INFO] Filled tag <def[target].location> with
'l@1069.8484155040783,23.697602721189526,703.2409914585065,2.220636,141.49217,storyworld'.
18:01:57 [INFO] Filled tag <def[distance]> with '3'.
18:01:57 [INFO] Filled tag
<def[phenex].location.distance[l@1069.8484155040783,23.697602721189526,703.2409914585065,2.220636,141.49217,storyworld].is[more].than[3]>
with 'true'.
18:01:57 [INFO] +- While loop 22 ---------+
18:01:57 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>"
18:01:57 [INFO] +- Executing dCommand: SPAWNEDMODEL ---------+
18:01:57 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:57 [INFO] Filled tag <def[target].location> with
'l@1069.8484155040783,23.697602721189526,703.2409914585065,2.220636,141.49217,storyworld'.
18:01:57 [INFO] Filled tag
<def[phenex].location.face[l@1069.8484155040783,23.697602721189526,703.2409914585065,2.220636,141.49217,storyworld].direction.vector.div[5]>
with 'l@0.13827866617256995,0.023277718615931545,0.14260840893009247,storyworld'.
18:01:57 [INFO] Filled tag <def[target].eye_location> with
'l@1069.8484155040783,25.317602725957897,703.2409914585065,2.220636,141.49217,storyworld'.
18:01:57 [INFO] Filled tag
<def[phenex].location.add[l@0.13827866617256995,0.023277718615931545,0.14260840893009247,storyworld].face[l@1069.8484155040783,25.317602725957897,703.2409914585065,2.220636,141.49217,storyworld]>
with 'l@1067.7970318567945,23.35227412881469,701.1253737432437,-33.700188,315.88315,storyworld'.
18:01:57 [INFO] +> Executing 'SPAWNEDMODEL': action='teleport'
location='l@1067.7970318567945,23.35227412881469,701.1253737432437,-33.700188,315.88315,storyworld'
uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:57 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Woah!! An exception has been called with this command (while executing it)!
18:01:57 [INFO] ERROR in script 'PHENEX_TRY_APPROACH'! Internal exception was thrown!
18:01:57 [SEVERE] java.lang.NullPointerException
18:01:57 [SEVERE] net.wizardsmine.extendizen.models.SpawnedModel.teleport(SpawnedModel.java:142)
18:01:57 [SEVERE] net.wizardsmine.extendizen.commands.SpawnedModelCommand.execute(SpawnedModelCommand.java:205)
18:01:57 [SEVERE] net.aufdemrand.denizencore.scripts.commands.CommandExecuter.execute(CommandExecuter.java:168)
18:01:57 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptEngine.revolve(ScriptEngine.java:70)
18:01:57 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptQueue.revolve(ScriptQueue.java:670)
18:01:57 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue.access$000(TimedQueue.java:12)
18:01:57 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.TimedQueue$1.run(TimedQueue.java:164)
18:01:57 [SEVERE] net.aufdemrand.denizencore.utilities.scheduling.RepeatingSchedulable.tick(RepeatingSchedulable.java:20)
18:01:57 [SEVERE] net.aufdemrand.denizencore.DenizenCore.tick(DenizenCore.java:155)
18:01:57 [SEVERE] net.aufdemrand.denizen.Denizen$6.run(Denizen.java:924)
18:01:57 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftTask.run(CraftTask.java:63)
18:01:57 [SEVERE] org.bukkit.craftbukkit.v1_12_R1.scheduler.CraftScheduler.mainThreadHeartbeat(CraftScheduler.java:423)
18:01:57 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.D(MinecraftServer.java:840)
18:01:57 [SEVERE] net.minecraft.server.v1_12_R1.DedicatedServer.D(DedicatedServer.java:423)
18:01:57 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.C(MinecraftServer.java:774)
18:01:57 [SEVERE] net.minecraft.server.v1_12_R1.MinecraftServer.run(MinecraftServer.java:666)
18:01:57 [SEVERE] java.lang.Thread.run(Thread.java:748)
18:01:57 [INFO] +> [Denizen] (Attempted: SPAWNEDMODEL "teleport" "uuid:<def[phenex].uuid>"
"<def[phenex].location.add[<def[phenex].location.face[<def[target].location>].direction.vector.div[5]>].face[<def[target].eye_location>]>")
18:01:57 [INFO] +---------------------+
18:01:57 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "!contains"
"walk"
18:01:57 [INFO] +- Executing dCommand: IF ---------+
18:01:57 [INFO] +> Executing 'IF': use_braces='true'
18:01:57 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:57 [INFO] Logic='NEGATIVE', Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='false'
18:01:57 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[loop_index]>" ">=" "<def[timeout]>"
18:01:57 [INFO] +- Executing dCommand: IF ---------+
18:01:57 [INFO] +> Executing 'IF': use_braces='true'
18:01:57 [INFO] Filled tag <def[loop_index]> with '22'.
18:01:57 [INFO] Filled tag <def[timeout]> with '100'.
18:01:57 [INFO] Comparable='Decimal(22.0)', Operator='OR_MORE', ComparedTo='Decimal(100.0)' --> OUTCOME='false'
18:01:57 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WAIT "0.5t"
18:01:57 [INFO] +- Executing dCommand: WAIT ---------+
18:01:57 [INFO] +> Executing 'WAIT': queue='PHENEX_TRY_APPROACH_EscortFilteringOccasional' delay='d@0.025s'
18:01:57 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: IF "<def[phenex].list_current_animations>" "contains" "walk"
18:01:57 [INFO] +- Executing dCommand: IF ---------+
18:01:57 [INFO] +> Executing 'IF': use_braces='true'
18:01:57 [INFO] Filled tag <def[phenex].list_current_animations> with 'li@walk'.
18:01:57 [INFO] Comparable='dList(li@walk)', Operator='CONTAINS', ComparedTo='Element(walk)' --> OUTCOME='true'
18:01:57 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: ANIMATEMODEL "pause" "uuid:<def[phenex].uuid>"
"animation:walk"
18:01:57 [INFO] +- Executing dCommand: ANIMATEMODEL ---------+
18:01:57 [INFO] Filled tag <def[phenex].uuid> with '8eb4c6ab-b791-4caa-86b6-fa47052d0aca'.
18:01:57 [INFO] +> Executing 'ANIMATEMODEL': action='pause' animation='walk' uuid='8eb4c6ab-b791-4caa-86b6-fa47052d0aca'
18:01:57 [INFO] Queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' Executing: WHILE " CALLBACK"
18:01:57 [INFO] Filled tag <def[target].location> with
'l@1069.8484155040783,23.697602721189526,703.2409914585065,2.220636,141.49217,storyworld'.
18:01:57 [INFO] Filled tag <def[distance]> with '3'.
18:01:57 [INFO] Filled tag
<def[phenex].location.distance[l@1069.8484155040783,23.697602721189526,703.2409914585065,2.220636,141.49217,storyworld].is[more].than[3]>
with 'false'.
18:01:57 [INFO] +- While loop complete ---------+
18:01:57 [INFO] Completing queue 'PHENEX_TRY_APPROACH_EscortFilteringOccasional' in 2311ms.